builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1507063225.15 results: success (0) revision: 5044cb7aaf48ba278343ac8268120f2cd259ddbf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:25.154058) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:25.154481) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:25.154746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:25.196523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:25.196773) ========= 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=3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-03 13:40:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.1M=0s 2017-10-03 13:40:25 (30.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110925 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:25.332602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:25.332871) ========= 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=3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021999 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:25.438783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:25.439072) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5044cb7aaf48ba278343ac8268120f2cd259ddbf --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 5044cb7aaf48ba278343ac8268120f2cd259ddbf --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=3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-03 13:40:25,493 truncating revision to first 12 chars 2017-10-03 13:40:25,493 Setting DEBUG logging. 2017-10-03 13:40:25,493 attempt 1/10 2017-10-03 13:40:25,493 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5044cb7aaf48?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-03 13:40:25,847 unpacking tar archive at: mozilla-beta-5044cb7aaf48/testing/mozharness/ program finished with exit code 0 elapsedTime=0.759395 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:26.215092) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:26.218413) ========= script_repo_revision: 5044cb7aaf48ba278343ac8268120f2cd259ddbf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:26.218801) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:26.219066) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 13:40:26.240415) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-10-03 13:40:26.240756) ========= /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=3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:40:26 INFO - MultiFileLogger online at 20171003 13:40:26 in /builds/slave/test 13:40:26 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 13:40:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:40:26 INFO - {'append_to_log': False, 13:40:26 INFO - 'base_work_dir': '/builds/slave/test', 13:40:26 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 13:40:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:40:26 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 13:40:26 INFO - 'buildbot_json_path': 'buildprops.json', 13:40:26 INFO - 'code_coverage': False, 13:40:26 INFO - 'config_files': ('talos/linux_config.py',), 13:40:26 INFO - 'default_actions': ('clobber', 13:40:26 INFO - 'read-buildbot-config', 13:40:26 INFO - 'download-and-extract', 13:40:26 INFO - 'populate-webroot', 13:40:26 INFO - 'create-virtualenv', 13:40:26 INFO - 'install', 13:40:26 INFO - 'setup-mitmproxy', 13:40:26 INFO - 'run-tests'), 13:40:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:40:26 INFO - 'disable_ccov_upload': False, 13:40:26 INFO - 'disable_stylo': False, 13:40:26 INFO - 'download_minidump_stackwalk': True, 13:40:26 INFO - 'download_symbols': 'ondemand', 13:40:26 INFO - 'enable_stylo': False, 13:40:26 INFO - 'enable_webrender': False, 13:40:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:40:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:40:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:40:26 INFO - 'gecko_profile': False, 13:40:26 INFO - 'gecko_profile_interval': 0, 13:40:26 INFO - 'installer_path': 'installer.exe', 13:40:26 INFO - 'log_level': 'info', 13:40:26 INFO - 'log_name': 'talos', 13:40:26 INFO - 'log_to_console': True, 13:40:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:40:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:40:26 INFO - 'opt_config_files': (), 13:40:26 INFO - 'pip_index': False, 13:40:26 INFO - 'suite': 'dromaeojs-e10s', 13:40:26 INFO - 'system_bits': '32', 13:40:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:40:26 INFO - 'title': 'talos-linux64-ix-059', 13:40:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:40:26 INFO - 'use_talos_json': True, 13:40:26 INFO - 'verify': 'False', 13:40:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:40:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:40:26 INFO - 'work_dir': 'build'} 13:40:26 INFO - [mozharness: 2017-10-03 20:40:26.438638Z] Running clobber step. 13:40:26 INFO - Running pre-action listener: _resource_record_pre_action 13:40:26 INFO - Running main action method: clobber 13:40:26 INFO - rmtree: /builds/slave/test/build 13:40:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:40:27 INFO - Running post-action listener: _resource_record_post_action 13:40:27 INFO - [mozharness: 2017-10-03 20:40:27.453859Z] Finished clobber step (success) 13:40:27 INFO - [mozharness: 2017-10-03 20:40:27.453956Z] Running read-buildbot-config step. 13:40:27 INFO - Running pre-action listener: _resource_record_pre_action 13:40:27 INFO - Running main action method: read_buildbot_config 13:40:27 INFO - Using buildbot properties: 13:40:27 INFO - { 13:40:27 INFO - "project": "", 13:40:27 INFO - "product": "firefox", 13:40:27 INFO - "who": "ffxbld@noreply.mozilla.org", 13:40:27 INFO - "installer_path": "public/build/target.tar.bz2", 13:40:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 13:40:27 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 13:40:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 13:40:27 INFO - "stage_platform": "linux64", 13:40:27 INFO - "basedir": "/builds/slave/test", 13:40:27 INFO - "buildnumber": 151, 13:40:27 INFO - "platform": "ubuntu64_hw", 13:40:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:40:27 INFO - "slavebuilddir": "test", 13:40:27 INFO - "taskId": "CWLpHlnsQ8mOk__ubIGLOA", 13:40:27 INFO - "branch": "mozilla-beta", 13:40:27 INFO - "script_repo_revision": "production", 13:40:27 INFO - "revision": "5044cb7aaf48ba278343ac8268120f2cd259ddbf", 13:40:27 INFO - "slavename": "talos-linux64-ix-059", 13:40:27 INFO - "repo_path": "releases/mozilla-beta" 13:40:27 INFO - } 13:40:27 INFO - Finding installer, test and symbols from parent task. 13:40:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CWLpHlnsQ8mOk__ubIGLOA'}, attempt #1 13:40:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CWLpHlnsQ8mOk__ubIGLOA'}, attempt #1 13:40:28 INFO - Task dependencies: VudcYqprSh-Son9W92vECw 13:40:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw'}, attempt #1 13:40:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.tar.bz2 13:40:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.test_packages.json 13:40:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.crashreporter-symbols.zip 13:40:29 INFO - Running post-action listener: _resource_record_post_action 13:40:29 INFO - [mozharness: 2017-10-03 20:40:29.189196Z] Finished read-buildbot-config step (success) 13:40:29 INFO - [mozharness: 2017-10-03 20:40:29.189419Z] Running download-and-extract step. 13:40:29 INFO - Running pre-action listener: _resource_record_pre_action 13:40:29 INFO - Running main action method: download_and_extract 13:40:29 INFO - mkdir: /builds/slave/test/build/tests 13:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:40:29 INFO - trying https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.test_packages.json 13:40:29 INFO - Downloading https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:40:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:40:31 INFO - Downloaded 989 bytes. 13:40:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:40:31 INFO - Using the following test package requirements: 13:40:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:40:31 INFO - u'common': [u'target.common.tests.zip'], 13:40:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:40:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:40:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:40:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:40:31 INFO - u'mozbase': [u'target.common.tests.zip'], 13:40:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:40:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:40:31 INFO - u'web-platform': [u'target.common.tests.zip', 13:40:31 INFO - u'target.web-platform.tests.tar.gz'], 13:40:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:40:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 13:40:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.common.tests.zip 13:40:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:40:31 INFO - Fetch https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.common.tests.zip into memory 13:40:53 INFO - Content-Length response header: 55178631 13:40:53 INFO - Bytes received: 55178631 13:41:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.talos.tests.zip 13:41:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:41:04 INFO - Fetch https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.talos.tests.zip into memory 13:41:05 INFO - Content-Length response header: 14509184 13:41:05 INFO - Bytes received: 14509184 13:41: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')]} 13:41:05 INFO - trying https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.tar.bz2 13:41:05 INFO - Downloading https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:41:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:41:08 INFO - Downloaded 53435356 bytes. 13:41:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.tar.bz2 13:41:08 INFO - mkdir: /builds/slave/test/properties 13:41:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:41:08 INFO - Writing to file /builds/slave/test/properties/build_url 13:41:08 INFO - Contents: 13:41:08 INFO - build_url:https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.tar.bz2 13:41:08 INFO - Running post-action listener: _resource_record_post_action 13:41:08 INFO - Running post-action listener: find_tests_for_verification 13:41:08 INFO - Running post-action listener: set_extra_try_arguments 13:41:08 INFO - [mozharness: 2017-10-03 20:41:08.413535Z] Finished download-and-extract step (success) 13:41:08 INFO - [mozharness: 2017-10-03 20:41:08.413659Z] Running populate-webroot step. 13:41:08 INFO - Running pre-action listener: _resource_record_pre_action 13:41:08 INFO - Running main action method: populate_webroot 13:41:08 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:41:08 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:41:08 INFO - 'tests': ['tresize', 13:41:08 INFO - 'tcanvasmark']}, 13:41:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:41:08 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:41:08 INFO - 'tests': ['dromaeo_css', 13:41:08 INFO - 'kraken']}, 13:41:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:41:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:41:08 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:41:08 INFO - 'talos_options': ['--disable-stylo'], 13:41:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:41:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:41:08 INFO - 'tests': ['damp', 'tps']}, 13:41:08 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:41:08 INFO - 'talos_options': ['--disable-stylo'], 13:41:08 INFO - 'tests': ['damp', 'tps']}, 13:41:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:41:08 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:41:08 INFO - 'tests': ['dromaeo_dom']}, 13:41:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:41:08 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:41:08 INFO - 'tests': ['basic_compositor_video', 13:41:08 INFO - 'glvideo']}, 13:41:08 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:41:08 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:41:08 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:41:08 INFO - 'talos_options': ['--disable-stylo'], 13:41:08 INFO - 'tests': ['ts_paint_webext', 13:41:08 INFO - 'tp5o_webext']}, 13:41:08 INFO - 'other-e10s': {'tests': ['a11yr', 13:41:08 INFO - 'ts_paint', 13:41:08 INFO - 'tpaint', 13:41:08 INFO - 'sessionrestore', 13:41:08 INFO - 'sessionrestore_many_windows', 13:41:08 INFO - 'sessionrestore_no_auto_restore', 13:41:08 INFO - 'tabpaint']}, 13:41:08 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:41:08 INFO - 'tests': ['a11yr', 13:41:08 INFO - 'ts_paint', 13:41:08 INFO - 'tpaint', 13:41:08 INFO - 'sessionrestore', 13:41:08 INFO - 'sessionrestore_many_windows', 13:41:08 INFO - 'sessionrestore_no_auto_restore', 13:41:08 INFO - 'tabpaint']}, 13:41:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:41:08 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 13:41:08 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:41:08 INFO - 'tests': ['perf_reftest_singletons']}, 13:41:08 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:41:08 INFO - 'tests': ['bloom_basic']}, 13:41:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:41:08 INFO - 'tsvgr_opacity', 13:41:08 INFO - 'tart', 13:41:08 INFO - 'tscrollx', 13:41:08 INFO - 'tsvg_static']}, 13:41:08 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:41:08 INFO - 'tests': ['tsvgx', 13:41:08 INFO - 'tsvgr_opacity', 13:41:08 INFO - 'tart', 13:41:08 INFO - 'tscrollx', 13:41:08 INFO - 'tsvg_static']}, 13:41:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:41:08 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:41:08 INFO - 'talos_options': ['--disable-stylo'], 13:41:08 INFO - 'tests': ['tp5o']}, 13:41:08 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:41:08 INFO - 'talos_options': ['--mitmproxy', 13:41:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:41:08 INFO - '--firstNonBlankPaint'], 13:41:08 INFO - 'tests': ['tp6_google', 13:41:08 INFO - 'tp6_youtube', 13:41:08 INFO - 'tp6_amazon', 13:41:08 INFO - 'tp6_facebook']}, 13:41:08 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:41:08 INFO - 'talos_options': ['--disable-stylo', 13:41:08 INFO - '--mitmproxy', 13:41:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:41:08 INFO - '--firstNonBlankPaint'], 13:41:08 INFO - 'tests': ['tp6_google', 13:41:08 INFO - 'tp6_youtube', 13:41:08 INFO - 'tp6_amazon', 13:41:08 INFO - 'tp6_facebook']}, 13:41:08 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:41:08 INFO - 'talos_options': ['--stylo-threads=1', 13:41:08 INFO - '--mitmproxy', 13:41:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:41:08 INFO - '--firstNonBlankPaint'], 13:41:08 INFO - 'tests': ['tp6_google', 13:41:08 INFO - 'tp6_youtube', 13:41:08 INFO - 'tp6_amazon', 13:41:08 INFO - 'tp6_facebook']}, 13:41:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:41:08 INFO - 'talos_options': ['--xperf_path', 13:41:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:41:08 INFO - 'tests': ['tp5n']}, 13:41:08 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:41:08 INFO - 'talos_options': ['--disable-stylo', 13:41:08 INFO - '--xperf_path', 13:41:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:41:08 INFO - 'tests': ['tp5n']}}} 13:41:08 INFO - Running post-action listener: _resource_record_post_action 13:41:08 INFO - [mozharness: 2017-10-03 20:41:08.429451Z] Finished populate-webroot step (success) 13:41:08 INFO - [mozharness: 2017-10-03 20:41:08.429540Z] Running create-virtualenv step. 13:41:08 INFO - Running pre-action listener: _resource_record_pre_action 13:41:08 INFO - Running main action method: create_virtualenv 13:41:08 INFO - Creating virtualenv /builds/slave/test/build/venv 13:41:08 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:41:08 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:41:08 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:41:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:41:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:41:09 INFO - Installing distribute.............................................................................................................................................................................................done. 13:41:09 INFO - Installing pip...............done. 13:41:09 INFO - Return code: 0 13:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:41:09 INFO - Reading from file tmpfile_stdout 13:41:09 INFO - Output received: 13:41:09 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 13:41:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:41:09 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')]} 13:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:09 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')]} 13:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:09 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb090>, '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 0x22fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f5f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', '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 13:41:09 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 13:41:09 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 13:41:09 INFO - Using env: {'DISPLAY': ':0', 13:41:09 INFO - 'HOME': '/home/cltbld', 13:41:09 INFO - 'LANG': 'en_US.UTF-8', 13:41:09 INFO - 'LANGUAGE': 'en_US:en', 13:41:09 INFO - 'LOGNAME': 'cltbld', 13:41:09 INFO - 'MAIL': '/var/mail/cltbld', 13:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:09 INFO - 'MOZ_NO_REMOTE': '1', 13:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:09 INFO - 'NO_EM_RESTART': '1', 13:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:09 INFO - 'PWD': '/builds/slave/test', 13:41:09 INFO - 'SHELL': '/bin/bash', 13:41:09 INFO - 'SHLVL': '1', 13:41:09 INFO - 'TERM': 'linux', 13:41:09 INFO - 'TMOUT': '86400', 13:41:09 INFO - 'USER': 'cltbld', 13:41:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', 13:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:09 INFO - '_': '/tools/buildbot/bin/python'} 13:41:10 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:41:10 INFO - Downloading/unpacking pip>=1.5 13:41:10 INFO - Running setup.py egg_info for package pip 13:41:10 INFO - warning: no files found matching 'pip/cacert.pem' 13:41:10 INFO - warning: no files found matching '*.html' under directory 'docs' 13:41:10 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:41:10 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:41:10 INFO - Installing collected packages: pip 13:41:10 INFO - Found existing installation: pip 1.1 13:41:10 INFO - Uninstalling pip: 13:41:10 INFO - Successfully uninstalled pip 13:41:10 INFO - Running setup.py install for pip 13:41:10 INFO - warning: no files found matching 'pip/cacert.pem' 13:41:10 INFO - warning: no files found matching '*.html' under directory 'docs' 13:41:10 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:41:10 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:41:10 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:41:10 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:41:10 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:41:10 INFO - Successfully installed pip 13:41:10 INFO - Cleaning up... 13:41:10 INFO - Return code: 0 13:41:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb090>, '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 0x22fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f5f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', '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 13:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:41:10 INFO - Using env: {'DISPLAY': ':0', 13:41:10 INFO - 'HOME': '/home/cltbld', 13:41:10 INFO - 'LANG': 'en_US.UTF-8', 13:41:10 INFO - 'LANGUAGE': 'en_US:en', 13:41:10 INFO - 'LOGNAME': 'cltbld', 13:41:10 INFO - 'MAIL': '/var/mail/cltbld', 13:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:10 INFO - 'MOZ_NO_REMOTE': '1', 13:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:10 INFO - 'NO_EM_RESTART': '1', 13:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:10 INFO - 'PWD': '/builds/slave/test', 13:41:10 INFO - 'SHELL': '/bin/bash', 13:41:10 INFO - 'SHLVL': '1', 13:41:10 INFO - 'TERM': 'linux', 13:41:10 INFO - 'TMOUT': '86400', 13:41:10 INFO - 'USER': 'cltbld', 13:41:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', 13:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:10 INFO - '_': '/tools/buildbot/bin/python'} 13:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:10 INFO - Downloading/unpacking psutil>=3.1.1 13:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:41:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:41:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:41:12 INFO - Installing collected packages: psutil 13:41:12 INFO - Running setup.py install for psutil 13:41:12 INFO - building 'psutil._psutil_linux' extension 13:41:12 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 13:41:12 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 13:41:12 INFO - building 'psutil._psutil_posix' extension 13:41:12 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 13:41:12 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 13:41:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:41:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:41:12 INFO - Successfully installed psutil 13:41:12 INFO - Cleaning up... 13:41:12 INFO - Return code: 0 13:41:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb090>, '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 0x22fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f5f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', '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 13:41:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:41:12 INFO - Using env: {'DISPLAY': ':0', 13:41:12 INFO - 'HOME': '/home/cltbld', 13:41:12 INFO - 'LANG': 'en_US.UTF-8', 13:41:12 INFO - 'LANGUAGE': 'en_US:en', 13:41:12 INFO - 'LOGNAME': 'cltbld', 13:41:12 INFO - 'MAIL': '/var/mail/cltbld', 13:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:12 INFO - 'MOZ_NO_REMOTE': '1', 13:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:12 INFO - 'NO_EM_RESTART': '1', 13:41:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:12 INFO - 'PWD': '/builds/slave/test', 13:41:12 INFO - 'SHELL': '/bin/bash', 13:41:12 INFO - 'SHLVL': '1', 13:41:12 INFO - 'TERM': 'linux', 13:41:12 INFO - 'TMOUT': '86400', 13:41:12 INFO - 'USER': 'cltbld', 13:41:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', 13:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:12 INFO - '_': '/tools/buildbot/bin/python'} 13:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:41:13 INFO - Installing collected packages: mozsystemmonitor 13:41:13 INFO - Running setup.py install for mozsystemmonitor 13:41:14 INFO - Successfully installed mozsystemmonitor 13:41:14 INFO - Cleaning up... 13:41:14 INFO - Return code: 0 13:41:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:41:14 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')]} 13:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:14 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')]} 13:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:14 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb090>, '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 0x22fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f5f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', '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 13:41:14 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 13:41:14 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 13:41:14 INFO - Using env: {'DISPLAY': ':0', 13:41:14 INFO - 'HOME': '/home/cltbld', 13:41:14 INFO - 'LANG': 'en_US.UTF-8', 13:41:14 INFO - 'LANGUAGE': 'en_US:en', 13:41:14 INFO - 'LOGNAME': 'cltbld', 13:41:14 INFO - 'MAIL': '/var/mail/cltbld', 13:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:14 INFO - 'MOZ_NO_REMOTE': '1', 13:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:14 INFO - 'NO_EM_RESTART': '1', 13:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:14 INFO - 'PWD': '/builds/slave/test', 13:41:14 INFO - 'SHELL': '/bin/bash', 13:41:14 INFO - 'SHLVL': '1', 13:41:14 INFO - 'TERM': 'linux', 13:41:14 INFO - 'TMOUT': '86400', 13:41:14 INFO - 'USER': 'cltbld', 13:41:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', 13:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:14 INFO - '_': '/tools/buildbot/bin/python'} 13:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:14 INFO - Downloading/unpacking jsonschema==2.5.1 13:41:14 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 13:41:14 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 13:41:14 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 13:41:14 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 13:41:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:41:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:15 INFO - Downloading functools32-3.2.3-2.tar.gz 13:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:41:15 INFO - warning: no files found matching '*.txt' 13:41:15 INFO - no previously-included directories found matching 'build' 13:41:15 INFO - no previously-included directories found matching 'dist' 13:41:15 INFO - no previously-included directories found matching '.git*' 13:41:15 INFO - Installing collected packages: jsonschema, functools32 13:41:15 INFO - Running setup.py install for functools32 13:41:15 INFO - warning: no files found matching '*.txt' 13:41:15 INFO - no previously-included directories found matching 'build' 13:41:15 INFO - no previously-included directories found matching 'dist' 13:41:15 INFO - no previously-included directories found matching '.git*' 13:41:15 INFO - Successfully installed jsonschema functools32 13:41:15 INFO - Cleaning up... 13:41:15 INFO - Return code: 0 13:41:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:41:15 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')]} 13:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:15 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')]} 13:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:15 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb090>, '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 0x22fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f5f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', '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 13:41:15 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 13:41:15 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 13:41:15 INFO - Using env: {'DISPLAY': ':0', 13:41:15 INFO - 'HOME': '/home/cltbld', 13:41:15 INFO - 'LANG': 'en_US.UTF-8', 13:41:15 INFO - 'LANGUAGE': 'en_US:en', 13:41:15 INFO - 'LOGNAME': 'cltbld', 13:41:15 INFO - 'MAIL': '/var/mail/cltbld', 13:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:15 INFO - 'MOZ_NO_REMOTE': '1', 13:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:15 INFO - 'NO_EM_RESTART': '1', 13:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:15 INFO - 'PWD': '/builds/slave/test', 13:41:15 INFO - 'SHELL': '/bin/bash', 13:41:15 INFO - 'SHLVL': '1', 13:41:15 INFO - 'TERM': 'linux', 13:41:15 INFO - 'TMOUT': '86400', 13:41:15 INFO - 'USER': 'cltbld', 13:41:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', 13:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:15 INFO - '_': '/tools/buildbot/bin/python'} 13:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:41:15 INFO - Cleaning up... 13:41:16 INFO - Return code: 0 13:41:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:41:16 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')]} 13:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:16 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')]} 13:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:16 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb090>, '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 0x22fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f5f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', '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 13:41:16 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 13:41:16 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 13:41:16 INFO - Using env: {'DISPLAY': ':0', 13:41:16 INFO - 'HOME': '/home/cltbld', 13:41:16 INFO - 'LANG': 'en_US.UTF-8', 13:41:16 INFO - 'LANGUAGE': 'en_US:en', 13:41:16 INFO - 'LOGNAME': 'cltbld', 13:41:16 INFO - 'MAIL': '/var/mail/cltbld', 13:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:16 INFO - 'MOZ_NO_REMOTE': '1', 13:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:16 INFO - 'NO_EM_RESTART': '1', 13:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:16 INFO - 'PWD': '/builds/slave/test', 13:41:16 INFO - 'SHELL': '/bin/bash', 13:41:16 INFO - 'SHLVL': '1', 13:41:16 INFO - 'TERM': 'linux', 13:41:16 INFO - 'TMOUT': '86400', 13:41:16 INFO - 'USER': 'cltbld', 13:41:16 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', 13:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:16 INFO - '_': '/tools/buildbot/bin/python'} 13:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:16 INFO - Downloading/unpacking blobuploader==1.2.4 13:41:16 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 13:41:16 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 13:41:16 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 13:41:16 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 13:41:17 INFO - Downloading blobuploader-1.2.4.tar.gz 13:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:41:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:41:17 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 13:41:17 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 13:41:17 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 13:41:17 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 13:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:41:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:41:17 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 13:41:17 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 13:41:17 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 13:41:17 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 13:41:17 INFO - Downloading docopt-0.6.1.tar.gz 13:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:41:17 INFO - Installing collected packages: blobuploader, requests, docopt 13:41:17 INFO - Running setup.py install for blobuploader 13:41:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:41:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:41:18 INFO - Running setup.py install for requests 13:41:18 INFO - Running setup.py install for docopt 13:41:18 INFO - Successfully installed blobuploader requests docopt 13:41:18 INFO - Cleaning up... 13:41:18 INFO - Return code: 0 13:41:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:41:18 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')]} 13:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:18 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')]} 13:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:18 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb090>, '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 0x22fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f5f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', '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 13:41:18 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 13:41:18 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 13:41:18 INFO - Using env: {'DISPLAY': ':0', 13:41:18 INFO - 'HOME': '/home/cltbld', 13:41:18 INFO - 'LANG': 'en_US.UTF-8', 13:41:18 INFO - 'LANGUAGE': 'en_US:en', 13:41:18 INFO - 'LOGNAME': 'cltbld', 13:41:18 INFO - 'MAIL': '/var/mail/cltbld', 13:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:18 INFO - 'MOZ_NO_REMOTE': '1', 13:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:18 INFO - 'NO_EM_RESTART': '1', 13:41:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:18 INFO - 'PWD': '/builds/slave/test', 13:41:18 INFO - 'SHELL': '/bin/bash', 13:41:18 INFO - 'SHLVL': '1', 13:41:18 INFO - 'TERM': 'linux', 13:41:18 INFO - 'TMOUT': '86400', 13:41:18 INFO - 'USER': 'cltbld', 13:41:18 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', 13:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:18 INFO - '_': '/tools/buildbot/bin/python'} 13:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:41:18 INFO - Running setup.py (path:/tmp/pip-Rh7aJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:41:18 INFO - Running setup.py (path:/tmp/pip-iDrDTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:41:18 INFO - Running setup.py (path:/tmp/pip-TNQyZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:41:18 INFO - Running setup.py (path:/tmp/pip-OExik9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:41:19 INFO - Running setup.py (path:/tmp/pip-CUYoDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:41:19 INFO - Running setup.py (path:/tmp/pip-RDuj0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:41:19 INFO - Running setup.py (path:/tmp/pip-Jk4JuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:41:19 INFO - Running setup.py (path:/tmp/pip-IVrgFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:41:19 INFO - Running setup.py (path:/tmp/pip-f4SgEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:41:19 INFO - Running setup.py (path:/tmp/pip-KWt0no-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:41:19 INFO - Running setup.py (path:/tmp/pip-7DKzVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:41:19 INFO - Running setup.py (path:/tmp/pip-2pRMhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:41:19 INFO - Running setup.py (path:/tmp/pip-EmsNFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:41:19 INFO - Running setup.py (path:/tmp/pip-OmbRNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:41:19 INFO - Running setup.py (path:/tmp/pip-FZIOc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:41:19 INFO - Running setup.py (path:/tmp/pip-I4ZVZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:41:19 INFO - Running setup.py (path:/tmp/pip-vmUtnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:41:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:41:19 INFO - Running setup.py install for manifestparser 13:41:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:41:20 INFO - Running setup.py install for mozcrash 13:41:20 INFO - Running setup.py install for mozdebug 13:41:20 INFO - Running setup.py install for mozdevice 13:41:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:41:20 INFO - Running setup.py install for mozfile 13:41:20 INFO - Running setup.py install for mozhttpd 13:41:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:41:20 INFO - Running setup.py install for mozinfo 13:41:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:41:20 INFO - Running setup.py install for mozInstall 13:41:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:41:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:41:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:41:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:41:20 INFO - Running setup.py install for mozleak 13:41:20 INFO - Running setup.py install for mozlog 13:41:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:41:20 INFO - Running setup.py install for moznetwork 13:41:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:41:21 INFO - Running setup.py install for mozprocess 13:41:21 INFO - Running setup.py install for mozprofile 13:41:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:41:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:41:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:41:21 INFO - Running setup.py install for mozrunner 13:41:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:41:21 INFO - Running setup.py install for mozscreenshot 13:41:21 INFO - Running setup.py install for moztest 13:41:21 INFO - Running setup.py install for mozversion 13:41:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:41:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:41:21 INFO - Cleaning up... 13:41:21 INFO - Return code: 0 13:41:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:41:21 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')]} 13:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:21 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')]} 13:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:21 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb090>, '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 0x22fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f5f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', '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 13:41:21 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 13:41:21 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 13:41:21 INFO - Using env: {'DISPLAY': ':0', 13:41:21 INFO - 'HOME': '/home/cltbld', 13:41:21 INFO - 'LANG': 'en_US.UTF-8', 13:41:21 INFO - 'LANGUAGE': 'en_US:en', 13:41:21 INFO - 'LOGNAME': 'cltbld', 13:41:21 INFO - 'MAIL': '/var/mail/cltbld', 13:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:21 INFO - 'MOZ_NO_REMOTE': '1', 13:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:21 INFO - 'NO_EM_RESTART': '1', 13:41:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:21 INFO - 'PWD': '/builds/slave/test', 13:41:21 INFO - 'SHELL': '/bin/bash', 13:41:21 INFO - 'SHLVL': '1', 13:41:21 INFO - 'TERM': 'linux', 13:41:21 INFO - 'TMOUT': '86400', 13:41:21 INFO - 'USER': 'cltbld', 13:41:21 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', 13:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:21 INFO - '_': '/tools/buildbot/bin/python'} 13:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:41:21 INFO - Running setup.py (path:/tmp/pip-h8fbzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:41:21 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)) 13:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:41:21 INFO - Running setup.py (path:/tmp/pip-IJPafO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:41:22 INFO - Running setup.py (path:/tmp/pip-QIGO_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:41:22 INFO - Running setup.py (path:/tmp/pip-4msagy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:41:22 INFO - Running setup.py (path:/tmp/pip-rW1t4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:41:22 INFO - Running setup.py (path:/tmp/pip-ioqfCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:41:22 INFO - Running setup.py (path:/tmp/pip-6_eSds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:41:22 INFO - Running setup.py (path:/tmp/pip-sizzqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:41:22 INFO - Running setup.py (path:/tmp/pip-VC4VxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:41:22 INFO - Running setup.py (path:/tmp/pip-WWfbhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:41:22 INFO - Running setup.py (path:/tmp/pip-Viwr4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:41:22 INFO - Running setup.py (path:/tmp/pip-hM5znF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:41:22 INFO - Running setup.py (path:/tmp/pip-7aL_Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:41:22 INFO - Running setup.py (path:/tmp/pip-bajX7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:41:22 INFO - Running setup.py (path:/tmp/pip-srrV1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:41:22 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)) 13:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:41:22 INFO - Running setup.py (path:/tmp/pip-BjJtk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:41:23 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)) 13:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:41:23 INFO - Running setup.py (path:/tmp/pip-OFOKtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:41:23 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)) 13:41:23 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)) 13:41:23 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)) 13:41:23 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)) 13:41:23 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)) 13:41:23 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)) 13:41:23 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)) 13:41:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:24 INFO - Downloading blessings-1.6.tar.gz 13:41:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:41:24 INFO - Installing collected packages: blessings 13:41:24 INFO - Running setup.py install for blessings 13:41:24 INFO - Successfully installed blessings 13:41:24 INFO - Cleaning up... 13:41:24 INFO - Return code: 0 13:41:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:41:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:41:24 INFO - Reading from file tmpfile_stdout 13:41:24 INFO - Current package versions: 13:41:24 INFO - argparse == 1.2.1 13:41:24 INFO - blessings == 1.6 13:41:24 INFO - blobuploader == 1.2.4 13:41:24 INFO - docopt == 0.6.1 13:41:24 INFO - functools32 == 3.2.3-2 13:41:24 INFO - jsonschema == 2.5.1 13:41:24 INFO - manifestparser == 1.1 13:41:24 INFO - mozInstall == 1.13 13:41:24 INFO - mozcrash == 1.0 13:41:24 INFO - mozdebug == 0.1 13:41:24 INFO - mozdevice == 0.51 13:41:24 INFO - mozfile == 1.2 13:41:24 INFO - mozhttpd == 0.7 13:41:24 INFO - mozinfo == 0.10 13:41:24 INFO - mozleak == 0.1 13:41:24 INFO - mozlog == 3.5 13:41:24 INFO - moznetwork == 0.27 13:41:24 INFO - mozprocess == 0.25 13:41:24 INFO - mozprofile == 0.28 13:41:24 INFO - mozrunner == 6.13 13:41:24 INFO - mozscreenshot == 0.1 13:41:24 INFO - mozsystemmonitor == 0.3 13:41:24 INFO - moztest == 0.8 13:41:24 INFO - mozversion == 1.4 13:41:24 INFO - psutil == 3.1.1 13:41:24 INFO - requests == 1.2.3 13:41:24 INFO - wsgiref == 0.1.2 13:41:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:41:24 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')]} 13:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:24 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')]} 13:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:24 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb090>, '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 0x22fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f5f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', '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 13:41:24 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 13:41:24 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 13:41:24 INFO - Using env: {'DISPLAY': ':0', 13:41:24 INFO - 'HOME': '/home/cltbld', 13:41:24 INFO - 'LANG': 'en_US.UTF-8', 13:41:24 INFO - 'LANGUAGE': 'en_US:en', 13:41:24 INFO - 'LOGNAME': 'cltbld', 13:41:24 INFO - 'MAIL': '/var/mail/cltbld', 13:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:24 INFO - 'MOZ_NO_REMOTE': '1', 13:41:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:24 INFO - 'NO_EM_RESTART': '1', 13:41:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:24 INFO - 'PWD': '/builds/slave/test', 13:41:24 INFO - 'SHELL': '/bin/bash', 13:41:24 INFO - 'SHLVL': '1', 13:41:24 INFO - 'TERM': 'linux', 13:41:24 INFO - 'TMOUT': '86400', 13:41:24 INFO - 'USER': 'cltbld', 13:41:24 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', 13:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:24 INFO - '_': '/tools/buildbot/bin/python'} 13:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:24 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)) 13:41:24 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)) 13:41:24 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)) 13:41:24 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)) 13:41:24 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)) 13:41:24 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)) 13:41:24 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)) 13:41:24 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)) 13:41:24 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)) 13:41:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:41:24 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 13:41:24 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 13:41:24 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 13:41:24 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 13:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:41:26 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)) 13:41:26 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)) 13:41:26 INFO - Installing collected packages: simplejson 13:41:26 INFO - Running setup.py install for simplejson 13:41:26 INFO - building 'simplejson._speedups' extension 13:41:26 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 13:41:27 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 13:41:27 INFO - Successfully installed simplejson 13:41:27 INFO - Cleaning up... 13:41:27 INFO - Return code: 0 13:41:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:41:27 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')]} 13:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:27 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')]} 13:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:27 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb090>, '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 0x22fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f5f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', '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 13:41:27 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 13:41:27 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 13:41:27 INFO - Using env: {'DISPLAY': ':0', 13:41:27 INFO - 'HOME': '/home/cltbld', 13:41:27 INFO - 'LANG': 'en_US.UTF-8', 13:41:27 INFO - 'LANGUAGE': 'en_US:en', 13:41:27 INFO - 'LOGNAME': 'cltbld', 13:41:27 INFO - 'MAIL': '/var/mail/cltbld', 13:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:27 INFO - 'MOZ_NO_REMOTE': '1', 13:41:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:27 INFO - 'NO_EM_RESTART': '1', 13:41:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:27 INFO - 'PWD': '/builds/slave/test', 13:41:27 INFO - 'SHELL': '/bin/bash', 13:41:27 INFO - 'SHLVL': '1', 13:41:27 INFO - 'TERM': 'linux', 13:41:27 INFO - 'TMOUT': '86400', 13:41:27 INFO - 'USER': 'cltbld', 13:41:27 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', 13:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:27 INFO - '_': '/tools/buildbot/bin/python'} 13:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:41:27 INFO - Cleaning up... 13:41:27 INFO - Return code: 0 13:41:27 INFO - Running post-action listener: _resource_record_post_action 13:41:27 INFO - Running post-action listener: _start_resource_monitoring 13:41:27 INFO - Starting resource monitoring. 13:41:27 INFO - [mozharness: 2017-10-03 20:41:27.408448Z] Finished create-virtualenv step (success) 13:41:27 INFO - [mozharness: 2017-10-03 20:41:27.408957Z] Running install step. 13:41:27 INFO - Running pre-action listener: _resource_record_pre_action 13:41:27 INFO - Running main action method: install 13:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:41:27 INFO - Reading from file tmpfile_stdout 13:41:27 INFO - Detecting whether we're running mozinstall >=1.0... 13:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:41:27 INFO - Reading from file tmpfile_stdout 13:41:27 INFO - Output received: 13:41:27 INFO - Usage: mozinstall [options] installer 13:41:27 INFO - Options: 13:41:27 INFO - -h, --help show this help message and exit 13:41:27 INFO - -d DEST, --destination=DEST 13:41:27 INFO - Directory to install application into. [default: 13:41:27 INFO - "/builds/slave/test"] 13:41:27 INFO - --app=APP Application being installed. [default: firefox] 13:41:27 INFO - mkdir: /builds/slave/test/build/application 13:41:27 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'] 13:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:41:42 INFO - Reading from file tmpfile_stdout 13:41:42 INFO - Output received: 13:41:42 INFO - /builds/slave/test/build/application/firefox/firefox 13:41:42 INFO - Running post-action listener: _resource_record_post_action 13:41:42 INFO - [mozharness: 2017-10-03 20:41:42.639821Z] Finished install step (success) 13:41:42 INFO - [mozharness: 2017-10-03 20:41:42.640072Z] Running setup-mitmproxy step. 13:41:42 INFO - Running pre-action listener: _resource_record_pre_action 13:41:42 INFO - Running main action method: setup_mitmproxy 13:41:42 INFO - Skipping: mitmproxy is not required 13:41:42 INFO - Running post-action listener: _resource_record_post_action 13:41:42 INFO - [mozharness: 2017-10-03 20:41:42.641276Z] Finished setup-mitmproxy step (success) 13:41:42 INFO - [mozharness: 2017-10-03 20:41:42.641503Z] Running run-tests step. 13:41:42 INFO - Running pre-action listener: _resource_record_pre_action 13:41:42 INFO - Running pre-action listener: _set_gcov_prefix 13:41:42 INFO - Running main action method: run_tests 13:41:42 WARNING - Try message not found. 13:41:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:41:42 INFO - Python 2.7.3 13:41:42 INFO - Return code: 0 13:41:42 INFO - grabbing minidump binary from tooltool 13:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:41:42 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 0x22fb090>, '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 0x22fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f5f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:41:42 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 13:41:42 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 13:41:42 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 13:41:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:41:42 INFO - Return code: 0 13:41:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:41:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:41:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:41:42 INFO - ENV: RUST_BACKTRACE is now full 13:41:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:41:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:41:42 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/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 13:41:42 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/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 13:41:42 INFO - Using env: {'DISPLAY': ':0', 13:41:42 INFO - 'HOME': '/home/cltbld', 13:41:42 INFO - 'LANG': 'en_US.UTF-8', 13:41:42 INFO - 'LANGUAGE': 'en_US:en', 13:41:42 INFO - 'LOGNAME': 'cltbld', 13:41:42 INFO - 'MAIL': '/var/mail/cltbld', 13:41:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:41:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:42 INFO - 'MOZ_NO_REMOTE': '1', 13:41:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:42 INFO - 'NO_EM_RESTART': '1', 13:41:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:42 INFO - 'PWD': '/builds/slave/test', 13:41:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:41:42 INFO - 'RUST_BACKTRACE': 'full', 13:41:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:41:42 INFO - 'SHELL': '/bin/bash', 13:41:42 INFO - 'SHLVL': '1', 13:41:42 INFO - 'TERM': 'linux', 13:41:42 INFO - 'TMOUT': '86400', 13:41:42 INFO - 'USER': 'cltbld', 13:41:42 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', 13:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:42 INFO - '_': '/tools/buildbot/bin/python'} 13:41:42 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/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 13:41:43 INFO - mozversion application_buildid: 20171003192105 13:41:43 INFO - mozversion application_changeset: 5044cb7aaf48ba278343ac8268120f2cd259ddbf 13:41:43 INFO - mozversion application_display_name: Firefox 13:41:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:41:43 INFO - mozversion application_name: Firefox 13:41:43 INFO - mozversion application_remotingname: firefox 13:41:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:41:43 INFO - mozversion application_vendor: Mozilla 13:41:43 INFO - mozversion application_version: 57.0 13:41:43 INFO - mozversion platform_buildid: 20171003192105 13:41:43 INFO - mozversion platform_changeset: 5044cb7aaf48ba278343ac8268120f2cd259ddbf 13:41:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:41:43 INFO - mozversion platform_version: 57.0 13:41:43 INFO - using testdate: 1507063303 13:41:43 INFO - actual date: 1507063303 13:41:43 INFO - starting webserver on 'localhost:43899' 13:41:43 INFO - SUITE-START | Running 2 tests 13:41:43 INFO - TEST-START | dromaeo_css 13:41:43 INFO - Initialising browser for dromaeo_css test... 13:41:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43899/getInfo.html -profile /tmp/tmp_BpBl6/profile 13:41:43 INFO - TEST-INFO | started process 2074 (/builds/slave/test/build/application/firefox/firefox http://localhost:43899/getInfo.html) 13:41:47 INFO - TEST-INFO | 2074: exit 0 13:41:47 INFO - Browser initialized. 13:41:47 INFO - Running cycle 1/1 for dromaeo_css test... 13:41:47 INFO - Using env: {'DISPLAY': ':0', 13:41:47 INFO - 'HOME': '/home/cltbld', 13:41:47 INFO - 'JSGC_DISABLE_POISONING': '1', 13:41:47 INFO - 'LANG': 'en_US.UTF-8', 13:41:47 INFO - 'LANGUAGE': 'en_US:en', 13:41:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:41:47 INFO - 'LOGNAME': 'cltbld', 13:41:47 INFO - 'MAIL': '/var/mail/cltbld', 13:41:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:41:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:41:47 INFO - 'MOZ_CRASHREPORTER': '1', 13:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:41:47 INFO - 'MOZ_NO_REMOTE': '1', 13:41:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:47 INFO - 'NO_EM_RESTART': '1', 13:41:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:47 INFO - 'PWD': '/builds/slave/test', 13:41:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:41:47 INFO - 'RUST_BACKTRACE': 'full', 13:41:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:41:47 INFO - 'SHELL': '/bin/bash', 13:41:47 INFO - 'SHLVL': '1', 13:41:47 INFO - 'TERM': 'linux', 13:41:47 INFO - 'TMOUT': '86400', 13:41:47 INFO - 'USER': 'cltbld', 13:41:47 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', 13:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:47 INFO - '_': '/tools/buildbot/bin/python'} 13:41:47 INFO - TEST-INFO | started process 2308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_BpBl6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:41:48 INFO - PID 2308 | 13:41:48 INFO - PID 2308 | (/builds/slave/test/build/application/firefox/firefox:2357): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:41:48 INFO - PID 2308 | 13:41:58 INFO - PID 2308 | RSS: Main: 143257600 13:41:58 INFO - PID 2308 | 13:44:56 INFO - PID 2308 | Cycle 1(1): loaded http://localhost:43899/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43899/tests/dromaeo/cssquery-ext.html) 13:44:57 INFO - PID 2308 | RSS: Main: 146579456 13:44:57 INFO - PID 2308 | 13:47:59 INFO - PID 2308 | Cycle 1(1): loaded http://localhost:43899/tests/dromaeo/cssquery-ext.html (next: http://localhost:43899/tests/dromaeo/cssquery-jquery.html) 13:47:59 INFO - PID 2308 | RSS: Main: 144740352 13:47:59 INFO - PID 2308 | 13:51:01 INFO - PID 2308 | Cycle 1(1): loaded http://localhost:43899/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43899/tests/dromaeo/cssquery-mootools.html) 13:51:01 INFO - PID 2308 | RSS: Main: 144035840 13:51:01 INFO - PID 2308 | 13:54:03 INFO - PID 2308 | Cycle 1(1): loaded http://localhost:43899/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43899/tests/dromaeo/cssquery-prototype.html) 13:54:03 INFO - PID 2308 | RSS: Main: 145993728 13:54:03 INFO - PID 2308 | 13:57:06 INFO - PID 2308 | Cycle 1(1): loaded http://localhost:43899/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43899/tests/dromaeo/cssquery-yui.html) 13:57:07 INFO - PID 2308 | RSS: Main: 147816448 13:57:07 INFO - PID 2308 | 14:00:08 INFO - PID 2308 | Cycle 1(1): loaded http://localhost:43899/tests/dromaeo/cssquery-yui.html (next: http://localhost:43899/tests/dromaeo/cssquery-dojo.html) 14:00:08 INFO - PID 2308 | RSS: Main: 150081536 14:00:08 INFO - PID 2308 | 14:00:08 INFO - PID 2308 | __start_tp_report 14:00:08 INFO - PID 2308 | _x_x_mozilla_page_load 14:00:08 INFO - PID 2308 | _x_x_mozilla_page_load_details 14:00:08 INFO - PID 2308 | |i|pagename|runs| 14:00:08 INFO - PID 2308 | |0;dojo.html;3998.1204135090275;3999.3401088820337;4019.8191081401333;4045.979770101149;4072.7556346619203;6391.360863913612;6410.839729006777;6438.645874476902;6481.3842684944975;6498.675066246692;6436.420722135007;6476.352364763521;6512.218533775942;6527.477801775858;6565.704543295551;5748.568857335696;5795.4784069433745;5874.295084589855;5923.674197919113;5949.762009519614;5843.8539036524;5881.8823623527505;5883.117532370136;5918.082697181943;5997;5894.793682221123;5970.432808883171;6008.399160084;6016;6031.306399764039;5943.732532036069;5951.821445356603;5955.04719244923;5981.551383646244;6028.457438830483;5742.023855944458;5827.475527202572;5863.882722345572;5880.235569375954;5926.111083337534;6429.903551446732;6437.130987316699;6472.6763661817195;6483.773067942647;6510.869782604322;7059.364657180827;7128.6079265640365;7144.999700041998;7150.213476517579;7166.3908567771805;7122.430205583592;7128.92871071293;7158.391536719385;7225.855482890365;7241.855162896765;6473.935260647428;6536.182977127859;6584.934150658528;6629.668516574152;6647.501437392167;7207.819804504929;7296.6716497757725;7310.195878453366;7351.786955152447;7358.742444014434;6991.825204369829;6994.860102797916;7026.981087742249;7050.5546362995465;7055.89416158758;7029.261927497641;7040.577565345993;7063.081799366152;7120.92879071213;7131.072960515204;7036.6129862857015;7106.289371062956;7114.039604653409;7127.5010749248095;7139.393151582174;7026.191987921352;7030.964845175844;7036.437085033185;7116.964415177891;7119.964400177966;5251.133562962144;5264.6051546134195;5320.14877619579;5343.091674415358;5351.384590772033;4804.903901921942;4825.710457372569;4856.562909338177;4908.435529914034;4975.104481193348;6739.359760822714;6754.324567543206;6802.65986700663;6806.931930680729;6809.489288303397;7125.786226413215;7127.2516385778745;7135.89296160558;7217.2421895701245;7223.349898509159;6569.83575410609;6693.364130407604;6695.263521012685;6702.966485167641;6705.061291419205;5965.403459654087;6019.879602407927;6032.788852390146;6070.484008859208;6092.3603021682975;7256.104848026166;7340.522866013692;7414.555126692416;7449;7454.180040195574;6948.33990770876;7032.472564557576;7058.929410705828;7064.470164737768;7091.751788687475;7312.630680712426;7400.481966262525;7425.071866016748;7427.962860185665;7437.405007599487;6926.272741362084;7038.8944165838575;7061.788146355618;7113.57318560888;7128;7085.964570177116;7116.323949224816;7125.073740413713;7159.391451726453;7204.71181152748;6724.4284235840505;6880.9655951721925;6881.41507971828;6969.059177011241;6981.755638552626;6787.728490860311;6813.591184528944;6821;6824.942133969243;6826.41975432074;6801.829954251183;6814.250432452525;6821.079154314302;6832.521723479309;6841.486888483483;6860.2453730088655;6918.965405172942;6937.445004399737;7005.509614326948;7014.088168538057;6715.127033485811;6717.932820671731;6808.38724514796;6817.2501024888215;6817.659117044029 14:00:08 INFO - PID 2308 | |1;ext.html;1004.5228516454683;1013.1641395848427;1025.0262250861683;1026.153423425674;1037.2531777120475;46687.533124668786;47377.76311118448;47405.762971185184;47483.287750683725;47573;43791.12417751651;44113.338299925446;44116;44148.55851441484;44229.336559951545;8074.111847696749;8193;8201;8257.752267431986;8273.627686754111;7970.561619110947;8005.039395272575;8064.435489515737;8132.349412047051;8149.918500815005;8797.29621630268;8969.282457403424;8971.95514022429;8974.551272436385;8975.102489751005;8854.07032261613;8870.778230544223;8879.911200888006;8920.821583568357;8926.553672316422;8724.43291186071;8825.338099642488;8830.735077947671;8831.735047948572;8833.160849719266;43130.35304470435;43371.34942975858;43434.34848477275;43499.34750978738;43611.78194109041;3769.038895081764;3785.6403641653997;3788.5643151037707;3791.639794219545;3793.089658481972;34299.65700342989;34488.82755586231;34539.481907771406;34546.82726586376;34610.65389346125;5509.834704958857;5653.462921022538;5686.2607860977805;5703.828885133453;5705.172749951275;237517;239618;239729;240229;240899;48870.75564622154;49289.75355123202;57392.71303643455;58236.08819559005;58323.70838145782;60063.099053514234;60308;60810;60974;61017.38982610117;18004.459866204033;18010.36963706264;18137.546561336072;18137.637247255247;18182.5454363642;14920.552383428514;14928.178950157846;14935.775963360558;14943.551693449213;14953.850461495464;16110.275037623334;16159.596010099842;16208.918955405148;16209.83790162107;16320.591985200228;6252.406021427957;6267.749290028439;6306.369363063657;6345.904811427832;6389.137466442064;1103.586155191803;1111.9833202501968;1114;1130.6325444230658;1136.8408422820812;25411.364715881882;25771.87114064455;25958.09146679857;26157.346066348495;26177.34556636061;1187.6852634051984;1230.0774419185611;1236.0358920042381;1247.1332423965257;1247.326443720381;13820.792688109686;13887;13933.372998215105;14035.298235088205;14149;307259;320596;320966;322703;325996;67714;67828.6608566954;68625.31374686288;68725.31274687289;68729;1559.469780274712;1585.9524214273822;1590.3320605345782;1591.4986779164526;1616.9514914552583;32625.34749305048;32641.673583264812;33097.338053239284;33126.503102453964;33350.666493335724;46519.767401162775;46783.362582309455;46800.7659961698;46869.2969605463;46899.062018760116;270117;271266;272804;273089;273156;41242.58757412388;41693.58306416897;41860.95347616334;42032.36951445792;42150.578494214664;49717;52026.21960670517;52153.217701735266;53185.734071329396;53301.73349133229;36651.45022824607;36659.45010824787;36951.44572831463;37155.25689486141;37633.2473350537;36900.446493302086;37236.44145337768;37322.44016339703;37817.432738508396;38090.80954595209;43536.56463435325;44896.55103449054;45056.77471612621;45094.09811803811;45501;36395.81802091079;36410.45384319184;36941.63058369382;37057.25885482329;37432;27384;27388;27481.31296717598;27611.30971725723;27864.582031269143 14:00:08 INFO - PID 2308 | |2;jquery.html;596.6837576084677;619.5291578400414;621.779268359732;630.3444417805482;650.9576877502964;24621.384465388353;24874.378140546494;25513.999999999978;25556.48887022261;25635.102771403006;26505.602415963775;27764.444711105818;27764.722352776465;27771;27784.166475005783;6775.59346439214;6960.895586566206;6964.616946067964;7005.964970175168;7016.298370162994;6668.066470694107;6911.550749201311;6926.099607051076;6933.583984960893;6940.340667636567;6888.242293347727;6888.793336199922;6900.551464154814;6900.930990690079;6902.861942761142;6797.762078327235;6803.761868334634;6833.111695479581;6876.381125698686;6888.690008949584;6397.200349956255;6405;6415.877221486268;6426;6429.646369449679;29773.702262977527;30365.544516832266;31571.684283157334;31774.841125794224;31898;2334.3813889319345;2358.5400846834873;2368.538135063663;2371.6442533619925;2377.191754803358;19904.402867913985;20264.189432422685;20469.18123275067;20477.4880627984;20567.38297851067;2538.4796116796015;2582.2253324002913;2638.287662331179;2644.1935209761014;2654.2037388783483;147751;152756;156963;162898.18550907288;176493;16591.917040414963;16706.58233544171;16732.916335418246;17086.743698844526;17465.912670436566;27553.724462755516;27603.86198069037;27628.099049599503;27734.3066423337;27764;11350.829737553944;11414;11442.885571144181;11474.139439542068;11541.07671386287;10506.894931050745;10530.684079477627;10531;10569.735756606146;10655.094316982988;9884.159846412991;9951.850722239173;10301.433421161908;10347.172226221885;10504.474776261157;3079.8306093164642;3096.148559146253;3129.6713845046397;3131.968680313213;3199.7600179986594;1051.7370657335666;1079.6221322537049;1089.8964598363143;1095.0965453500894;1099.7085772270354;22033.33899983003;22280.777192228194;22455.55088898213;22554.097836086374;22784;1141.275290190735;1166.7724793665323;1170.268582136165;1177.8881006304387;1180.3508070561156;11915.344656043828;12265.202761820454;12284;12355.196912200678;12412;648999;651101;651177;659023;663746;123735;128063;128890;130987;134328.32835835757;1149.2989276541302;1208.5347141350467;1295.5854126679371;1297.6561211279018;1332.4603535567917;22389.44026399353;22866.31401057971;22941.426464338525;23047.539049218587;23153.88423057874;65816.34183658102;66952;67114.66442667755;67189;67395.3260467389;87561.56219218863;88088.5595572018;88362;88540;88735.55632221798;16071.839281607034;16211.189440528162;16297.67404651924;16490.505284841474;16525.91737041307;24772;24833.130840420497;24923.50152996966;24990.75009249957;25086.37284067913;19039.90480047591;19385.4184374469;19465.318713844947;19577;19698.90150549238;17552.648947021244;17607.823921760617;17782.822171778116;17956.461306160312;18083.09584520795;19786.60426791485;20046.89976550108;20071.59856802885;20206.59586808285;20241.6963745541;16023.958442701187;16216;16254.268557914686;16267;16379.344826207294;19468.415947521597;19499.61000780005;19641.508962275486;20087.39737807868;20261.189552417738 14:00:08 INFO - PID 2308 | |3;mootools.html;1463.2829913342462;1571.6385231396782;1578.9657774157924;1582.106110047823;1583.5882670505664;17408.65182696347;18155.183016764244;18234.179461924214;18241.635167296663;18260.817391826076;17829.286828526845;17906;17949;17952.281908723635;17966.730499042493;3058.143719758471;3085;3143.9685603143903;3145.5281707743793;3146.669599692034;3042.7261546460813;3075.2773098321877;3108.1607965849207;3120.032789835147;3126.796758210709;3103.937921241574;3180.3480286541203;3186.283086305574;3189.776715629907;3201.6158061032706;3125.7968232064954;3135.3885992231526;3151.3854798314337;3158.115727596277;3160.2573395252098;3017.9245518861985;3037.4228896509812;3045.5431685247167;3056.4651186042574;3062.0813755873373;17300.22149003298;17769;17771.466855994342;17778.644427111514;17779.73330400045;8991.325650576233;9272.629094836198;9274.30442716799;9286.674966376211;9288.767780805467;5767.4520920512905;5820.912686309709;5861.912071318934;5946.7323970421;6034.306054803666;2137.657974724052;2187.156252928778;2192.35325578953;2226.298715904485;2228.19784877444;32856.178595535304;32978.505322420184;33092.6690733092;33132;33143.17142071443;7481.326680598772;7553.7356192533;7579.696812127453;7830.686772529149;7831.608419578998;20460.590788184152;20547.897260513902;20551.4862128448;20571.58856822855;20592;8847.73456796297;8859.202671759573;8997.685081022133;9002.099790021077;9055.411398259092;8112.756617301372;8150.3479721622125;8309.709160179365;8332.916670833336;8383.580820958927;5927.940720592739;5961.5826892118;6005.369436209223;6029.939700602938;6051.848703782441;1582;1626.6502701919144;1749.6763098826757;1766.7703198584102;1792.6683563540787;1019.3578045831078;1046.2885238038054;1049.7060822969581;1058.8252938265255;1070.710908054821;10250.948745256226;10349.430781307101;10358.223133265035;10447.320924139907;10511.211659125596;1125.9042981346513;1131.5643477261315;1131.8358837968449;1134.28540019787;1145.4673576786834;5741.851629674082;5772.711364431846;5785.1322301654245;6478.481721462272;6542;26451.338716531856;26788.464230715665;26852.731472685413;27265.182044538695;27268.727312727016;25148.11981580636;26009.21972340833;26165.869170654027;26268.21195364142;26479.86760066226;12864.163829351062;13130.671733206746;13254.337283135805;13254.734905302033;13376.46494140243;9503.049695030442;9512.667056652985;9534.141927226583;9549;9731.41611503312;22221.444463888532;22352.552948941255;22374.664380033988;23005;23344.6498302529;23433.648495272926;23519.75402617982;23584.17455389053;23696.28911132669;23835.64246536338;13234.205947643171;13236.669083272995;13350.599482015556;13355.332233388486;13382.531611393944;16325.918370408071;16376.181190940644;16407.42574009904;16438.917805410896;16469.423570174986;11360.488778004845;13501.662458438617;13623;13703.862961370258;13708;12276.754464910831;12321.322327271728;12356.320402377956;12523.874761252271;12625.684357891127;11402.82895756581;11413.31520108763;11475.024622907147;11526.366049867338;11575.768484630093;8344.41589088758;8459.61931713062;8503.319734421355;8621.137886211329;8660.696875609323;8961.193492585699;8968.596413161555;8998.415103018282;9001.95499022527;9013.459192448474 14:00:08 INFO - PID 2308 | |4;prototype.html;559.6586082489681;579.7304253522111;581.1167026120296;604.320139842677;615.5106690181307;6346.714397852096;6401.839954001152;6459.677016149197;6498.6100833949995;6527.706253218605;6336.239651241846;6409.173385585109;6439.195100612424;6455.774047908324;6458.903116453245;5292.206169074631;5317.867053323669;5328.120860058086;5347.144456886899;5351;4989.675671081386;5291.8093428978555;5325.281087053257;5333.38666053403;5376.973115134419;5149.665271757323;5158.787684894047;5163.896722065557;5177.223416487538;5179.585633149339;5127.717975511346;5144.099782538041;5156.071907056728;5171.2501687255135;5171.663841850268;4699.7415142167165;4701.294805779126;4706.199946009152;4706.811727530895;4713.787879545429;6337;6343.904841427382;6350.936490635081;6397.712102955332;6420.917959379524;5964.552658550626;6066.908996365058;6073.301570319426;6091.208142941389;6106.053561697944;6685.231198412148;6690.83272918176;6758.966205168943;6773.342395106636;6802.693878775467;4952.455229924705;5125.589952803767;5171.81898633546;5187.910538786859;5208.322918020633;6869.484788640872;6985.301469852974;7003.894941575881;7015.473839462061;7099.396551293146;5287.550558202596;5312.681239125587;5357.223202635674;5360.195970604441;5378.159656309274;5384.892302154013;5405.351357837085;5408.8377348679605;5419.3225846769155;5436.6737995719595;5989.131575921554;5998.850028749316;5999.700014999233;6018.939810601838;6021.397860214031;6814.591124532544;6824.965875170592;6830.53143574124;6839.521233513706;6847.452203823682;1845.2434501854175;1858.2566973210824;1878.64305781901;1886.226647074693;1897.724829899657;1295.1257900917033;1330.9866901331056;1333.3333333333333;1346.6566025663394;1356.3421740455872;6398.2641996170105;6429.58207716497;6434;6470.547061705635;6502.674866256668;6763.560368576125;6776.7628133015105;6780.559263647847;6808.242661722011;6824.590524568542;6353.30113687494;6363.204599425072;6368.968155159195;6385.936140638627;6440.323766004596;3514.525539052195;3617.2403795203304;3618.5295911531334;3639.6724294813594;3652.141746689526;7184.389326907167;7201.3158749918675;7218.783436496913;7240.637968101574;7252.274772522811;6939.258992697856;6963.7562685305775;6983.685734141975;6993.790186294419;7057.294270572902;7094.871538538418;7130;7175.138983322035;7230.602316872517;7287.307705767944;6827.965860170667;6852.657367131723;6853.211880633791;6870.484713646397;6873.731668549467;6728.293529179366;6767.35710107539;6798.150231221098;6836.889215407077;6853.17761868579;7016.894746578703;7126.572405655677;7174.067371241706;7178;7215.278472152742;5339.679619222859;5343.305370301836;5349.893002140013;5354.571634269327;5358.97320513395;6699.631520266237;6830.692618832264;6845.178578570603;6930.826729331807;6933.4106600939485;6538.901916471162;6721.596704197764;6732.3267673232285;6752.561083529555;6766.763163289262;6681.432078273401;6715.630640314829;6726.260111387645;6741.764038258638;6779.322067793379;6633.800985970429;6652.567583107082;6677.232118306457;6678.465722742266;6698.531102822755;6796.66016699173;6806.897896531457;6816.897746533905;6835.658217089225;6861.113193871725;6435.356464353715;6600.207975043026;6628.436582890508;6635.236947750877;6686.866262674622 14:00:08 INFO - PID 2308 | |5;yui.html;977.1645243316968;1007.0835539658912;1009.429672235187;1026.4611079183428;1045.9958439897698;20384.69422958655;20768.584628307442;20843.583128337425;20866.791332086676;20936.581268374623;22225.777742222574;24224.515509689794;24241.39396515088;24253.151139710113;24384.268471945827;1075.9731006724817;1097.1058587251364;1097.9451027448595;1101.3887292552631;1102.7298311913553;1061.6284300494842;1104.9558017679283;1105.2208193223757;1112.4660163121707;1114.186643750063;1196.9222000569978;1201.1351826684818;1205.6624145239348;1206.2400687566821;1206.8551773787115;1183.7395772929942;1198.6164427383242;1204.9518019279262;1207.1429285207425;1207.7886369885234;882.9735107946772;883.024258194692;883.1301168349171;883.7702197428715;884.752269364579;20651.793482065288;20733.481662958395;21098.5780284395;21101.5779684407;21637.67543486833;21963.23128690504;22396.216132435286;22403.775962240332;22426.55146897053;22691;17771.289148434047;18167.391911852654;18195.181216845274;18313.816861831478;18351.35770248035;3916.060145565072;4010.197960407901;4041.1109555897656;4041.717079804415;4050.2507036198103;169688;173469;174045;174123;177048;16832.57918552046;16907.070111144007;17161.914190428968;17170.742438863428;17210.91394543019;35282.82358588191;37294;37463.25073498515;37471.25057498835;37498.62501375006;8445.66217351299;8543.829123417498;8552.786180345542;8624.396292259482;8676.219140277279;4072.165206132736;4176.749395036308;4233.04756429807;4236.512801027921;4239.59723826236;5383.515483606494;7043.260457651975;7136.785896423115;7150.499465037397;7161.104861892263;1285.7235694325766;1301.9153755005893;1326.7877139657608;1334.0794851552398;1334.3861823561272;750.1485813601493;777.6733771815851;782.772995831214;792.180093603118;792.7146227358146;14062.437502499786;14219.85780142206;14820.703585928437;15406.691866162839;15504.689906201813;770.6724642027116;771.2595907928452;781.4959351218432;783.9529628222325;795.4352409789115;6649.135612370361;6752.155980502437;6768;6816.7614133505085;6910.2053263874295;153626.23186884218;153979;156390;156485;159326.20336898242;138462.30768846293;139463;141308;142655;145491;120962;122592;124435;125658.99999999817;130141.34929325293;12431.31627760482;12529.122961392615;12685.06325072809;12739.936300318439;12987.842931675703;61814.69092654508;62631.37368626438;62820.371796281455;63874;63878.36121638724;76542.61728691321;76952.61523692346;77351;79462.60268698851;80292.59853700694;17986.91006544959;18772.906135469235;19074.80925190786;19162.137703803084;19191.90404047971;20705.378838634864;20954.161833527098;21102.47243818917;21122;21137.365879023655;17441.30234790594;17708.91145544264;18041.278348866424;18052.097395129927;18065.458036258933;18060.187291572172;18187.45437636873;18210.089495524906;18255.178516967033;18386.356477523223;17857.196426160594;18068.457946261635;18237.81762182361;18265.726014109532;18306;14062.226577538333;14304.141751494944;14614.561563153122;14662;14713.504606396353;14003.649908752363;14291.071080379743;14317.355718992461;14345.067570607876;14356.641083972985 14:00:08 INFO - PID 2308 | __end_tp_report 14:00:08 INFO - PID 2308 | __start_cc_report 14:00:08 INFO - PID 2308 | _x_x_mozilla_cycle_collect,248 14:00:08 INFO - PID 2308 | __end_cc_report 14:00:08 INFO - PID 2308 | __startTimestamp1507064408955__endTimestamp 14:00:08 INFO - PID 2308 | 14:00:08 INFO - PID 2308 | ------- Summary: start ------- 14:00:08 INFO - PID 2308 | Number of tests: 6 14:00:08 INFO - PID 2308 | 14:00:08 INFO - PID 2308 | [#0] dojo.html Cycles:165 Average:6562.61 Median:6814.25 stddev:754.44 (11.1%) stddev-sans-first:729.44 14:00:08 INFO - PID 2308 | Values: 3998.1 3999.3 4019.8 4046.0 4072.8 6391.4 6410.8 6438.6 6481.4 6498.7 6436.4 6476.4 6512.2 6527.5 6565.7 5748.6 5795.5 5874.3 5923.7 5949.8 5843.9 5881.9 5883.1 5918.1 5997.0 5894.8 5970.4 6008.4 6016.0 6031.3 5943.7 5951.8 5955.0 5981.6 6028.5 5742.0 5827.5 5863.9 5880.2 5926.1 6429.9 6437.1 6472.7 6483.8 6510.9 7059.4 7128.6 7145.0 7150.2 7166.4 7122.4 7128.9 7158.4 7225.9 7241.9 6473.9 6536.2 6584.9 6629.7 6647.5 7207.8 7296.7 7310.2 7351.8 7358.7 6991.8 6994.9 7027.0 7050.6 7055.9 7029.3 7040.6 7063.1 7120.9 7131.1 7036.6 7106.3 7114.0 7127.5 7139.4 7026.2 7031.0 7036.4 7117.0 7120.0 5251.1 5264.6 5320.1 5343.1 5351.4 4804.9 4825.7 4856.6 4908.4 4975.1 6739.4 6754.3 6802.7 6806.9 6809.5 7125.8 7127.3 7135.9 7217.2 7223.3 6569.8 6693.4 6695.3 6703.0 6705.1 5965.4 6019.9 6032.8 6070.5 6092.4 7256.1 7340.5 7414.6 7449.0 7454.2 6948.3 7032.5 7058.9 7064.5 7091.8 7312.6 7400.5 7425.1 7428.0 7437.4 6926.3 7038.9 7061.8 7113.6 7128.0 7086.0 7116.3 7125.1 7159.4 7204.7 6724.4 6881.0 6881.4 6969.1 6981.8 6787.7 6813.6 6821.0 6824.9 6826.4 6801.8 6814.3 6821.1 6832.5 6841.5 6860.2 6919.0 6937.4 7005.5 7014.1 6715.1 6717.9 6808.4 6817.3 6817.7 14:00:08 INFO - PID 2308 | 14:00:08 INFO - PID 2308 | [#1] ext.html Cycles:180 Average:47052.08 Median:3787.10 stddev:72701.61 (1919.7%) stddev-sans-first:72823.35 14:00:08 INFO - PID 2308 | Values: 1004.5 1013.2 1025.0 1026.2 1037.3 46687.5 47377.8 47405.8 47483.3 47573.0 43791.1 44113.3 44116.0 44148.6 44229.3 8074.1 8193.0 8201.0 8257.8 8273.6 7970.6 8005.0 8064.4 8132.3 8149.9 8797.3 8969.3 8972.0 8974.6 8975.1 8854.1 8870.8 8879.9 8920.8 8926.6 8724.4 8825.3 8830.7 8831.7 8833.2 43130.4 43371.3 43434.3 43499.3 43611.8 3769.0 3785.6 3788.6 3791.6 3793.1 34299.7 34488.8 34539.5 34546.8 34610.7 5509.8 5653.5 5686.3 5703.8 5705.2 237517.0 239618.0 239729.0 240229.0 240899.0 48870.8 49289.8 57392.7 58236.1 58323.7 60063.1 60308.0 60810.0 60974.0 61017.4 18004.5 18010.4 18137.5 18137.6 18182.5 14920.6 14928.2 14935.8 14943.6 14953.9 16110.3 16159.6 16208.9 16209.8 16320.6 6252.4 6267.7 6306.4 6345.9 6389.1 1103.6 1112.0 1114.0 1130.6 1136.8 25411.4 25771.9 25958.1 26157.3 26177.3 1187.7 1230.1 1236.0 1247.1 1247.3 13820.8 13887.0 13933.4 14035.3 14149.0 307259.0 320596.0 320966.0 322703.0 325996.0 67714.0 67828.7 68625.3 68725.3 68729.0 1559.5 1586.0 1590.3 1591.5 1617.0 32625.3 32641.7 33097.3 33126.5 33350.7 46519.8 46783.4 46800.8 46869.3 46899.1 270117.0 271266.0 272804.0 273089.0 273156.0 41242.6 41693.6 41861.0 42032.4 42150.6 49717.0 52026.2 52153.2 53185.7 53301.7 36651.5 36659.5 36951.4 37155.3 37633.2 36900.4 37236.4 37322.4 37817.4 38090.8 43536.6 44896.6 45056.8 45094.1 45501.0 36395.8 36410.5 36941.6 37057.3 37432.0 27384.0 27388.0 27481.3 27611.3 27864.6 14:00:08 INFO - PID 2308 | 14:00:08 INFO - PID 2308 | [#2] jquery.html Cycles:180 Average:42160.88 Median:22994.48 stddev:109280.15 (475.2%) stddev-sans-first:109542.15 14:00:08 INFO - PID 2308 | Values: 596.7 619.5 621.8 630.3 651.0 24621.4 24874.4 25514.0 25556.5 25635.1 26505.6 27764.4 27764.7 27771.0 27784.2 6775.6 6960.9 6964.6 7006.0 7016.3 6668.1 6911.6 6926.1 6933.6 6940.3 6888.2 6888.8 6900.6 6900.9 6902.9 6797.8 6803.8 6833.1 6876.4 6888.7 6397.2 6405.0 6415.9 6426.0 6429.6 29773.7 30365.5 31571.7 31774.8 31898.0 2334.4 2358.5 2368.5 2371.6 2377.2 19904.4 20264.2 20469.2 20477.5 20567.4 2538.5 2582.2 2638.3 2644.2 2654.2 147751.0 152756.0 156963.0 162898.2 176493.0 16591.9 16706.6 16732.9 17086.7 17465.9 27553.7 27603.9 27628.1 27734.3 27764.0 11350.8 11414.0 11442.9 11474.1 11541.1 10506.9 10530.7 10531.0 10569.7 10655.1 9884.2 9951.9 10301.4 10347.2 10504.5 3079.8 3096.1 3129.7 3132.0 3199.8 1051.7 1079.6 1089.9 1095.1 1099.7 22033.3 22280.8 22455.6 22554.1 22784.0 1141.3 1166.8 1170.3 1177.9 1180.4 11915.3 12265.2 12284.0 12355.2 12412.0 648999.0 651101.0 651177.0 659023.0 663746.0 123735.0 128063.0 128890.0 130987.0 134328.3 1149.3 1208.5 1295.6 1297.7 1332.5 22389.4 22866.3 22941.4 23047.5 23153.9 65816.3 66952.0 67114.7 67189.0 67395.3 87561.6 88088.6 88362.0 88540.0 88735.6 16071.8 16211.2 16297.7 16490.5 16525.9 24772.0 24833.1 24923.5 24990.8 25086.4 19039.9 19385.4 19465.3 19577.0 19698.9 17552.6 17607.8 17782.8 17956.5 18083.1 19786.6 20046.9 20071.6 20206.6 20241.7 16024.0 16216.0 16254.3 16267.0 16379.3 19468.4 19499.6 19641.5 20087.4 20261.2 14:00:08 INFO - PID 2308 | 14:00:08 INFO - PID 2308 | [#3] mootools.html Cycles:180 Average:11086.91 Median:25578.67 stddev:8214.73 (32.1%) stddev-sans-first:8205.96 14:00:08 INFO - PID 2308 | Values: 1463.3 1571.6 1579.0 1582.1 1583.6 17408.7 18155.2 18234.2 18241.6 18260.8 17829.3 17906.0 17949.0 17952.3 17966.7 3058.1 3085.0 3144.0 3145.5 3146.7 3042.7 3075.3 3108.2 3120.0 3126.8 3103.9 3180.3 3186.3 3189.8 3201.6 3125.8 3135.4 3151.4 3158.1 3160.3 3017.9 3037.4 3045.5 3056.5 3062.1 17300.2 17769.0 17771.5 17778.6 17779.7 8991.3 9272.6 9274.3 9286.7 9288.8 5767.5 5820.9 5861.9 5946.7 6034.3 2137.7 2187.2 2192.4 2226.3 2228.2 32856.2 32978.5 33092.7 33132.0 33143.2 7481.3 7553.7 7579.7 7830.7 7831.6 20460.6 20547.9 20551.5 20571.6 20592.0 8847.7 8859.2 8997.7 9002.1 9055.4 8112.8 8150.3 8309.7 8332.9 8383.6 5927.9 5961.6 6005.4 6029.9 6051.8 1582.0 1626.7 1749.7 1766.8 1792.7 1019.4 1046.3 1049.7 1058.8 1070.7 10250.9 10349.4 10358.2 10447.3 10511.2 1125.9 1131.6 1131.8 1134.3 1145.5 5741.9 5772.7 5785.1 6478.5 6542.0 26451.3 26788.5 26852.7 27265.2 27268.7 25148.1 26009.2 26165.9 26268.2 26479.9 12864.2 13130.7 13254.3 13254.7 13376.5 9503.0 9512.7 9534.1 9549.0 9731.4 22221.4 22352.6 22374.7 23005.0 23344.6 23433.6 23519.8 23584.2 23696.3 23835.6 13234.2 13236.7 13350.6 13355.3 13382.5 16325.9 16376.2 16407.4 16438.9 16469.4 11360.5 13501.7 13623.0 13703.9 13708.0 12276.8 12321.3 12356.3 12523.9 12625.7 11402.8 11413.3 11475.0 11526.4 11575.8 8344.4 8459.6 8503.3 8621.1 8660.7 8961.2 8968.6 8998.4 9002.0 9013.5 14:00:08 INFO - PID 2308 | 14:00:08 INFO - PID 2308 | [#4] prototype.html Cycles:180 Average:5785.88 Median:6434.68 stddev:1601.26 (24.9%) stddev-sans-first:1556.96 14:00:08 INFO - PID 2308 | Values: 559.7 579.7 581.1 604.3 615.5 6346.7 6401.8 6459.7 6498.6 6527.7 6336.2 6409.2 6439.2 6455.8 6458.9 5292.2 5317.9 5328.1 5347.1 5351.0 4989.7 5291.8 5325.3 5333.4 5377.0 5149.7 5158.8 5163.9 5177.2 5179.6 5127.7 5144.1 5156.1 5171.3 5171.7 4699.7 4701.3 4706.2 4706.8 4713.8 6337.0 6343.9 6350.9 6397.7 6420.9 5964.6 6066.9 6073.3 6091.2 6106.1 6685.2 6690.8 6759.0 6773.3 6802.7 4952.5 5125.6 5171.8 5187.9 5208.3 6869.5 6985.3 7003.9 7015.5 7099.4 5287.6 5312.7 5357.2 5360.2 5378.2 5384.9 5405.4 5408.8 5419.3 5436.7 5989.1 5998.9 5999.7 6018.9 6021.4 6814.6 6825.0 6830.5 6839.5 6847.5 1845.2 1858.3 1878.6 1886.2 1897.7 1295.1 1331.0 1333.3 1346.7 1356.3 6398.3 6429.6 6434.0 6470.5 6502.7 6763.6 6776.8 6780.6 6808.2 6824.6 6353.3 6363.2 6369.0 6385.9 6440.3 3514.5 3617.2 3618.5 3639.7 3652.1 7184.4 7201.3 7218.8 7240.6 7252.3 6939.3 6963.8 6983.7 6993.8 7057.3 7094.9 7130.0 7175.1 7230.6 7287.3 6828.0 6852.7 6853.2 6870.5 6873.7 6728.3 6767.4 6798.2 6836.9 6853.2 7016.9 7126.6 7174.1 7178.0 7215.3 5339.7 5343.3 5349.9 5354.6 5359.0 6699.6 6830.7 6845.2 6930.8 6933.4 6538.9 6721.6 6732.3 6752.6 6766.8 6681.4 6715.6 6726.3 6741.8 6779.3 6633.8 6652.6 6677.2 6678.5 6698.5 6796.7 6806.9 6816.9 6835.7 6861.1 6435.4 6600.2 6628.4 6635.2 6686.9 14:00:08 INFO - PID 2308 | 14:00:08 INFO - PID 2308 | [#5] yui.html Cycles:180 Average:30201.08 Median:18285.86 stddev:45479.04 (248.7%) stddev-sans-first:45553.68 14:00:08 INFO - PID 2308 | Values: 977.2 1007.1 1009.4 1026.5 1046.0 20384.7 20768.6 20843.6 20866.8 20936.6 22225.8 24224.5 24241.4 24253.2 24384.3 1076.0 1097.1 1097.9 1101.4 1102.7 1061.6 1105.0 1105.2 1112.5 1114.2 1196.9 1201.1 1205.7 1206.2 1206.9 1183.7 1198.6 1205.0 1207.1 1207.8 883.0 883.0 883.1 883.8 884.8 20651.8 20733.5 21098.6 21101.6 21637.7 21963.2 22396.2 22403.8 22426.6 22691.0 17771.3 18167.4 18195.2 18313.8 18351.4 3916.1 4010.2 4041.1 4041.7 4050.3 169688.0 173469.0 174045.0 174123.0 177048.0 16832.6 16907.1 17161.9 17170.7 17210.9 35282.8 37294.0 37463.3 37471.3 37498.6 8445.7 8543.8 8552.8 8624.4 8676.2 4072.2 4176.7 4233.0 4236.5 4239.6 5383.5 7043.3 7136.8 7150.5 7161.1 1285.7 1301.9 1326.8 1334.1 1334.4 750.1 777.7 782.8 792.2 792.7 14062.4 14219.9 14820.7 15406.7 15504.7 770.7 771.3 781.5 784.0 795.4 6649.1 6752.2 6768.0 6816.8 6910.2 153626.2 153979.0 156390.0 156485.0 159326.2 138462.3 139463.0 141308.0 142655.0 145491.0 120962.0 122592.0 124435.0 125659.0 130141.3 12431.3 12529.1 12685.1 12739.9 12987.8 61814.7 62631.4 62820.4 63874.0 63878.4 76542.6 76952.6 77351.0 79462.6 80292.6 17986.9 18772.9 19074.8 19162.1 19191.9 20705.4 20954.2 21102.5 21122.0 21137.4 17441.3 17708.9 18041.3 18052.1 18065.5 18060.2 18187.5 18210.1 18255.2 18386.4 17857.2 18068.5 18237.8 18265.7 18306.0 14062.2 14304.1 14614.6 14662.0 14713.5 14003.6 14291.1 14317.4 14345.1 14356.6 14:00:08 INFO - PID 2308 | -------- Summary: end -------- 14:00:08 INFO - PID 2308 | 14:00:09 INFO - TEST-INFO | 2308: exit 0 14:00:09 INFO - TEST-OK | dromaeo_css | took 1106509ms 14:00:09 INFO - TEST-START | kraken 14:00:09 INFO - Initialising browser for kraken test... 14:00:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43899/getInfo.html -profile /tmp/tmpn7yNjD/profile 14:00:09 INFO - TEST-INFO | started process 2744 (/builds/slave/test/build/application/firefox/firefox http://localhost:43899/getInfo.html) 14:00:14 INFO - TEST-INFO | 2744: exit 0 14:00:14 INFO - Browser initialized. 14:00:14 INFO - Running cycle 1/1 for kraken test... 14:00:14 INFO - Using env: {'DISPLAY': ':0', 14:00:14 INFO - 'HOME': '/home/cltbld', 14:00:14 INFO - 'JSGC_DISABLE_POISONING': '1', 14:00:14 INFO - 'LANG': 'en_US.UTF-8', 14:00:14 INFO - 'LANGUAGE': 'en_US:en', 14:00:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:00:14 INFO - 'LOGNAME': 'cltbld', 14:00:14 INFO - 'MAIL': '/var/mail/cltbld', 14:00:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:00:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:00:14 INFO - 'MOZ_CRASHREPORTER': '1', 14:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:00:14 INFO - 'MOZ_NO_REMOTE': '1', 14:00:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:14 INFO - 'NO_EM_RESTART': '1', 14:00:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:14 INFO - 'PWD': '/builds/slave/test', 14:00:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:00:14 INFO - 'RUST_BACKTRACE': 'full', 14:00:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:00:14 INFO - 'SHELL': '/bin/bash', 14:00:14 INFO - 'SHLVL': '1', 14:00:14 INFO - 'TERM': 'linux', 14:00:14 INFO - 'TMOUT': '86400', 14:00:14 INFO - 'USER': 'cltbld', 14:00:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410', 14:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:14 INFO - '_': '/tools/buildbot/bin/python'} 14:00:14 INFO - TEST-INFO | started process 3016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn7yNjD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:00:14 INFO - PID 3016 | 14:00:14 INFO - PID 3016 | (/builds/slave/test/build/application/firefox/firefox:3118): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:00:14 INFO - PID 3016 | 14:00:25 INFO - PID 3016 | RSS: Main: 143437824 14:00:25 INFO - PID 3016 | 14:00:27 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43899/tests/kraken/driver.html?testName=audio-beat-detection) 14:00:28 INFO - PID 3016 | RSS: Main: 150396928 14:00:28 INFO - PID 3016 | 14:00:31 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43899/tests/kraken/driver.html?testName=audio-dft) 14:00:31 INFO - PID 3016 | RSS: Main: 150831104 14:00:31 INFO - PID 3016 | 14:00:34 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43899/tests/kraken/driver.html?testName=audio-fft) 14:00:35 INFO - PID 3016 | RSS: Main: 152002560 14:00:35 INFO - PID 3016 | 14:00:37 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43899/tests/kraken/driver.html?testName=audio-oscillator) 14:00:37 INFO - PID 3016 | RSS: Main: 152092672 14:00:37 INFO - PID 3016 | 14:00:39 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43899/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:00:40 INFO - PID 3016 | RSS: Main: 152264704 14:00:40 INFO - PID 3016 | 14:00:43 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43899/tests/kraken/driver.html?testName=imaging-darkroom) 14:00:44 INFO - PID 3016 | RSS: Main: 152326144 14:00:44 INFO - PID 3016 | 14:00:47 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43899/tests/kraken/driver.html?testName=imaging-desaturate) 14:00:48 INFO - PID 3016 | RSS: Main: 154918912 14:00:48 INFO - PID 3016 | 14:00:51 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43899/tests/kraken/driver.html?testName=json-parse-financial) 14:00:51 INFO - PID 3016 | RSS: Main: 155684864 14:00:51 INFO - PID 3016 | 14:00:53 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43899/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:00:53 INFO - PID 3016 | RSS: Main: 155697152 14:00:53 INFO - PID 3016 | 14:00:55 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43899/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:00:55 INFO - PID 3016 | RSS: Main: 155484160 14:00:55 INFO - PID 3016 | 14:00:57 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43899/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:00:58 INFO - PID 3016 | RSS: Main: 152301568 14:00:58 INFO - PID 3016 | 14:01:00 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:01:01 INFO - PID 3016 | RSS: Main: 152592384 14:01:01 INFO - PID 3016 | 14:01:04 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:01:04 INFO - PID 3016 | RSS: Main: 153018368 14:01:04 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | Cycle 1(1): loaded http://localhost:43899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43899/tests/kraken/driver.html?testName=ai-astar) 14:01:06 INFO - PID 3016 | RSS: Main: 154644480 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | __start_tp_report 14:01:06 INFO - PID 3016 | _x_x_mozilla_page_load 14:01:06 INFO - PID 3016 | _x_x_mozilla_page_load_details 14:01:06 INFO - PID 3016 | |i|pagename|runs| 14:01:06 INFO - PID 3016 | |0;ai-astar;116;105;106;107;105;106;106;105;104;105 14:01:06 INFO - PID 3016 | |1;audio-beat-detection;111;109;111;110;113;111;110;111;111;139 14:01:06 INFO - PID 3016 | |2;audio-dft;164;162;162;163;164;163;163;162;163;163 14:01:06 INFO - PID 3016 | |3;audio-fft;72;73;73;77;74;73;74;73;73;72 14:01:06 INFO - PID 3016 | |4;audio-oscillator;79;78;78;76;77;77;78;77;77;76 14:01:06 INFO - PID 3016 | |5;imaging-gaussian-blur;113;113;113;116;116;114;117;118;117;115 14:01:06 INFO - PID 3016 | |6;imaging-darkroom;148;149;148;148;147;148;148;148;148;148 14:01:06 INFO - PID 3016 | |7;imaging-desaturate;100;94;95;94;94;96;95;95;95;95 14:01:06 INFO - PID 3016 | |8;json-parse-financial;44;43;44;46;46;46;53;43;44;43 14:01:06 INFO - PID 3016 | |9;json-stringify-tinderbox;38;37;37;38;38;38;38;38;38;38 14:01:06 INFO - PID 3016 | |10;stanford-crypto-aes;70;78;76;73;76;70;73;72;70;71 14:01:06 INFO - PID 3016 | |11;stanford-crypto-ccm;102;104;105;102;110;103;114;108;105;107 14:01:06 INFO - PID 3016 | |12;stanford-crypto-pbkdf2;153;152;148;149;153;156;154;148;162;152 14:01:06 INFO - PID 3016 | |13;stanford-crypto-sha256-iterative;61;61;56;57;58;58;58;62;57;58 14:01:06 INFO - PID 3016 | __end_tp_report 14:01:06 INFO - PID 3016 | __start_cc_report 14:01:06 INFO - PID 3016 | _x_x_mozilla_cycle_collect,676 14:01:06 INFO - PID 3016 | __end_cc_report 14:01:06 INFO - PID 3016 | __startTimestamp1507064466758__endTimestamp 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | ------- Summary: start ------- 14:01:06 INFO - PID 3016 | Number of tests: 14 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#0] ai-astar Cycles:10 Average:106.50 Median:106.00 stddev:3.44 (3.2%) stddev-sans-first:0.88 14:01:06 INFO - PID 3016 | Values: 116.0 105.0 106.0 107.0 105.0 106.0 106.0 105.0 104.0 105.0 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#1] audio-beat-detection Cycles:10 Average:113.60 Median:111.00 stddev:8.98 (8.1%) stddev-sans-first:9.48 14:01:06 INFO - PID 3016 | Values: 111.0 109.0 111.0 110.0 113.0 111.0 110.0 111.0 111.0 139.0 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 14:01:06 INFO - PID 3016 | Values: 164.0 162.0 162.0 163.0 164.0 163.0 163.0 162.0 163.0 163.0 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.00 stddev:1.43 (2.0%) stddev-sans-first:1.42 14:01:06 INFO - PID 3016 | Values: 72.0 73.0 73.0 77.0 74.0 73.0 74.0 73.0 73.0 72.0 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:77.50 stddev:0.95 (1.2%) stddev-sans-first:0.78 14:01:06 INFO - PID 3016 | Values: 79.0 78.0 78.0 76.0 77.0 77.0 78.0 77.0 77.0 76.0 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:116.00 stddev:1.87 (1.6%) stddev-sans-first:1.81 14:01:06 INFO - PID 3016 | Values: 113.0 113.0 113.0 116.0 116.0 114.0 117.0 118.0 117.0 115.0 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 14:01:06 INFO - PID 3016 | Values: 148.0 149.0 148.0 148.0 147.0 148.0 148.0 148.0 148.0 148.0 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.77 (1.9%) stddev-sans-first:0.67 14:01:06 INFO - PID 3016 | Values: 100.0 94.0 95.0 94.0 94.0 96.0 95.0 95.0 95.0 95.0 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#8] json-parse-financial Cycles:10 Average:45.20 Median:45.00 stddev:3.01 (6.7%) stddev-sans-first:3.16 14:01:06 INFO - PID 3016 | Values: 44.0 43.0 44.0 46.0 46.0 46.0 53.0 43.0 44.0 43.0 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 14:01:06 INFO - PID 3016 | Values: 38.0 37.0 37.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:2.88 (4.0%) stddev-sans-first:2.86 14:01:06 INFO - PID 3016 | Values: 70.0 78.0 76.0 73.0 76.0 70.0 73.0 72.0 70.0 71.0 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#11] stanford-crypto-ccm Cycles:10 Average:106.00 Median:106.00 stddev:3.83 (3.6%) stddev-sans-first:3.78 14:01:06 INFO - PID 3016 | Values: 102.0 104.0 105.0 102.0 110.0 103.0 114.0 108.0 105.0 107.0 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.70 Median:153.00 stddev:4.19 (2.7%) stddev-sans-first:4.44 14:01:06 INFO - PID 3016 | Values: 153.0 152.0 148.0 149.0 153.0 156.0 154.0 148.0 162.0 152.0 14:01:06 INFO - PID 3016 | 14:01:06 INFO - PID 3016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.60 Median:58.00 stddev:2.01 (3.5%) stddev-sans-first:1.94 14:01:06 INFO - PID 3016 | Values: 61.0 61.0 56.0 57.0 58.0 58.0 58.0 62.0 57.0 58.0 14:01:06 INFO - PID 3016 | -------- Summary: end -------- 14:01:06 INFO - PID 3016 | 14:01:07 INFO - PID 3016 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:01:07 INFO - TEST-INFO | 3016: exit 0 14:01:07 INFO - TEST-OK | kraken | took 57852ms 14:01:07 INFO - SUITE-END | took 1164s 14:01:07 INFO - Completed test suite (00:19:24) 14:01:07 INFO - javascript benchmark 14:01:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9541.835200157382, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3998.1204135090275, 3999.3401088820337, 4019.8191081401333, 4045.979770101149, 4072.7556346619203, 6391.360863913612, 6410.839729006777, 6438.645874476902, 6481.3842684944975, 6498.675066246692, 6436.420722135007, 6476.352364763521, 6512.218533775942, 6527.477801775858, 6565.704543295551, 5748.568857335696, 5795.4784069433745, 5874.295084589855, 5923.674197919113, 5949.762009519614, 5843.8539036524, 5881.8823623527505, 5883.117532370136, 5918.082697181943, 5997.0, 5894.793682221123, 5970.432808883171, 6008.399160084, 6016.0, 6031.306399764039, 5943.732532036069, 5951.821445356603, 5955.04719244923, 5981.551383646244, 6028.457438830483, 5742.023855944458, 5827.475527202572, 5863.882722345572, 5880.235569375954, 5926.111083337534, 6429.903551446732, 6437.130987316699, 6472.6763661817195, 6483.773067942647, 6510.869782604322, 7059.364657180827, 7128.6079265640365, 7144.999700041998, 7150.213476517579, 7166.3908567771805, 7122.430205583592, 7128.92871071293, 7158.391536719385, 7225.855482890365, 7241.855162896765, 6473.935260647428, 6536.182977127859, 6584.934150658528, 6629.668516574152, 6647.501437392167, 7207.819804504929, 7296.6716497757725, 7310.195878453366, 7351.786955152447, 7358.742444014434, 6991.825204369829, 6994.860102797916, 7026.981087742249, 7050.5546362995465, 7055.89416158758, 7029.261927497641, 7040.577565345993, 7063.081799366152, 7120.92879071213, 7131.072960515204, 7036.6129862857015, 7106.289371062956, 7114.039604653409, 7127.5010749248095, 7139.393151582174, 7026.191987921352, 7030.964845175844, 7036.437085033185, 7116.964415177891, 7119.964400177966, 5251.133562962144, 5264.6051546134195, 5320.14877619579, 5343.091674415358, 5351.384590772033, 4804.903901921942, 4825.710457372569, 4856.562909338177, 4908.435529914034, 4975.104481193348, 6739.359760822714, 6754.324567543206, 6802.65986700663, 6806.931930680729, 6809.489288303397, 7125.786226413215, 7127.2516385778745, 7135.89296160558, 7217.2421895701245, 7223.349898509159, 6569.83575410609, 6693.364130407604, 6695.263521012685, 6702.966485167641, 6705.061291419205, 5965.403459654087, 6019.879602407927, 6032.788852390146, 6070.484008859208, 6092.3603021682975, 7256.104848026166, 7340.522866013692, 7414.555126692416, 7449.0, 7454.180040195574, 6948.33990770876, 7032.472564557576, 7058.929410705828, 7064.470164737768, 7091.751788687475, 7312.630680712426, 7400.481966262525, 7425.071866016748, 7427.962860185665, 7437.405007599487, 6926.272741362084, 7038.8944165838575, 7061.788146355618, 7113.57318560888, 7128.0, 7085.964570177116, 7116.323949224816, 7125.073740413713, 7159.391451726453, 7204.71181152748, 6724.4284235840505, 6880.9655951721925, 6881.41507971828, 6969.059177011241, 6981.755638552626, 6787.728490860311, 6813.591184528944, 6821.0, 6824.942133969243, 6826.41975432074, 6801.829954251183, 6814.250432452525, 6821.079154314302, 6832.521723479309, 6841.486888483483, 6860.2453730088655, 6918.965405172942, 6937.445004399737, 7005.509614326948, 7014.088168538057, 6715.127033485811, 6717.932820671731, 6808.38724514796, 6817.2501024888215, 6817.659117044029], "value": 6512.825286861895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1004.5228516454683, 1013.1641395848427, 1025.0262250861683, 1026.153423425674, 1037.2531777120475, 46687.533124668786, 47377.76311118448, 47405.762971185184, 47483.287750683725, 47573.0, 43791.12417751651, 44113.338299925446, 44116.0, 44148.55851441484, 44229.336559951545, 8074.111847696749, 8193.0, 8201.0, 8257.752267431986, 8273.627686754111, 7970.561619110947, 8005.039395272575, 8064.435489515737, 8132.349412047051, 8149.918500815005, 8797.29621630268, 8969.282457403424, 8971.95514022429, 8974.551272436385, 8975.102489751005, 8854.07032261613, 8870.778230544223, 8879.911200888006, 8920.821583568357, 8926.553672316422, 8724.43291186071, 8825.338099642488, 8830.735077947671, 8831.735047948572, 8833.160849719266, 43130.35304470435, 43371.34942975858, 43434.34848477275, 43499.34750978738, 43611.78194109041, 3769.038895081764, 3785.6403641653997, 3788.5643151037707, 3791.639794219545, 3793.089658481972, 34299.65700342989, 34488.82755586231, 34539.481907771406, 34546.82726586376, 34610.65389346125, 5509.834704958857, 5653.462921022538, 5686.2607860977805, 5703.828885133453, 5705.172749951275, 237517.0, 239618.0, 239729.0, 240229.0, 240899.0, 48870.75564622154, 49289.75355123202, 57392.71303643455, 58236.08819559005, 58323.70838145782, 60063.099053514234, 60308.0, 60810.0, 60974.0, 61017.38982610117, 18004.459866204033, 18010.36963706264, 18137.546561336072, 18137.637247255247, 18182.5454363642, 14920.552383428514, 14928.178950157846, 14935.775963360558, 14943.551693449213, 14953.850461495464, 16110.275037623334, 16159.596010099842, 16208.918955405148, 16209.83790162107, 16320.591985200228, 6252.406021427957, 6267.749290028439, 6306.369363063657, 6345.904811427832, 6389.137466442064, 1103.586155191803, 1111.9833202501968, 1114.0, 1130.6325444230658, 1136.8408422820812, 25411.364715881882, 25771.87114064455, 25958.09146679857, 26157.346066348495, 26177.34556636061, 1187.6852634051984, 1230.0774419185611, 1236.0358920042381, 1247.1332423965257, 1247.326443720381, 13820.792688109686, 13887.0, 13933.372998215105, 14035.298235088205, 14149.0, 307259.0, 320596.0, 320966.0, 322703.0, 325996.0, 67714.0, 67828.6608566954, 68625.31374686288, 68725.31274687289, 68729.0, 1559.469780274712, 1585.9524214273822, 1590.3320605345782, 1591.4986779164526, 1616.9514914552583, 32625.34749305048, 32641.673583264812, 33097.338053239284, 33126.503102453964, 33350.666493335724, 46519.767401162775, 46783.362582309455, 46800.7659961698, 46869.2969605463, 46899.062018760116, 270117.0, 271266.0, 272804.0, 273089.0, 273156.0, 41242.58757412388, 41693.58306416897, 41860.95347616334, 42032.36951445792, 42150.578494214664, 49717.0, 52026.21960670517, 52153.217701735266, 53185.734071329396, 53301.73349133229, 36651.45022824607, 36659.45010824787, 36951.44572831463, 37155.25689486141, 37633.2473350537, 36900.446493302086, 37236.44145337768, 37322.44016339703, 37817.432738508396, 38090.80954595209, 43536.56463435325, 44896.55103449054, 45056.77471612621, 45094.09811803811, 45501.0, 36395.81802091079, 36410.45384319184, 36941.63058369382, 37057.25885482329, 37432.0, 27384.0, 27388.0, 27481.31296717598, 27611.30971725723, 27864.582031269143], "value": 20001.327693062736, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.6837576084677, 619.5291578400414, 621.779268359732, 630.3444417805482, 650.9576877502964, 24621.384465388353, 24874.378140546494, 25513.999999999978, 25556.48887022261, 25635.102771403006, 26505.602415963775, 27764.444711105818, 27764.722352776465, 27771.0, 27784.166475005783, 6775.59346439214, 6960.895586566206, 6964.616946067964, 7005.964970175168, 7016.298370162994, 6668.066470694107, 6911.550749201311, 6926.099607051076, 6933.583984960893, 6940.340667636567, 6888.242293347727, 6888.793336199922, 6900.551464154814, 6900.930990690079, 6902.861942761142, 6797.762078327235, 6803.761868334634, 6833.111695479581, 6876.381125698686, 6888.690008949584, 6397.200349956255, 6405.0, 6415.877221486268, 6426.0, 6429.646369449679, 29773.702262977527, 30365.544516832266, 31571.684283157334, 31774.841125794224, 31898.0, 2334.3813889319345, 2358.5400846834873, 2368.538135063663, 2371.6442533619925, 2377.191754803358, 19904.402867913985, 20264.189432422685, 20469.18123275067, 20477.4880627984, 20567.38297851067, 2538.4796116796015, 2582.2253324002913, 2638.287662331179, 2644.1935209761014, 2654.2037388783483, 147751.0, 152756.0, 156963.0, 162898.18550907288, 176493.0, 16591.917040414963, 16706.58233544171, 16732.916335418246, 17086.743698844526, 17465.912670436566, 27553.724462755516, 27603.86198069037, 27628.099049599503, 27734.3066423337, 27764.0, 11350.829737553944, 11414.0, 11442.885571144181, 11474.139439542068, 11541.07671386287, 10506.894931050745, 10530.684079477627, 10531.0, 10569.735756606146, 10655.094316982988, 9884.159846412991, 9951.850722239173, 10301.433421161908, 10347.172226221885, 10504.474776261157, 3079.8306093164642, 3096.148559146253, 3129.6713845046397, 3131.968680313213, 3199.7600179986594, 1051.7370657335666, 1079.6221322537049, 1089.8964598363143, 1095.0965453500894, 1099.7085772270354, 22033.33899983003, 22280.777192228194, 22455.55088898213, 22554.097836086374, 22784.0, 1141.275290190735, 1166.7724793665323, 1170.268582136165, 1177.8881006304387, 1180.3508070561156, 11915.344656043828, 12265.202761820454, 12284.0, 12355.196912200678, 12412.0, 648999.0, 651101.0, 651177.0, 659023.0, 663746.0, 123735.0, 128063.0, 128890.0, 130987.0, 134328.32835835757, 1149.2989276541302, 1208.5347141350467, 1295.5854126679371, 1297.6561211279018, 1332.4603535567917, 22389.44026399353, 22866.31401057971, 22941.426464338525, 23047.539049218587, 23153.88423057874, 65816.34183658102, 66952.0, 67114.66442667755, 67189.0, 67395.3260467389, 87561.56219218863, 88088.5595572018, 88362.0, 88540.0, 88735.55632221798, 16071.839281607034, 16211.189440528162, 16297.67404651924, 16490.505284841474, 16525.91737041307, 24772.0, 24833.130840420497, 24923.50152996966, 24990.75009249957, 25086.37284067913, 19039.90480047591, 19385.4184374469, 19465.318713844947, 19577.0, 19698.90150549238, 17552.648947021244, 17607.823921760617, 17782.822171778116, 17956.461306160312, 18083.09584520795, 19786.60426791485, 20046.89976550108, 20071.59856802885, 20206.59586808285, 20241.6963745541, 16023.958442701187, 16216.0, 16254.268557914686, 16267.0, 16379.344826207294, 19468.415947521597, 19499.61000780005, 19641.508962275486, 20087.39737807868, 20261.189552417738], "value": 13337.888530038968, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.2829913342462, 1571.6385231396782, 1578.9657774157924, 1582.106110047823, 1583.5882670505664, 17408.65182696347, 18155.183016764244, 18234.179461924214, 18241.635167296663, 18260.817391826076, 17829.286828526845, 17906.0, 17949.0, 17952.281908723635, 17966.730499042493, 3058.143719758471, 3085.0, 3143.9685603143903, 3145.5281707743793, 3146.669599692034, 3042.7261546460813, 3075.2773098321877, 3108.1607965849207, 3120.032789835147, 3126.796758210709, 3103.937921241574, 3180.3480286541203, 3186.283086305574, 3189.776715629907, 3201.6158061032706, 3125.7968232064954, 3135.3885992231526, 3151.3854798314337, 3158.115727596277, 3160.2573395252098, 3017.9245518861985, 3037.4228896509812, 3045.5431685247167, 3056.4651186042574, 3062.0813755873373, 17300.22149003298, 17769.0, 17771.466855994342, 17778.644427111514, 17779.73330400045, 8991.325650576233, 9272.629094836198, 9274.30442716799, 9286.674966376211, 9288.767780805467, 5767.4520920512905, 5820.912686309709, 5861.912071318934, 5946.7323970421, 6034.306054803666, 2137.657974724052, 2187.156252928778, 2192.35325578953, 2226.298715904485, 2228.19784877444, 32856.178595535304, 32978.505322420184, 33092.6690733092, 33132.0, 33143.17142071443, 7481.326680598772, 7553.7356192533, 7579.696812127453, 7830.686772529149, 7831.608419578998, 20460.590788184152, 20547.897260513902, 20551.4862128448, 20571.58856822855, 20592.0, 8847.73456796297, 8859.202671759573, 8997.685081022133, 9002.099790021077, 9055.411398259092, 8112.756617301372, 8150.3479721622125, 8309.709160179365, 8332.916670833336, 8383.580820958927, 5927.940720592739, 5961.5826892118, 6005.369436209223, 6029.939700602938, 6051.848703782441, 1582.0, 1626.6502701919144, 1749.6763098826757, 1766.7703198584102, 1792.6683563540787, 1019.3578045831078, 1046.2885238038054, 1049.7060822969581, 1058.8252938265255, 1070.710908054821, 10250.948745256226, 10349.430781307101, 10358.223133265035, 10447.320924139907, 10511.211659125596, 1125.9042981346513, 1131.5643477261315, 1131.8358837968449, 1134.28540019787, 1145.4673576786834, 5741.851629674082, 5772.711364431846, 5785.1322301654245, 6478.481721462272, 6542.0, 26451.338716531856, 26788.464230715665, 26852.731472685413, 27265.182044538695, 27268.727312727016, 25148.11981580636, 26009.21972340833, 26165.869170654027, 26268.21195364142, 26479.86760066226, 12864.163829351062, 13130.671733206746, 13254.337283135805, 13254.734905302033, 13376.46494140243, 9503.049695030442, 9512.667056652985, 9534.141927226583, 9549.0, 9731.41611503312, 22221.444463888532, 22352.552948941255, 22374.664380033988, 23005.0, 23344.6498302529, 23433.648495272926, 23519.75402617982, 23584.17455389053, 23696.28911132669, 23835.64246536338, 13234.205947643171, 13236.669083272995, 13350.599482015556, 13355.332233388486, 13382.531611393944, 16325.918370408071, 16376.181190940644, 16407.42574009904, 16438.917805410896, 16469.423570174986, 11360.488778004845, 13501.662458438617, 13623.0, 13703.862961370258, 13708.0, 12276.754464910831, 12321.322327271728, 12356.320402377956, 12523.874761252271, 12625.684357891127, 11402.82895756581, 11413.31520108763, 11475.024622907147, 11526.366049867338, 11575.768484630093, 8344.41589088758, 8459.61931713062, 8503.319734421355, 8621.137886211329, 8660.696875609323, 8961.193492585699, 8968.596413161555, 8998.415103018282, 9001.95499022527, 9013.459192448474], "value": 7808.825808467175, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.6586082489681, 579.7304253522111, 581.1167026120296, 604.320139842677, 615.5106690181307, 6346.714397852096, 6401.839954001152, 6459.677016149197, 6498.6100833949995, 6527.706253218605, 6336.239651241846, 6409.173385585109, 6439.195100612424, 6455.774047908324, 6458.903116453245, 5292.206169074631, 5317.867053323669, 5328.120860058086, 5347.144456886899, 5351.0, 4989.675671081386, 5291.8093428978555, 5325.281087053257, 5333.38666053403, 5376.973115134419, 5149.665271757323, 5158.787684894047, 5163.896722065557, 5177.223416487538, 5179.585633149339, 5127.717975511346, 5144.099782538041, 5156.071907056728, 5171.2501687255135, 5171.663841850268, 4699.7415142167165, 4701.294805779126, 4706.199946009152, 4706.811727530895, 4713.787879545429, 6337.0, 6343.904841427382, 6350.936490635081, 6397.712102955332, 6420.917959379524, 5964.552658550626, 6066.908996365058, 6073.301570319426, 6091.208142941389, 6106.053561697944, 6685.231198412148, 6690.83272918176, 6758.966205168943, 6773.342395106636, 6802.693878775467, 4952.455229924705, 5125.589952803767, 5171.81898633546, 5187.910538786859, 5208.322918020633, 6869.484788640872, 6985.301469852974, 7003.894941575881, 7015.473839462061, 7099.396551293146, 5287.550558202596, 5312.681239125587, 5357.223202635674, 5360.195970604441, 5378.159656309274, 5384.892302154013, 5405.351357837085, 5408.8377348679605, 5419.3225846769155, 5436.6737995719595, 5989.131575921554, 5998.850028749316, 5999.700014999233, 6018.939810601838, 6021.397860214031, 6814.591124532544, 6824.965875170592, 6830.53143574124, 6839.521233513706, 6847.452203823682, 1845.2434501854175, 1858.2566973210824, 1878.64305781901, 1886.226647074693, 1897.724829899657, 1295.1257900917033, 1330.9866901331056, 1333.3333333333333, 1346.6566025663394, 1356.3421740455872, 6398.2641996170105, 6429.58207716497, 6434.0, 6470.547061705635, 6502.674866256668, 6763.560368576125, 6776.7628133015105, 6780.559263647847, 6808.242661722011, 6824.590524568542, 6353.30113687494, 6363.204599425072, 6368.968155159195, 6385.936140638627, 6440.323766004596, 3514.525539052195, 3617.2403795203304, 3618.5295911531334, 3639.6724294813594, 3652.141746689526, 7184.389326907167, 7201.3158749918675, 7218.783436496913, 7240.637968101574, 7252.274772522811, 6939.258992697856, 6963.7562685305775, 6983.685734141975, 6993.790186294419, 7057.294270572902, 7094.871538538418, 7130.0, 7175.138983322035, 7230.602316872517, 7287.307705767944, 6827.965860170667, 6852.657367131723, 6853.211880633791, 6870.484713646397, 6873.731668549467, 6728.293529179366, 6767.35710107539, 6798.150231221098, 6836.889215407077, 6853.17761868579, 7016.894746578703, 7126.572405655677, 7174.067371241706, 7178.0, 7215.278472152742, 5339.679619222859, 5343.305370301836, 5349.893002140013, 5354.571634269327, 5358.97320513395, 6699.631520266237, 6830.692618832264, 6845.178578570603, 6930.826729331807, 6933.4106600939485, 6538.901916471162, 6721.596704197764, 6732.3267673232285, 6752.561083529555, 6766.763163289262, 6681.432078273401, 6715.630640314829, 6726.260111387645, 6741.764038258638, 6779.322067793379, 6633.800985970429, 6652.567583107082, 6677.232118306457, 6678.465722742266, 6698.531102822755, 6796.66016699173, 6806.897896531457, 6816.897746533905, 6835.658217089225, 6861.113193871725, 6435.356464353715, 6600.207975043026, 6628.436582890508, 6635.236947750877, 6686.866262674622], "value": 5327.342268928404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [977.1645243316968, 1007.0835539658912, 1009.429672235187, 1026.4611079183428, 1045.9958439897698, 20384.69422958655, 20768.584628307442, 20843.583128337425, 20866.791332086676, 20936.581268374623, 22225.777742222574, 24224.515509689794, 24241.39396515088, 24253.151139710113, 24384.268471945827, 1075.9731006724817, 1097.1058587251364, 1097.9451027448595, 1101.3887292552631, 1102.7298311913553, 1061.6284300494842, 1104.9558017679283, 1105.2208193223757, 1112.4660163121707, 1114.186643750063, 1196.9222000569978, 1201.1351826684818, 1205.6624145239348, 1206.2400687566821, 1206.8551773787115, 1183.7395772929942, 1198.6164427383242, 1204.9518019279262, 1207.1429285207425, 1207.7886369885234, 882.9735107946772, 883.024258194692, 883.1301168349171, 883.7702197428715, 884.752269364579, 20651.793482065288, 20733.481662958395, 21098.5780284395, 21101.5779684407, 21637.67543486833, 21963.23128690504, 22396.216132435286, 22403.775962240332, 22426.55146897053, 22691.0, 17771.289148434047, 18167.391911852654, 18195.181216845274, 18313.816861831478, 18351.35770248035, 3916.060145565072, 4010.197960407901, 4041.1109555897656, 4041.717079804415, 4050.2507036198103, 169688.0, 173469.0, 174045.0, 174123.0, 177048.0, 16832.57918552046, 16907.070111144007, 17161.914190428968, 17170.742438863428, 17210.91394543019, 35282.82358588191, 37294.0, 37463.25073498515, 37471.25057498835, 37498.62501375006, 8445.66217351299, 8543.829123417498, 8552.786180345542, 8624.396292259482, 8676.219140277279, 4072.165206132736, 4176.749395036308, 4233.04756429807, 4236.512801027921, 4239.59723826236, 5383.515483606494, 7043.260457651975, 7136.785896423115, 7150.499465037397, 7161.104861892263, 1285.7235694325766, 1301.9153755005893, 1326.7877139657608, 1334.0794851552398, 1334.3861823561272, 750.1485813601493, 777.6733771815851, 782.772995831214, 792.180093603118, 792.7146227358146, 14062.437502499786, 14219.85780142206, 14820.703585928437, 15406.691866162839, 15504.689906201813, 770.6724642027116, 771.2595907928452, 781.4959351218432, 783.9529628222325, 795.4352409789115, 6649.135612370361, 6752.155980502437, 6768.0, 6816.7614133505085, 6910.2053263874295, 153626.23186884218, 153979.0, 156390.0, 156485.0, 159326.20336898242, 138462.30768846293, 139463.0, 141308.0, 142655.0, 145491.0, 120962.0, 122592.0, 124435.0, 125658.99999999817, 130141.34929325293, 12431.31627760482, 12529.122961392615, 12685.06325072809, 12739.936300318439, 12987.842931675703, 61814.69092654508, 62631.37368626438, 62820.371796281455, 63874.0, 63878.36121638724, 76542.61728691321, 76952.61523692346, 77351.0, 79462.60268698851, 80292.59853700694, 17986.91006544959, 18772.906135469235, 19074.80925190786, 19162.137703803084, 19191.90404047971, 20705.378838634864, 20954.161833527098, 21102.47243818917, 21122.0, 21137.365879023655, 17441.30234790594, 17708.91145544264, 18041.278348866424, 18052.097395129927, 18065.458036258933, 18060.187291572172, 18187.45437636873, 18210.089495524906, 18255.178516967033, 18386.356477523223, 17857.196426160594, 18068.457946261635, 18237.81762182361, 18265.726014109532, 18306.0, 14062.226577538333, 14304.141751494944, 14614.561563153122, 14662.0, 14713.504606396353, 14003.649908752363, 14291.071080379743, 14317.355718992461, 14345.067570607876, 14356.641083972985], "value": 10441.26702248987, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1365.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 105.0, 106.0, 107.0, 105.0, 106.0, 106.0, 105.0, 104.0, 105.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 111.0, 110.0, 113.0, 111.0, 110.0, 111.0, 111.0, 139.0], "value": 113.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 163.0, 164.0, 163.0, 163.0, 162.0, 163.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 77.0, 74.0, 73.0, 74.0, 73.0, 73.0, 72.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 76.0, 77.0, 77.0, 78.0, 77.0, 77.0, 76.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 116.0, 116.0, 114.0, 117.0, 118.0, 117.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 95.0, 94.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 44.0, 46.0, 46.0, 46.0, 53.0, 43.0, 44.0, 43.0], "value": 45.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 37.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 76.0, 73.0, 76.0, 70.0, 73.0, 72.0, 70.0, 71.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 104.0, 105.0, 102.0, 110.0, 103.0, 114.0, 108.0, 105.0, 107.0], "value": 106.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 148.0, 149.0, 153.0, 156.0, 154.0, 148.0, 162.0, 152.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 56.0, 57.0, 58.0, 58.0, 58.0, 62.0, 57.0, 58.0], "value": 58.6, "unit": "score"}]}]} 14:01:07 INFO - Return code: 0 14:01:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:01:07 INFO - # TBPL SUCCESS # 14:01:07 INFO - Running post-action listener: _package_coverage_data 14:01:07 INFO - Running post-action listener: _resource_record_post_action 14:01:07 INFO - [mozharness: 2017-10-03 21:01:07.581711Z] Finished run-tests step (success) 14:01:07 INFO - Running post-run listener: _resource_record_post_run 14:01:07 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 646123520; Read time: 20; Write time: 491904 14:01:07 INFO - TinderboxPrint: CPU usage
13.1% 14:01:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 14:01:07 INFO - TinderboxPrint: I/O write bytes / time
646,123,520 / 491,904 14:01:07 INFO - TinderboxPrint: CPU idle
8,177.2 (86.9%) 14:01:07 INFO - TinderboxPrint: CPU user
1,181.0 (12.6%) 14:01:07 INFO - TinderboxPrint: Swap in / out
0 / 0 14:01:07 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 374083584; Read time: 0; Write time: 342404 14:01:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:01:07 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 0; Write bytes: 271347712; Read time: 0; Write time: 144188 14:01:08 INFO - Running post-run listener: _upload_blobber_files 14:01:08 INFO - Blob upload gear active. 14:01:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:01:08 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 14:01:08 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'] 14:01:08 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 14:01:08 INFO - (blobuploader) - INFO - Open directory for files ... 14:01:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:01:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:01:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:01:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:01:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:01:09 INFO - (blobuploader) - INFO - Done attempting. 14:01:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:01:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:01:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:01:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:01:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:01:16 INFO - (blobuploader) - INFO - Done attempting. 14:01:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:01:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:01:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:01:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:01:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:01:17 INFO - (blobuploader) - INFO - Done attempting. 14:01:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:01:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:01:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:01:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:01:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:01:18 INFO - (blobuploader) - INFO - Done attempting. 14:01:18 INFO - (blobuploader) - INFO - Iteration through files over. 14:01:18 INFO - Return code: 0 14:01:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:01:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:01:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e405d52ae7dd1a97b029c75fab709774b5fe2f725e3d671685d47799d3b629822ecfbaa35cb181625ff598177a8b7065a9e3b46c60dbefd09b6032ca12bbde46", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7ae5d34cb143fb768232bf12bc7fe7daeeb9145e3dfa9e349db34069b6c75db7cf558a39ed38955d8ed0a018ab7372fdec8be8e5d8c3371f98d067882ed364da", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea966b0ad70e42f904535dcbdca720fdf997bf52dc1f1a059b83f41cfc128f51073a52f65e42447f556def4f32ced1305560ef5549542aa61412983d62b930df", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/34c3b965e5d197cf0d8193ddb963983b2321f430e312bb924cb18146c94540315d22de464a30abf22e17a6eec379f7862f166a6647a306271808a8333191bb37"} 14:01:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:01:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:01:18 INFO - Contents: 14:01:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e405d52ae7dd1a97b029c75fab709774b5fe2f725e3d671685d47799d3b629822ecfbaa35cb181625ff598177a8b7065a9e3b46c60dbefd09b6032ca12bbde46", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7ae5d34cb143fb768232bf12bc7fe7daeeb9145e3dfa9e349db34069b6c75db7cf558a39ed38955d8ed0a018ab7372fdec8be8e5d8c3371f98d067882ed364da", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea966b0ad70e42f904535dcbdca720fdf997bf52dc1f1a059b83f41cfc128f51073a52f65e42447f556def4f32ced1305560ef5549542aa61412983d62b930df", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/34c3b965e5d197cf0d8193ddb963983b2321f430e312bb924cb18146c94540315d22de464a30abf22e17a6eec379f7862f166a6647a306271808a8333191bb37"} 14:01:18 INFO - Running post-run listener: copy_logs_to_upload_dir 14:01:18 INFO - Copying logs to upload dir... 14:01:18 INFO - mkdir: /builds/slave/test/build/upload/logs 14:01:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.718084 ========= master_lag: -0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-10-03 14:01:18.730084) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 14:01:18.737860) ========= 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=3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e405d52ae7dd1a97b029c75fab709774b5fe2f725e3d671685d47799d3b629822ecfbaa35cb181625ff598177a8b7065a9e3b46c60dbefd09b6032ca12bbde46", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7ae5d34cb143fb768232bf12bc7fe7daeeb9145e3dfa9e349db34069b6c75db7cf558a39ed38955d8ed0a018ab7372fdec8be8e5d8c3371f98d067882ed364da", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea966b0ad70e42f904535dcbdca720fdf997bf52dc1f1a059b83f41cfc128f51073a52f65e42447f556def4f32ced1305560ef5549542aa61412983d62b930df", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/34c3b965e5d197cf0d8193ddb963983b2321f430e312bb924cb18146c94540315d22de464a30abf22e17a6eec379f7862f166a6647a306271808a8333191bb37"} build_url:https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/VudcYqprSh-Son9W92vECw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e405d52ae7dd1a97b029c75fab709774b5fe2f725e3d671685d47799d3b629822ecfbaa35cb181625ff598177a8b7065a9e3b46c60dbefd09b6032ca12bbde46", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7ae5d34cb143fb768232bf12bc7fe7daeeb9145e3dfa9e349db34069b6c75db7cf558a39ed38955d8ed0a018ab7372fdec8be8e5d8c3371f98d067882ed364da", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea966b0ad70e42f904535dcbdca720fdf997bf52dc1f1a059b83f41cfc128f51073a52f65e42447f556def4f32ced1305560ef5549542aa61412983d62b930df", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/34c3b965e5d197cf0d8193ddb963983b2321f430e312bb924cb18146c94540315d22de464a30abf22e17a6eec379f7862f166a6647a306271808a8333191bb37"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 14:01:18.772189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 14:01:18.772619) ========= 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=3a3620fb28aea1604ab609ef000001d2-1507062752.658074-545370410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 14:01:18.853422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 14:01:18.853731) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 14:01:18.854050) ========= ========= Total master_lag: -0.00 =========