builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1508891664.15 results: success (0) revision: 598d726067c4fa4718fcc09cdf3e5f6b9b0b6eae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-24 17:34:24.148433) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-24 17:34:24.149176) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-24 17:34:24.149597) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-24 17:34:24.171616) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 17:34:24.172140) ========= 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=62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-24 17:34:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 100M=0s 2017-10-24 17:34:24 (100 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076423 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 17:34:24.272976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 17:34:24.273483) ========= 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=62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023895 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 17:34:24.323602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-24 17:34:24.324015) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 598d726067c4fa4718fcc09cdf3e5f6b9b0b6eae --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 598d726067c4fa4718fcc09cdf3e5f6b9b0b6eae --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=62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-24 17:34:24,392 truncating revision to first 12 chars 2017-10-24 17:34:24,392 Setting DEBUG logging. 2017-10-24 17:34:24,392 attempt 1/10 2017-10-24 17:34:24,392 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/598d726067c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-24 17:34:25,130 unpacking tar archive at: mozilla-beta-598d726067c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.096247 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-24 17:34:25.437772) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-24 17:34:25.438139) ========= script_repo_revision: 598d726067c4fa4718fcc09cdf3e5f6b9b0b6eae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-24 17:34:25.438555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-24 17:34:25.438892) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-24 17:34:25.454303) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-10-24 17:34:25.454707) ========= /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=62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:34:25 INFO - MultiFileLogger online at 20171024 17:34:25 in /builds/slave/test 17:34:25 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 17:34:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:34:25 INFO - {'append_to_log': False, 17:34:25 INFO - 'base_work_dir': '/builds/slave/test', 17:34:25 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 17:34:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:34:25 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 17:34:25 INFO - 'buildbot_json_path': 'buildprops.json', 17:34:25 INFO - 'code_coverage': False, 17:34:25 INFO - 'config_files': ('talos/linux_config.py',), 17:34:25 INFO - 'default_actions': ('clobber', 17:34:25 INFO - 'read-buildbot-config', 17:34:25 INFO - 'download-and-extract', 17:34:25 INFO - 'populate-webroot', 17:34:25 INFO - 'create-virtualenv', 17:34:25 INFO - 'install', 17:34:25 INFO - 'setup-mitmproxy', 17:34:25 INFO - 'run-tests'), 17:34:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:34:25 INFO - 'disable_ccov_upload': False, 17:34:25 INFO - 'disable_stylo': False, 17:34:25 INFO - 'download_minidump_stackwalk': True, 17:34:25 INFO - 'download_symbols': 'ondemand', 17:34:25 INFO - 'enable_stylo': False, 17:34:25 INFO - 'enable_webrender': False, 17:34:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:34:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:34:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:34:25 INFO - 'gecko_profile': False, 17:34:25 INFO - 'gecko_profile_interval': 0, 17:34:25 INFO - 'installer_path': 'installer.exe', 17:34:25 INFO - 'log_level': 'info', 17:34:25 INFO - 'log_name': 'talos', 17:34:25 INFO - 'log_to_console': True, 17:34:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:34:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:34:25 INFO - 'opt_config_files': (), 17:34:25 INFO - 'pip_index': False, 17:34:25 INFO - 'suite': 'dromaeojs-e10s', 17:34:25 INFO - 'system_bits': '32', 17:34:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:34:25 INFO - 'title': 'talos-linux64-ix-018', 17:34:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:34:25 INFO - 'use_talos_json': True, 17:34:25 INFO - 'verify': 'False', 17:34:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:34:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:34:25 INFO - 'work_dir': 'build'} 17:34:25 INFO - [mozharness: 2017-10-25 00:34:25.653386Z] Running clobber step. 17:34:25 INFO - Running pre-action listener: _resource_record_pre_action 17:34:25 INFO - Running main action method: clobber 17:34:25 INFO - rmtree: /builds/slave/test/build 17:34:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:34:26 INFO - Running post-action listener: _resource_record_post_action 17:34:26 INFO - [mozharness: 2017-10-25 00:34:26.801496Z] Finished clobber step (success) 17:34:26 INFO - [mozharness: 2017-10-25 00:34:26.801593Z] Running read-buildbot-config step. 17:34:26 INFO - Running pre-action listener: _resource_record_pre_action 17:34:26 INFO - Running main action method: read_buildbot_config 17:34:26 INFO - Using buildbot properties: 17:34:26 INFO - { 17:34:26 INFO - "project": "", 17:34:26 INFO - "product": "firefox", 17:34:26 INFO - "who": "ryanvm@gmail.com", 17:34:26 INFO - "installer_path": "public/build/target.tar.bz2", 17:34:26 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 17:34:26 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 17:34:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 17:34:26 INFO - "stage_platform": "linux64", 17:34:26 INFO - "basedir": "/builds/slave/test", 17:34:26 INFO - "buildnumber": 41, 17:34:26 INFO - "platform": "ubuntu64_hw", 17:34:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:34:26 INFO - "slavebuilddir": "test", 17:34:26 INFO - "taskId": "QDXptDuBQH2_pdvzJR09kg", 17:34:26 INFO - "branch": "mozilla-beta", 17:34:26 INFO - "script_repo_revision": "production", 17:34:26 INFO - "revision": "598d726067c4fa4718fcc09cdf3e5f6b9b0b6eae", 17:34:26 INFO - "slavename": "talos-linux64-ix-018", 17:34:26 INFO - "repo_path": "releases/mozilla-beta" 17:34:26 INFO - } 17:34:26 INFO - Finding installer, test and symbols from parent task. 17:34:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QDXptDuBQH2_pdvzJR09kg'}, attempt #1 17:34:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QDXptDuBQH2_pdvzJR09kg'}, attempt #1 17:34:27 INFO - Task dependencies: GqEimflOS1iRhfkrfZBhzg 17:34:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg'}, attempt #1 17:34:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.tar.bz2 17:34:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.test_packages.json 17:34:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.crashreporter-symbols.zip 17:34:28 INFO - Running post-action listener: _resource_record_post_action 17:34:28 INFO - [mozharness: 2017-10-25 00:34:28.157497Z] Finished read-buildbot-config step (success) 17:34:28 INFO - [mozharness: 2017-10-25 00:34:28.157716Z] Running download-and-extract step. 17:34:28 INFO - Running pre-action listener: _resource_record_pre_action 17:34:28 INFO - Running main action method: download_and_extract 17:34:28 INFO - mkdir: /builds/slave/test/build/tests 17:34:28 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')]} 17:34:28 INFO - trying https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.test_packages.json 17:34:28 INFO - Downloading https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:34:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:34:28 INFO - Downloaded 989 bytes. 17:34:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:34:28 INFO - Using the following test package requirements: 17:34:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:34:28 INFO - u'common': [u'target.common.tests.zip'], 17:34:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:34:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:34:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:34:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:34:28 INFO - u'mozbase': [u'target.common.tests.zip'], 17:34:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:34:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:34:28 INFO - u'web-platform': [u'target.common.tests.zip', 17:34:28 INFO - u'target.web-platform.tests.tar.gz'], 17:34:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:34:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:34:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.common.tests.zip 17:34:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:34:28 INFO - Fetch https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.common.tests.zip into memory 17:34:29 INFO - Content-Length response header: 55178802 17:34:29 INFO - Bytes received: 55178802 17:34:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.talos.tests.zip 17:34:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:34:40 INFO - Fetch https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.talos.tests.zip into memory 17:34:41 INFO - Content-Length response header: 14509096 17:34:41 INFO - Bytes received: 14509096 17:34:41 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')]} 17:34:41 INFO - trying https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.tar.bz2 17:34:41 INFO - Downloading https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:34:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:34:42 INFO - Downloaded 53580710 bytes. 17:34:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.tar.bz2 17:34:42 INFO - mkdir: /builds/slave/test/properties 17:34:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:34:42 INFO - Writing to file /builds/slave/test/properties/build_url 17:34:42 INFO - Contents: 17:34:42 INFO - build_url:https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.tar.bz2 17:34:42 INFO - Running post-action listener: _resource_record_post_action 17:34:42 INFO - Running post-action listener: find_tests_for_verification 17:34:42 INFO - Running post-action listener: set_extra_try_arguments 17:34:42 INFO - [mozharness: 2017-10-25 00:34:42.765092Z] Finished download-and-extract step (success) 17:34:42 INFO - [mozharness: 2017-10-25 00:34:42.765190Z] Running populate-webroot step. 17:34:42 INFO - Running pre-action listener: _resource_record_pre_action 17:34:42 INFO - Running main action method: populate_webroot 17:34:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:34:42 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:34:42 INFO - 'tests': ['tresize', 17:34:42 INFO - 'tcanvasmark']}, 17:34:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:34:42 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:34:42 INFO - 'tests': ['dromaeo_css', 17:34:42 INFO - 'kraken']}, 17:34:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:42 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'talos_options': ['--disable-stylo'], 17:34:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'tests': ['damp', 'tps']}, 17:34:42 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'talos_options': ['--disable-stylo'], 17:34:42 INFO - 'tests': ['damp', 'tps']}, 17:34:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:34:42 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:34:42 INFO - 'tests': ['dromaeo_dom']}, 17:34:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:34:42 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:34:42 INFO - 'tests': ['basic_compositor_video', 17:34:42 INFO - 'glvideo']}, 17:34:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:34:42 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'talos_options': ['--disable-stylo'], 17:34:42 INFO - 'tests': ['ts_paint_webext', 17:34:42 INFO - 'tp5o_webext']}, 17:34:42 INFO - 'other-e10s': {'tests': ['a11yr', 17:34:42 INFO - 'ts_paint', 17:34:42 INFO - 'tpaint', 17:34:42 INFO - 'sessionrestore', 17:34:42 INFO - 'sessionrestore_many_windows', 17:34:42 INFO - 'sessionrestore_no_auto_restore', 17:34:42 INFO - 'tabpaint']}, 17:34:42 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:34:42 INFO - 'tests': ['a11yr', 17:34:42 INFO - 'ts_paint', 17:34:42 INFO - 'tpaint', 17:34:42 INFO - 'sessionrestore', 17:34:42 INFO - 'sessionrestore_many_windows', 17:34:42 INFO - 'sessionrestore_no_auto_restore', 17:34:42 INFO - 'tabpaint']}, 17:34:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:34:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:34:42 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:34:42 INFO - 'tests': ['perf_reftest_singletons']}, 17:34:42 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:34:42 INFO - 'tests': ['bloom_basic']}, 17:34:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:34:42 INFO - 'tsvgr_opacity', 17:34:42 INFO - 'tart', 17:34:42 INFO - 'tscrollx', 17:34:42 INFO - 'tsvg_static']}, 17:34:42 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:34:42 INFO - 'tests': ['tsvgx', 17:34:42 INFO - 'tsvgr_opacity', 17:34:42 INFO - 'tart', 17:34:42 INFO - 'tscrollx', 17:34:42 INFO - 'tsvg_static']}, 17:34:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:34:42 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'talos_options': ['--disable-stylo'], 17:34:42 INFO - 'tests': ['tp5o']}, 17:34:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:34:42 INFO - 'talos_options': ['--mitmproxy', 17:34:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:34:42 INFO - '--firstNonBlankPaint'], 17:34:42 INFO - 'tests': ['tp6_google', 17:34:42 INFO - 'tp6_youtube', 17:34:42 INFO - 'tp6_amazon', 17:34:42 INFO - 'tp6_facebook']}, 17:34:42 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:34:42 INFO - 'talos_options': ['--disable-stylo', 17:34:42 INFO - '--mitmproxy', 17:34:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:34:42 INFO - '--firstNonBlankPaint'], 17:34:42 INFO - 'tests': ['tp6_google', 17:34:42 INFO - 'tp6_youtube', 17:34:42 INFO - 'tp6_amazon', 17:34:42 INFO - 'tp6_facebook']}, 17:34:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:34:42 INFO - 'talos_options': ['--stylo-threads=1', 17:34:42 INFO - '--mitmproxy', 17:34:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:34:42 INFO - '--firstNonBlankPaint'], 17:34:42 INFO - 'tests': ['tp6_google', 17:34:42 INFO - 'tp6_youtube', 17:34:42 INFO - 'tp6_amazon', 17:34:42 INFO - 'tp6_facebook']}, 17:34:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'talos_options': ['--xperf_path', 17:34:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:42 INFO - 'tests': ['tp5n']}, 17:34:42 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'talos_options': ['--disable-stylo', 17:34:42 INFO - '--xperf_path', 17:34:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:42 INFO - 'tests': ['tp5n']}}} 17:34:42 INFO - Running post-action listener: _resource_record_post_action 17:34:42 INFO - [mozharness: 2017-10-25 00:34:42.780043Z] Finished populate-webroot step (success) 17:34:42 INFO - [mozharness: 2017-10-25 00:34:42.780132Z] Running create-virtualenv step. 17:34:42 INFO - Running pre-action listener: _resource_record_pre_action 17:34:42 INFO - Running main action method: create_virtualenv 17:34:42 INFO - Creating virtualenv /builds/slave/test/build/venv 17:34:42 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:34:42 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:34:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:34:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:34:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:34:43 INFO - Installing distribute.............................................................................................................................................................................................done. 17:34:43 INFO - Installing pip...............done. 17:34:43 INFO - Return code: 0 17:34:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:34:43 INFO - Reading from file tmpfile_stdout 17:34:43 INFO - Output received: 17:34:43 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:34:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e090>, '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 0x145ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1458f90>, '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': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', '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 17:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:34:43 INFO - Using env: {'DISPLAY': ':0', 17:34:43 INFO - 'HOME': '/home/cltbld', 17:34:43 INFO - 'LANG': 'en_US.UTF-8', 17:34:43 INFO - 'LANGUAGE': 'en_US:en', 17:34:43 INFO - 'LOGNAME': 'cltbld', 17:34:43 INFO - 'MAIL': '/var/mail/cltbld', 17:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:43 INFO - 'MOZ_NO_REMOTE': '1', 17:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:43 INFO - 'NO_EM_RESTART': '1', 17:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:43 INFO - 'PWD': '/builds/slave/test', 17:34:43 INFO - 'SHELL': '/bin/bash', 17:34:43 INFO - 'SHLVL': '1', 17:34:43 INFO - 'TERM': 'linux', 17:34:43 INFO - 'TMOUT': '86400', 17:34:43 INFO - 'USER': 'cltbld', 17:34:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', 17:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:43 INFO - '_': '/tools/buildbot/bin/python'} 17:34:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:34:45 INFO - Downloading/unpacking pip>=1.5 17:34:45 INFO - Running setup.py egg_info for package pip 17:34:45 INFO - warning: no files found matching 'pip/cacert.pem' 17:34:45 INFO - warning: no files found matching '*.html' under directory 'docs' 17:34:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:34:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:34:45 INFO - Installing collected packages: pip 17:34:45 INFO - Found existing installation: pip 1.1 17:34:45 INFO - Uninstalling pip: 17:34:45 INFO - Successfully uninstalled pip 17:34:45 INFO - Running setup.py install for pip 17:34:45 INFO - warning: no files found matching 'pip/cacert.pem' 17:34:45 INFO - warning: no files found matching '*.html' under directory 'docs' 17:34:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:34:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:34:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:34:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:34:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:34:45 INFO - Successfully installed pip 17:34:45 INFO - Cleaning up... 17:34:45 INFO - Return code: 0 17:34:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e090>, '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 0x145ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1458f90>, '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': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', '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 17:34:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:34:45 INFO - Using env: {'DISPLAY': ':0', 17:34:45 INFO - 'HOME': '/home/cltbld', 17:34:45 INFO - 'LANG': 'en_US.UTF-8', 17:34:45 INFO - 'LANGUAGE': 'en_US:en', 17:34:45 INFO - 'LOGNAME': 'cltbld', 17:34:45 INFO - 'MAIL': '/var/mail/cltbld', 17:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:45 INFO - 'MOZ_NO_REMOTE': '1', 17:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:45 INFO - 'NO_EM_RESTART': '1', 17:34:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:45 INFO - 'PWD': '/builds/slave/test', 17:34:45 INFO - 'SHELL': '/bin/bash', 17:34:45 INFO - 'SHLVL': '1', 17:34:45 INFO - 'TERM': 'linux', 17:34:45 INFO - 'TMOUT': '86400', 17:34:45 INFO - 'USER': 'cltbld', 17:34:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', 17:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:45 INFO - '_': '/tools/buildbot/bin/python'} 17:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:45 INFO - Downloading/unpacking psutil>=3.1.1 17:34:45 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 17:34:45 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 17:34:45 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 17:34:45 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 17:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:34:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:46 INFO - Installing collected packages: psutil 17:34:46 INFO - Running setup.py install for psutil 17:34:46 INFO - building 'psutil._psutil_linux' extension 17:34:46 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 17:34:47 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 17:34:47 INFO - building 'psutil._psutil_posix' extension 17:34:47 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 17:34:48 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 17:34:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:48 INFO - Successfully installed psutil 17:34:48 INFO - Cleaning up... 17:34:48 INFO - Return code: 0 17:34:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e090>, '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 0x145ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1458f90>, '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': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', '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 17:34:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:34:48 INFO - Using env: {'DISPLAY': ':0', 17:34:48 INFO - 'HOME': '/home/cltbld', 17:34:48 INFO - 'LANG': 'en_US.UTF-8', 17:34:48 INFO - 'LANGUAGE': 'en_US:en', 17:34:48 INFO - 'LOGNAME': 'cltbld', 17:34:48 INFO - 'MAIL': '/var/mail/cltbld', 17:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:48 INFO - 'MOZ_NO_REMOTE': '1', 17:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:48 INFO - 'NO_EM_RESTART': '1', 17:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:48 INFO - 'PWD': '/builds/slave/test', 17:34:48 INFO - 'SHELL': '/bin/bash', 17:34:48 INFO - 'SHLVL': '1', 17:34:48 INFO - 'TERM': 'linux', 17:34:48 INFO - 'TMOUT': '86400', 17:34:48 INFO - 'USER': 'cltbld', 17:34:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', 17:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:48 INFO - '_': '/tools/buildbot/bin/python'} 17:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:34:48 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 17:34:48 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 17:34:48 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 17:34:48 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 17:34:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:34:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:34:49 INFO - Installing collected packages: mozsystemmonitor 17:34:49 INFO - Running setup.py install for mozsystemmonitor 17:34:49 INFO - Successfully installed mozsystemmonitor 17:34:49 INFO - Cleaning up... 17:34:50 INFO - Return code: 0 17:34:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e090>, '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 0x145ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1458f90>, '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': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', '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 17:34:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:34:50 INFO - Using env: {'DISPLAY': ':0', 17:34:50 INFO - 'HOME': '/home/cltbld', 17:34:50 INFO - 'LANG': 'en_US.UTF-8', 17:34:50 INFO - 'LANGUAGE': 'en_US:en', 17:34:50 INFO - 'LOGNAME': 'cltbld', 17:34:50 INFO - 'MAIL': '/var/mail/cltbld', 17:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:50 INFO - 'MOZ_NO_REMOTE': '1', 17:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:50 INFO - 'NO_EM_RESTART': '1', 17:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:50 INFO - 'PWD': '/builds/slave/test', 17:34:50 INFO - 'SHELL': '/bin/bash', 17:34:50 INFO - 'SHLVL': '1', 17:34:50 INFO - 'TERM': 'linux', 17:34:50 INFO - 'TMOUT': '86400', 17:34:50 INFO - 'USER': 'cltbld', 17:34:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', 17:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:50 INFO - '_': '/tools/buildbot/bin/python'} 17:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:51 INFO - Downloading/unpacking jsonschema==2.5.1 17:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:34:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:54 INFO - Downloading functools32-3.2.3-2.tar.gz 17:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:34:54 INFO - warning: no files found matching '*.txt' 17:34:54 INFO - no previously-included directories found matching 'build' 17:34:54 INFO - no previously-included directories found matching 'dist' 17:34:54 INFO - no previously-included directories found matching '.git*' 17:34:54 INFO - Installing collected packages: jsonschema, functools32 17:34:54 INFO - Running setup.py install for functools32 17:34:54 INFO - warning: no files found matching '*.txt' 17:34:54 INFO - no previously-included directories found matching 'build' 17:34:54 INFO - no previously-included directories found matching 'dist' 17:34:54 INFO - no previously-included directories found matching '.git*' 17:34:54 INFO - Successfully installed jsonschema functools32 17:34:54 INFO - Cleaning up... 17:34:54 INFO - Return code: 0 17:34:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e090>, '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 0x145ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1458f90>, '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': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', '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 17:34:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:34:54 INFO - Using env: {'DISPLAY': ':0', 17:34:54 INFO - 'HOME': '/home/cltbld', 17:34:54 INFO - 'LANG': 'en_US.UTF-8', 17:34:54 INFO - 'LANGUAGE': 'en_US:en', 17:34:54 INFO - 'LOGNAME': 'cltbld', 17:34:54 INFO - 'MAIL': '/var/mail/cltbld', 17:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:54 INFO - 'MOZ_NO_REMOTE': '1', 17:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:54 INFO - 'NO_EM_RESTART': '1', 17:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:54 INFO - 'PWD': '/builds/slave/test', 17:34:54 INFO - 'SHELL': '/bin/bash', 17:34:54 INFO - 'SHLVL': '1', 17:34:54 INFO - 'TERM': 'linux', 17:34:54 INFO - 'TMOUT': '86400', 17:34:54 INFO - 'USER': 'cltbld', 17:34:54 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', 17:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:54 INFO - '_': '/tools/buildbot/bin/python'} 17:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:34:55 INFO - Cleaning up... 17:34:55 INFO - Return code: 0 17:34:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:34:55 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')]} 17:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:55 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')]} 17:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:55 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 0x10ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e090>, '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 0x145ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1458f90>, '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': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', '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 17:34:55 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 17:34:55 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 17:34:55 INFO - Using env: {'DISPLAY': ':0', 17:34:55 INFO - 'HOME': '/home/cltbld', 17:34:55 INFO - 'LANG': 'en_US.UTF-8', 17:34:55 INFO - 'LANGUAGE': 'en_US:en', 17:34:55 INFO - 'LOGNAME': 'cltbld', 17:34:55 INFO - 'MAIL': '/var/mail/cltbld', 17:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:55 INFO - 'MOZ_NO_REMOTE': '1', 17:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:55 INFO - 'NO_EM_RESTART': '1', 17:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:55 INFO - 'PWD': '/builds/slave/test', 17:34:55 INFO - 'SHELL': '/bin/bash', 17:34:55 INFO - 'SHLVL': '1', 17:34:55 INFO - 'TERM': 'linux', 17:34:55 INFO - 'TMOUT': '86400', 17:34:55 INFO - 'USER': 'cltbld', 17:34:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', 17:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:55 INFO - '_': '/tools/buildbot/bin/python'} 17:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:55 INFO - Downloading/unpacking blobuploader==1.2.4 17:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:56 INFO - Downloading blobuploader-1.2.4.tar.gz 17:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:34:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:34:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:56 INFO - Downloading docopt-0.6.1.tar.gz 17:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:34:57 INFO - Installing collected packages: blobuploader, requests, docopt 17:34:57 INFO - Running setup.py install for blobuploader 17:34:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:34:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:34:57 INFO - Running setup.py install for requests 17:34:57 INFO - Running setup.py install for docopt 17:34:57 INFO - Successfully installed blobuploader requests docopt 17:34:57 INFO - Cleaning up... 17:34:57 INFO - Return code: 0 17:34:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:57 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 0x10ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e090>, '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 0x145ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1458f90>, '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': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', '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 17:34:57 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 17:34:57 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 17:34:57 INFO - Using env: {'DISPLAY': ':0', 17:34:57 INFO - 'HOME': '/home/cltbld', 17:34:57 INFO - 'LANG': 'en_US.UTF-8', 17:34:57 INFO - 'LANGUAGE': 'en_US:en', 17:34:57 INFO - 'LOGNAME': 'cltbld', 17:34:57 INFO - 'MAIL': '/var/mail/cltbld', 17:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:57 INFO - 'MOZ_NO_REMOTE': '1', 17:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:57 INFO - 'NO_EM_RESTART': '1', 17:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:57 INFO - 'PWD': '/builds/slave/test', 17:34:57 INFO - 'SHELL': '/bin/bash', 17:34:57 INFO - 'SHLVL': '1', 17:34:57 INFO - 'TERM': 'linux', 17:34:57 INFO - 'TMOUT': '86400', 17:34:57 INFO - 'USER': 'cltbld', 17:34:57 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', 17:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:57 INFO - '_': '/tools/buildbot/bin/python'} 17:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:34:57 INFO - Running setup.py (path:/tmp/pip-ruzOYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:34:57 INFO - Running setup.py (path:/tmp/pip-uCmV5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:34:57 INFO - Running setup.py (path:/tmp/pip-uGpSvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:34:58 INFO - Running setup.py (path:/tmp/pip-PuLyoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:34:58 INFO - Running setup.py (path:/tmp/pip-lPVtxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:34:58 INFO - Running setup.py (path:/tmp/pip-wBwLWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:34:58 INFO - Running setup.py (path:/tmp/pip-bessUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:34:58 INFO - Running setup.py (path:/tmp/pip-n9LErk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:34:58 INFO - Running setup.py (path:/tmp/pip-gV0Now-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:34:58 INFO - Running setup.py (path:/tmp/pip-wmVCth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:34:58 INFO - Running setup.py (path:/tmp/pip-2fuPoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:34:58 INFO - Running setup.py (path:/tmp/pip-_hthWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:34:58 INFO - Running setup.py (path:/tmp/pip-BoEiPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:34:58 INFO - Running setup.py (path:/tmp/pip-ZzCx0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:58 INFO - Running setup.py (path:/tmp/pip-evpLde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:34:58 INFO - Running setup.py (path:/tmp/pip-cAXRGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:34:59 INFO - Running setup.py (path:/tmp/pip-bSwqgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:34:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:34:59 INFO - Running setup.py install for manifestparser 17:34:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:34:59 INFO - Running setup.py install for mozcrash 17:34:59 INFO - Running setup.py install for mozdebug 17:34:59 INFO - Running setup.py install for mozdevice 17:34:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:34:59 INFO - Running setup.py install for mozfile 17:34:59 INFO - Running setup.py install for mozhttpd 17:34:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:34:59 INFO - Running setup.py install for mozinfo 17:34:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:34:59 INFO - Running setup.py install for mozInstall 17:34:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:34:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:34:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:34:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:34:59 INFO - Running setup.py install for mozleak 17:34:59 INFO - Running setup.py install for mozlog 17:35:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:35:00 INFO - Running setup.py install for moznetwork 17:35:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:35:00 INFO - Running setup.py install for mozprocess 17:35:00 INFO - Running setup.py install for mozprofile 17:35:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:35:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:35:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:35:00 INFO - Running setup.py install for mozrunner 17:35:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:35:00 INFO - Running setup.py install for mozscreenshot 17:35:00 INFO - Running setup.py install for moztest 17:35:00 INFO - Running setup.py install for mozversion 17:35:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:35:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:35:00 INFO - Cleaning up... 17:35:00 INFO - Return code: 0 17:35:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:00 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')]} 17:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:00 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')]} 17:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:00 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 0x10ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e090>, '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 0x145ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1458f90>, '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': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', '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 17:35:00 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 17:35:00 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 17:35:00 INFO - Using env: {'DISPLAY': ':0', 17:35:00 INFO - 'HOME': '/home/cltbld', 17:35:00 INFO - 'LANG': 'en_US.UTF-8', 17:35:00 INFO - 'LANGUAGE': 'en_US:en', 17:35:00 INFO - 'LOGNAME': 'cltbld', 17:35:00 INFO - 'MAIL': '/var/mail/cltbld', 17:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:00 INFO - 'MOZ_NO_REMOTE': '1', 17:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:00 INFO - 'NO_EM_RESTART': '1', 17:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:00 INFO - 'PWD': '/builds/slave/test', 17:35:00 INFO - 'SHELL': '/bin/bash', 17:35:00 INFO - 'SHLVL': '1', 17:35:00 INFO - 'TERM': 'linux', 17:35:00 INFO - 'TMOUT': '86400', 17:35:00 INFO - 'USER': 'cltbld', 17:35:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', 17:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:00 INFO - '_': '/tools/buildbot/bin/python'} 17:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:01 INFO - Running setup.py (path:/tmp/pip-lynIua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:01 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)) 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:01 INFO - Running setup.py (path:/tmp/pip-X3av7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:01 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)) 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:01 INFO - Running setup.py (path:/tmp/pip-X1lQd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:01 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)) 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:01 INFO - Running setup.py (path:/tmp/pip-mAyTZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:01 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)) 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:01 INFO - Running setup.py (path:/tmp/pip-PWEq2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:01 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)) 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:01 INFO - Running setup.py (path:/tmp/pip-VigRSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:01 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)) 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:01 INFO - Running setup.py (path:/tmp/pip-DKlx7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:01 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)) 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:01 INFO - Running setup.py (path:/tmp/pip-WAiktF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:01 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)) 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:01 INFO - Running setup.py (path:/tmp/pip-799QU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:01 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)) 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:01 INFO - Running setup.py (path:/tmp/pip-RHwTWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:01 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)) 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:01 INFO - Running setup.py (path:/tmp/pip-ZmuJjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:01 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)) 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:01 INFO - Running setup.py (path:/tmp/pip-nAJlo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:01 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)) 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:01 INFO - Running setup.py (path:/tmp/pip-Xx0qMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:02 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)) 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:02 INFO - Running setup.py (path:/tmp/pip-xvTaRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:02 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)) 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:02 INFO - Running setup.py (path:/tmp/pip-f84kFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:02 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)) 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:02 INFO - Running setup.py (path:/tmp/pip-Uks_aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:02 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)) 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:02 INFO - Running setup.py (path:/tmp/pip-GzspRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:02 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)) 17:35:02 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)) 17:35:02 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)) 17:35:02 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)) 17:35:02 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)) 17:35:02 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)) 17:35:02 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)) 17:35:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:35:02 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 17:35:02 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 17:35:02 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 17:35:02 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 17:35:03 INFO - Downloading blessings-1.6.tar.gz 17:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:35:03 INFO - Installing collected packages: blessings 17:35:03 INFO - Running setup.py install for blessings 17:35:03 INFO - Successfully installed blessings 17:35:03 INFO - Cleaning up... 17:35:03 INFO - Return code: 0 17:35:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:35:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:03 INFO - Reading from file tmpfile_stdout 17:35:03 INFO - Current package versions: 17:35:03 INFO - argparse == 1.2.1 17:35:03 INFO - blessings == 1.6 17:35:03 INFO - blobuploader == 1.2.4 17:35:03 INFO - docopt == 0.6.1 17:35:03 INFO - functools32 == 3.2.3-2 17:35:03 INFO - jsonschema == 2.5.1 17:35:03 INFO - manifestparser == 1.1 17:35:03 INFO - mozInstall == 1.13 17:35:03 INFO - mozcrash == 1.0 17:35:03 INFO - mozdebug == 0.1 17:35:03 INFO - mozdevice == 0.51 17:35:03 INFO - mozfile == 1.2 17:35:03 INFO - mozhttpd == 0.7 17:35:03 INFO - mozinfo == 0.10 17:35:03 INFO - mozleak == 0.1 17:35:03 INFO - mozlog == 3.5 17:35:03 INFO - moznetwork == 0.27 17:35:03 INFO - mozprocess == 0.25 17:35:03 INFO - mozprofile == 0.28 17:35:03 INFO - mozrunner == 6.13 17:35:03 INFO - mozscreenshot == 0.1 17:35:03 INFO - mozsystemmonitor == 0.3 17:35:03 INFO - moztest == 0.8 17:35:03 INFO - mozversion == 1.4 17:35:03 INFO - psutil == 3.1.1 17:35:03 INFO - requests == 1.2.3 17:35:03 INFO - wsgiref == 0.1.2 17:35:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:03 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')]} 17:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:03 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')]} 17:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:03 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 0x10ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e090>, '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 0x145ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1458f90>, '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': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', '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 17:35:03 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 17:35:03 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 17:35:03 INFO - Using env: {'DISPLAY': ':0', 17:35:03 INFO - 'HOME': '/home/cltbld', 17:35:03 INFO - 'LANG': 'en_US.UTF-8', 17:35:03 INFO - 'LANGUAGE': 'en_US:en', 17:35:03 INFO - 'LOGNAME': 'cltbld', 17:35:03 INFO - 'MAIL': '/var/mail/cltbld', 17:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:03 INFO - 'MOZ_NO_REMOTE': '1', 17:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:03 INFO - 'NO_EM_RESTART': '1', 17:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:03 INFO - 'PWD': '/builds/slave/test', 17:35:03 INFO - 'SHELL': '/bin/bash', 17:35:03 INFO - 'SHLVL': '1', 17:35:03 INFO - 'TERM': 'linux', 17:35:03 INFO - 'TMOUT': '86400', 17:35:03 INFO - 'USER': 'cltbld', 17:35:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', 17:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:03 INFO - '_': '/tools/buildbot/bin/python'} 17:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:04 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)) 17:35:04 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)) 17:35:04 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)) 17:35:04 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)) 17:35:04 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)) 17:35:04 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)) 17:35:04 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)) 17:35:04 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)) 17:35:04 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)) 17:35:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:35:04 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 17:35:04 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 17:35:04 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 17:35:04 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 17:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:35:05 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)) 17:35:05 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)) 17:35:05 INFO - Installing collected packages: simplejson 17:35:05 INFO - Running setup.py install for simplejson 17:35:05 INFO - building 'simplejson._speedups' extension 17:35:05 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 17:35:06 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 17:35:06 INFO - Successfully installed simplejson 17:35:06 INFO - Cleaning up... 17:35:06 INFO - Return code: 0 17:35:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:35:06 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')]} 17:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:06 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')]} 17:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:06 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 0x10ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e090>, '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 0x145ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1458f90>, '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': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', '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 17:35:06 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 17:35:06 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 17:35:06 INFO - Using env: {'DISPLAY': ':0', 17:35:06 INFO - 'HOME': '/home/cltbld', 17:35:06 INFO - 'LANG': 'en_US.UTF-8', 17:35:06 INFO - 'LANGUAGE': 'en_US:en', 17:35:06 INFO - 'LOGNAME': 'cltbld', 17:35:06 INFO - 'MAIL': '/var/mail/cltbld', 17:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:06 INFO - 'MOZ_NO_REMOTE': '1', 17:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:06 INFO - 'NO_EM_RESTART': '1', 17:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:06 INFO - 'PWD': '/builds/slave/test', 17:35:06 INFO - 'SHELL': '/bin/bash', 17:35:06 INFO - 'SHLVL': '1', 17:35:06 INFO - 'TERM': 'linux', 17:35:06 INFO - 'TMOUT': '86400', 17:35:06 INFO - 'USER': 'cltbld', 17:35:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', 17:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:06 INFO - '_': '/tools/buildbot/bin/python'} 17:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:35:06 INFO - Cleaning up... 17:35:06 INFO - Return code: 0 17:35:06 INFO - Running post-action listener: _resource_record_post_action 17:35:06 INFO - Running post-action listener: _start_resource_monitoring 17:35:06 INFO - Starting resource monitoring. 17:35:06 INFO - [mozharness: 2017-10-25 00:35:06.534662Z] Finished create-virtualenv step (success) 17:35:06 INFO - [mozharness: 2017-10-25 00:35:06.535195Z] Running install step. 17:35:06 INFO - Running pre-action listener: _resource_record_pre_action 17:35:06 INFO - Running main action method: install 17:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:06 INFO - Reading from file tmpfile_stdout 17:35:06 INFO - Detecting whether we're running mozinstall >=1.0... 17:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:35:06 INFO - Reading from file tmpfile_stdout 17:35:06 INFO - Output received: 17:35:06 INFO - Usage: mozinstall [options] installer 17:35:06 INFO - Options: 17:35:06 INFO - -h, --help show this help message and exit 17:35:06 INFO - -d DEST, --destination=DEST 17:35:06 INFO - Directory to install application into. [default: 17:35:06 INFO - "/builds/slave/test"] 17:35:06 INFO - --app=APP Application being installed. [default: firefox] 17:35:06 INFO - mkdir: /builds/slave/test/build/application 17:35:06 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'] 17:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:35:21 INFO - Reading from file tmpfile_stdout 17:35:21 INFO - Output received: 17:35:21 INFO - /builds/slave/test/build/application/firefox/firefox 17:35:21 INFO - Running post-action listener: _resource_record_post_action 17:35:21 INFO - [mozharness: 2017-10-25 00:35:21.466502Z] Finished install step (success) 17:35:21 INFO - [mozharness: 2017-10-25 00:35:21.466716Z] Running setup-mitmproxy step. 17:35:21 INFO - Running pre-action listener: _resource_record_pre_action 17:35:21 INFO - Running main action method: setup_mitmproxy 17:35:21 INFO - Skipping: mitmproxy is not required 17:35:21 INFO - Running post-action listener: _resource_record_post_action 17:35:21 INFO - [mozharness: 2017-10-25 00:35:21.468340Z] Finished setup-mitmproxy step (success) 17:35:21 INFO - [mozharness: 2017-10-25 00:35:21.468652Z] Running run-tests step. 17:35:21 INFO - Running pre-action listener: _resource_record_pre_action 17:35:21 INFO - Running pre-action listener: _set_gcov_prefix 17:35:21 INFO - Running main action method: run_tests 17:35:21 WARNING - Try message not found. 17:35:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:35:21 INFO - Python 2.7.3 17:35:21 INFO - Return code: 0 17:35:21 INFO - grabbing minidump binary from tooltool 17:35: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')]} 17:35:21 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 0x145e090>, '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 0x145ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1458f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:35:21 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 17:35:21 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 17:35:21 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 17:35:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:35:21 INFO - Return code: 0 17:35:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:35:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:35:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:35:21 INFO - ENV: RUST_BACKTRACE is now full 17:35:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:35:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:35:21 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/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 17:35:21 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/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 17:35:21 INFO - Using env: {'DISPLAY': ':0', 17:35:21 INFO - 'HOME': '/home/cltbld', 17:35:21 INFO - 'LANG': 'en_US.UTF-8', 17:35:21 INFO - 'LANGUAGE': 'en_US:en', 17:35:21 INFO - 'LOGNAME': 'cltbld', 17:35:21 INFO - 'MAIL': '/var/mail/cltbld', 17:35:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:21 INFO - 'MOZ_NO_REMOTE': '1', 17:35:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:21 INFO - 'NO_EM_RESTART': '1', 17:35:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:21 INFO - 'PWD': '/builds/slave/test', 17:35:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:21 INFO - 'RUST_BACKTRACE': 'full', 17:35:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:35:21 INFO - 'SHELL': '/bin/bash', 17:35:21 INFO - 'SHLVL': '1', 17:35:21 INFO - 'TERM': 'linux', 17:35:21 INFO - 'TMOUT': '86400', 17:35:21 INFO - 'USER': 'cltbld', 17:35:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', 17:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:21 INFO - '_': '/tools/buildbot/bin/python'} 17:35:21 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/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 17:35:21 INFO - mozversion application_buildid: 20171024231529 17:35:21 INFO - mozversion application_changeset: 598d726067c4fa4718fcc09cdf3e5f6b9b0b6eae 17:35:21 INFO - mozversion application_display_name: Firefox 17:35:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:35:21 INFO - mozversion application_name: Firefox 17:35:21 INFO - mozversion application_remotingname: firefox 17:35:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:35:21 INFO - mozversion application_vendor: Mozilla 17:35:21 INFO - mozversion application_version: 57.0 17:35:21 INFO - mozversion platform_buildid: 20171024231529 17:35:21 INFO - mozversion platform_changeset: 598d726067c4fa4718fcc09cdf3e5f6b9b0b6eae 17:35:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:35:21 INFO - mozversion platform_version: 57.0 17:35:21 INFO - using testdate: 1508891721 17:35:21 INFO - actual date: 1508891721 17:35:21 INFO - starting webserver on 'localhost:47104' 17:35:21 INFO - SUITE-START | Running 2 tests 17:35:21 INFO - TEST-START | dromaeo_css 17:35:21 INFO - Initialising browser for dromaeo_css test... 17:35:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47104/getInfo.html -profile /tmp/tmpYYIPiX/profile 17:35:21 INFO - TEST-INFO | started process 19454 (/builds/slave/test/build/application/firefox/firefox http://localhost:47104/getInfo.html) 17:35:26 INFO - TEST-INFO | 19454: exit 0 17:35:26 INFO - Browser initialized. 17:35:26 INFO - Running cycle 1/1 for dromaeo_css test... 17:35:26 INFO - Using env: {'DISPLAY': ':0', 17:35:26 INFO - 'HOME': '/home/cltbld', 17:35:26 INFO - 'JSGC_DISABLE_POISONING': '1', 17:35:26 INFO - 'LANG': 'en_US.UTF-8', 17:35:26 INFO - 'LANGUAGE': 'en_US:en', 17:35:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:35:26 INFO - 'LOGNAME': 'cltbld', 17:35:26 INFO - 'MAIL': '/var/mail/cltbld', 17:35:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:35:26 INFO - 'MOZ_CRASHREPORTER': '1', 17:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:35:26 INFO - 'MOZ_NO_REMOTE': '1', 17:35:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:26 INFO - 'NO_EM_RESTART': '1', 17:35:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:26 INFO - 'PWD': '/builds/slave/test', 17:35:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:26 INFO - 'RUST_BACKTRACE': 'full', 17:35:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:35:26 INFO - 'SHELL': '/bin/bash', 17:35:26 INFO - 'SHLVL': '1', 17:35:26 INFO - 'TERM': 'linux', 17:35:26 INFO - 'TMOUT': '86400', 17:35:26 INFO - 'USER': 'cltbld', 17:35:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', 17:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:26 INFO - '_': '/tools/buildbot/bin/python'} 17:35:26 INFO - TEST-INFO | started process 19682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYYIPiX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:27 INFO - PID 19682 | 17:35:27 INFO - PID 19682 | (/builds/slave/test/build/application/firefox/firefox:19730): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:35:27 INFO - PID 19682 | 17:35:37 INFO - PID 19682 | RSS: Main: 143781888 17:35:37 INFO - PID 19682 | 17:38:35 INFO - PID 19682 | Cycle 1(1): loaded http://localhost:47104/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47104/tests/dromaeo/cssquery-ext.html) 17:38:36 INFO - PID 19682 | RSS: Main: 146890752 17:38:36 INFO - PID 19682 | 17:41:37 INFO - PID 19682 | Cycle 1(1): loaded http://localhost:47104/tests/dromaeo/cssquery-ext.html (next: http://localhost:47104/tests/dromaeo/cssquery-jquery.html) 17:41:38 INFO - PID 19682 | RSS: Main: 145031168 17:41:38 INFO - PID 19682 | 17:44:39 INFO - PID 19682 | Cycle 1(1): loaded http://localhost:47104/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47104/tests/dromaeo/cssquery-mootools.html) 17:44:40 INFO - PID 19682 | RSS: Main: 146939904 17:44:40 INFO - PID 19682 | 17:47:41 INFO - PID 19682 | Cycle 1(1): loaded http://localhost:47104/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47104/tests/dromaeo/cssquery-prototype.html) 17:47:42 INFO - PID 19682 | RSS: Main: 146874368 17:47:42 INFO - PID 19682 | 17:50:45 INFO - PID 19682 | Cycle 1(1): loaded http://localhost:47104/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47104/tests/dromaeo/cssquery-yui.html) 17:50:45 INFO - PID 19682 | RSS: Main: 147705856 17:50:45 INFO - PID 19682 | 17:53:47 INFO - PID 19682 | Cycle 1(1): loaded http://localhost:47104/tests/dromaeo/cssquery-yui.html (next: http://localhost:47104/tests/dromaeo/cssquery-dojo.html) 17:53:47 INFO - PID 19682 | RSS: Main: 149860352 17:53:47 INFO - PID 19682 | 17:53:47 INFO - PID 19682 | __start_tp_report 17:53:47 INFO - PID 19682 | _x_x_mozilla_page_load 17:53:47 INFO - PID 19682 | _x_x_mozilla_page_load_details 17:53:47 INFO - PID 19682 | |i|pagename|runs| 17:53:47 INFO - PID 19682 | |0;dojo.html;4027.5972402759717;4047;4047.6154765297288;4057.107436364001;4076.021754778854;6501.577397469161;6506.54454188207;6576.408123268905;6600.636964966925;6601.50488713346;6524.217093948733;6529.706163222654;6593.0769692243;6615.966920165404;6620.801375958717;5857.76568937242;5868.2664666916635;5882.235309409771;5930.673812940276;5947.88104237915;5868.325142608591;5876.0598304271325;5889.411058894098;5918.319393269786;5963.791267305645;5883.852903677421;5925.081612350093;5989.371116032819;6012.639241645494;6019.879602407949;5841.824745257649;5994.400559943971;6001.129836173752;6007.128966299906;6022.126791615235;5816.738246778905;5867.383924687889;5890.734916928705;5976.133460648225;6007.038873780174;6388.105665206875;6394.040893865911;6401.871962560723;6433.678316084177;6452.645104519296;7045.365917067437;7053.294670532957;7073.540219885691;7083.929160708379;7086.2205157432645;7000.929990700079;7058.435325173974;7082.822929426754;7176.784696459063;7184.964075179643;6482.708278127401;6533.248676402274;6578.440832529241;6587.868242635121;6632.270450250517;7177.246389129171;7177.246389129171;7189.424846012306;7192.3886469649615;7259.9274007259255;6913.930860691429;6960.37356637905;6997.685104170325;7008.92991070093;7018.052562904045;7030.402415794612;7031.156261248683;7118.28817118284;7137.714491420389;7139.785806425712;6912.516123871382;6965.895511567331;6974.337437943387;7057.505974581833;7062.329078737512;7000.649967501605;7005;7039.472039596948;7039.788806335818;7064.011038454621;5239.187925871496;5266.394364648115;5306.681599103988;5308.681479111188;5309.150535914235;4755.0489902019735;4801.927971080437;4862.197737373293;4862.440819305825;4869.732164730903;6551.508636852255;6605.207375115017;6610.206775187008;6680.3987641112535;6689.5986240825705;7054.894176587355;7056.894146587805;7061.89407158893;7100.076989991268;7101.964490177619;6520.543561950618;6592.110065141144;6684.1978962523835;6685.09751183584;6697.966510167418;5843.766249349978;5915.852103697356;5985.700714964234;5988;6005;7243.348098671145;7327.63361831917;7410.444216683771;7414.962925185339;7425.480216384801;6962.234154242928;7015.193252775996;7024.438044956289;7044.894326585208;7046.365827075588;7264.34620884123;7278.053852999076;7314.634268286671;7393.408527317909;7406.037215161994;6860.828479288058;6921.134858142732;6936.7225310989015;6940.7917762467205;6967.7212911482975;7036.859262814817;7074.893876591958;7074.964625176841;7089.291070892869;7115.146182458138;6778.966105169443;6827.146606674166;6834.555753875982;6886.690098945459;6920.446364290945;6737.865242695217;6807.9319206807295;6808.38724514796;6810.591364517946;6821.079154314302;6723;6728.428083612947;6743.5953842769595;6749.763758268437;6759.898601520883;6845.422092814447;6873.931260687329;6877.518573699793;6943.75696850628;7008.929910700827;6619.66901654925;6692.799216023527;6712.2616512184595;6752.966235168793;6758.493113016445 17:53:47 INFO - PID 19682 | |1;ext.html;977.2182254196646;999.6401295533602;1024.9436281004544;1051.9474026298683;1054.2830875004993;47042.76478617611;47750.52249477504;47876;47928.520714792845;48257;46176.07647847041;46339;46355.536444635545;46483;46631.76684116574;8249.58752062396;8339.499630022188;8373.330133589297;8385.287250583708;8386.790330241762;8280.089190189074;8340.499570025819;8365.749027529153;8367.372447066464;8367.623456944422;8277.296429803444;8304.377171712116;8350.498970061815;8913.821723565525;9114.270858331318;8956.059613740561;9037.096290370977;9066.048064953151;9069.863952040725;9084.636614535411;7849.979502664617;7954.164812694699;7970.601469926481;7975.680972761083;7982.401319900972;42079;43334;43977.78011109956;44068.3389749154;44167.33748993768;3840.0783811885226;3857.537095548524;3861.8262178201767;3869.419587061935;3883.592222816592;35952.28095438077;36111.27777444463;36119;36319;36364.454533182026;5546.500814926676;5646.774129034834;5720.8283751487525;5728.541716662657;5765.971170144165;246994;248072;248143;248321;248714.75642621852;56330.43669563252;56388.15417768737;56443.71778141165;56543;56736.43263567394;56772;56896.431035689944;57022;57038.14442783361;57238.7138064307;18782.906085469484;18806.435806925812;18976.335828245945;19005.714914276297;19037.238510459705;15761.921190394203;15799.684006319809;15839.049657020616;15842.28709708066;15846.524604261891;15574.299156537983;15880.285387157375;15931;16083.115428651536;16093.114878681785;6198.380161983766;6288.622682639057;6294.569459644505;6310.242770867525;6352.333005034405;1076.4886678827652;1085.9022687958122;1098.5990113608634;1108.490094556513;1120.815065514181;26047.218583442525;26199.214023579323;26254;26340.419574825188;26545.203643890713;1215.7203843116133;1220.5710635834625;1228.969275768113;1231.0889941443268;1238.2446707508414;13690;13872.722545549033;14002.57992260234;14010.159390436402;14012.579622611338;286747;328149;328435;332014;333272;67843.32156678468;68249.65875170691;68277.99999999901;68458;68514;1504.4057597249243;1557.548310989823;1573.1347758732652;1575.9369625214863;1595.3618552579062;31996.040118796474;32271;32439.189020274684;32643.34713305768;32714;45015.324770127816;45161;45195;45195.774021129684;45295.547044529136;276951;277604;278885;279310;279917;40090;40157.19685606213;40201.59798401978;40342.39486407765;40702.59297407106;49570.752146240484;51108;51225.74387128041;51356.22965655443;51992.480075198764;36174;36282.27435451329;36814.63185368219;36874.26251474902;36950;36795.81602091972;37000.44499332566;37252.25495490021;37687;37696.057598560255;42437.1512569753;43476.565234347254;43675;44116;44240;35057;35166.47250291299;35476.290474190886;35536.644633554366;35858;25539.48921021532;25830.61254081228;26033.349166270993;26202.73797262003;26856.462870742867 17:53:47 INFO - PID 19682 | |2;jquery.html;637.0600213322989;639.4020778178133;641.6726396832596;641.8165945679685;655.5574986883854;24430.38924026898;25248.116315928946;25267.873660631692;25271.74728252717;25297;27290.317742056457;27594;27652.58521122185;27667;27708.445831083416;6641.335866413357;6988.545744526615;7007.649617519129;7030.648467576626;7036.753713620024;6996.650167491631;7030.753923612649;7067.787966360992;7084.539504932189;7092.113485814273;6688.5986840789465;6940.514164008521;6947.548409353401;6953.33943275388;6974.267701891305;6911.343422374892;6952.339527744856;6959.61722105284;6969.5121341505865;6975.79072627822;6477.708503117371;6511.28375878653;6537.477001839841;6542.901856472156;6577.04632828242;30017.549736753965;30403.543946840815;30563.388732225452;30569.23576910595;30613.540796888065;2393.4734358441287;2438.366024833556;2438.6220135878966;2440.670509481215;2443;20561.4859628509;20980;20988.055537500695;21009;21026.789732102636;2619.8428094314213;2622.593498007812;2713.6200931869553;2713.9050133245437;2731.2762118038536;134705;138187;156118;161716;163154.3684563151;15881.602959926095;16679.166041697867;16749.24628391725;17351.739723904153;17385.739213911547;27147.592786108224;27210.1836944892;27254.45491090167;27306;27376.72623273742;11523.48144333507;11625.18623696333;11638.635511683118;11731.88268117308;11819.290842549475;10595.099416549525;10674.839877401846;10683.305585137097;10697.251192416456;10766.354018758899;10013;10137.13834324076;10174.236932230113;10338.172946164288;10430.530626121843;3151.416987857254;3163.351512939842;3165.7467402607735;3166.366726654678;3168.8574014169417;1049.8162821506205;1055.2560444886337;1069.4492336446735;1073.7906108308962;1080.0603474976663;21112.683309750366;21525.892370538048;21532.569348613255;21926.45183870416;22139.55720885573;1117.4915413486844;1137.5108703257513;1157.2073129906041;1158.6002829023973;1160.3038177093845;11725.4137293135;12060.879391206152;12112.697182570506;12140.878591214152;12159.209651372632;589849;597258;617200;632899;635244;129956.70043299635;130507;132694;133207;133506;1144.6108323170163;1163.8836116388463;1245.3337464456654;1261.2054405724334;1289.3682095773004;22361.888190558944;22704.772952270927;22776.658350125093;22869.19957801469;23074.769252307262;68611.3138868625;69047.65476172588;69478.65260673664;70334.64832675803;70897.6455117721;83158;86798.56600717209;87790.12209878075;88011;89187;16129.919350403174;16364.590885227964;16386.754198687267;16450.588735281235;16491.34034638649;25221.243362699148;25238.49523009566;25379.36551586225;25471.10851120276;25621.231363059138;18994.145263462902;20069.09689064025;20113.2960346393;20312.492187695425;20327.28854490145;17069.829301706824;17665.646687065928;17891.642167156322;18354;18405.987670677707;20674.793252067288;20731.8963405182;20885.582288354453;20950.685739714223;21046.368608941757;16176.514704558882;16237.59406014859;16271.593210169367;16313.10277934725;16411.507654770376;19743;20506.79493205049;20545.691814623093;20560.58878822445;20883.26908558193 17:53:47 INFO - PID 19682 | |3;mootools.html;1408.5422237772725;1451.8402975672675;1457.507661898154;1461.1160248049923;1483.3547406878006;17247.913760431195;17805.7329140063;17807.910960445195;17812.376566820163;17840.107994600283;17353.826461735378;17470.737938930924;17500.64998700025;17524.948503089825;17531.38640147595;2943.249471384794;3026.334206474572;3119.3761247750426;3120.1263646179104;3122.35991621717;2753.4493101379703;3052.923676908073;3080.722734953854;3086.1204556701346;3098.2254436390904;3100.503919372901;3133.623965124188;3133.7022982816598;3136.84315784211;3147.2446612812987;2932.0470846974818;2961.0376627596115;2965.5255159174644;2975.5536669499534;2981.329200929795;2783.4572258409617;2844.2320573445054;2846.4734024205586;2851.2301678546883;2870.1102658176032;16942.661146776994;17243;17267.136643167792;17267.30930762768;17334.133293335282;8989.86515202266;9228.907710922938;9257.444553326755;9272.119148680864;9313.022132676038;5744.770209191627;6171.074338849164;6239.781607643756;6280;6439.613623182578;2265.490264690448;2266.138867230442;2274.65880117982;2275.294658655822;2334.2763743239652;32504.349913001606;32638.836805816056;32650.346993060244;32695;32716.182095447566;7606.885896711554;7625;7671.462997590115;7795.649195786204;7797.610119494003;20823.79176208249;20857.791422085887;20870.895645521978;21013.159473620883;21022.579548409252;8881.511516866505;9036.32227582934;9057.728268151966;9069;9076.591553380114;8172.959135204286;8182.22268884455;8199;8402.663893444316;8408.117147699526;6231.937680623227;6284.622922624657;6305.4009869062365;6312.274088479791;6425.100485931974;1724.629204720991;1777.9555511112067;1858.27527264367;1866.0949439521821;1916.2430839818473;1010.7169992402139;1017.9541920613442;1028.7942411517577;1041.1774697988503;1052.4895425718673;9986.700398988041;10191.796164076677;10256.230782691178;10295.3822770634;10315.690529284133;1084.38732116354;1100.9504572294265;1107.2360071550604;1117.7317443813588;1121.360824330124;5990.460858522754;6196.225471816023;6202.782902598387;6311.96844015777;6378.904316435257;26282.73717262841;26535.601965970527;26695.733042669326;27085.729142708715;27227.86386068057;26126.86936565305;26245.34386640311;26626;26785.732142678324;26896.59655105175;12926.030547708959;13127.212367257804;13218.272994985176;13248.470061197444;13296.468141274434;9338.906610933804;9366.344355895022;9390.76523086901;9420.717378478657;9438.622455101719;22342.21802236914;22412;22769;22984.195553155558;23180.304590862303;23765.287041388787;23863.642045368986;23874.522509549366;23976.520469590163;24052.639210412206;12748.745025099632;12952.481900723866;13069.215847049207;13070.281134537692;13073.346332683517;15991.120488372786;16107.516774496784;16110.758338625164;16142.515724528283;16355;13212.207267563977;13263.80104298417;13532.391042402918;13635.795463067863;13725.245111518961;12052;12112.45493952792;12129.454174562343;12145.757084858431;12494.437750301076;11614.593489227836;11687.415629218334;11711.355875426592;11720.824187637021;11773.88226117728;8935.821283574422;8996.55017249148;9057.36598438103;9142;9226.40028398152;9064.274858011211;9255.907440925774;9280.767980800263;9300.488473133772;9393.201577865684 17:53:47 INFO - PID 19682 | |4;prototype.html;572.6792995922284;573.6529399713176;578.4735890339791;609.4758507683392;617.2469587103735;6079.270487541496;6249.687515624218;6334.746610135589;6352.269489008754;6363.204599425072;6267.811965641038;6279.560430769848;6300.684965751717;6324.9051264231075;6336.841578960528;5218.425973142951;5227.424983251839;5238.292830467876;5266.236395722618;5268.235141227674;5054.1660625996665;5068.74656267187;5141.100307446182;5145.768440420171;5242.1088414969545;5065.721385323805;5080.1617733074;5085.211792172201;5111.948880511184;5113.846584602468;5010.348654674869;5037.219231019198;5044.974775126101;5074.441811400761;5074.695518268915;4644;4655.208614535537;4672.299155126724;4672.392588963413;4687.742174180418;6239.65681887496;6255.781047663356;6287.434130928238;6309.716062777186;6380.393862583047;5926.911096333559;5949.970250148722;5987.461128498456;6035.215421995156;6079.787207447718;6678.365555272241;6696.531242813005;6710;6725.394714475672;6773.3903948644365;5029.723365214912;5222.451642577551;5242.135047717122;5250.8780607223525;5267.3152490176035;6873.381395674363;6874.621895795729;6960.338767817049;6973.594110032031;6980.616066116361;5275.472452754694;5298;5309.283246761715;5339.19472474768;5357.544608708304;5342.412334643186;5366.275552800322;5413.918791218135;5414.648047876875;5417.8103766367985;5845.707714614252;5906.940930590725;5917.585768996215;5974.103884417372;6029.638221706711;6694.556486882253;6753.831154221086;6762.560433571802;6766.323367663194;6830.282820303896;1825.3884948542386;1854.5456363190835;1855.1559040636478;1859.730339100823;1866.5986812835306;1280.257450678604;1336.3318340829585;1336.8729970652967;1343.6775173958179;1366.152985149214;6312.116303717483;6324.102769169231;6349.174607301022;6374.171357723466;6396.456301214449;6718.496112791462;6718.865622687519;6727.091842601186;6763.560368576027;6823.863522729617;6316.336784637639;6375.521835862236;6383.957133717258;6392.520560957947;6410.8717825643225;3562.2163124112653;3580.445031020196;3606.314800187956;3610.1696609779897;3628.165521929971;7151.678174482161;7180.066591343092;7183.958326042694;7214.314640109181;7223.349898509159;7034.788956331318;7035.33164349386;7046.224915259318;7053.365197132282;7062.293770623;7078.610676412847;7208.927910720826;7215.639218039182;7233.493655444068;7258.818529536698;6797.72809087631;6818.21590517077;6828.36119331347;6851.554648947803;6887.724491020504;6654.3012983637955;6710.328967103446;6734.898976515454;6813.931860681329;6821.249662537216;7098;7170.569765813859;7186.784396468114;7220.277972202948;7264.963675181591;5360.678359298455;5373.570114390917;5378.139497680352;5379.757910893941;5395.622306438669;6549.443297319781;6800.93199068003;6840.965795170992;6932.376086152271;6932.722691092502;6211.9068213975925;6564.901526477011;6624.436922861611;6655.23464801554;6695.163104611924;6577.80266592003;6591.011348297794;6661.16735408074;6687.598744075371;6694.364035416823;6600.679864027118;6602.504812139013;6624.9337506624315;6625.701843417154;6625.834354141185;6695.598264104169;6699.497537684791;6714.294999025032;6722.991551267153;6758.290379510081;6292.179733746358;6435.903461448176;6500.512461565307;6537;6605.5376123670885 17:53:47 INFO - PID 19682 | |5;yui.html;1000.1898462245582;1023.9948800255997;1030.1346868630349;1030.7062487191151;1041.213883517944;20471.874046927413;20812;21012.99999999998;21062.789372106276;21258.89370553147;20344.69482957757;20815.16739330425;20824.8958755206;20865.68701469479;20895.37313880586;1059.9523021464033;1080.3193987787683;1081.5403453532256;1092;1093.518851705251;1084.3873211635441;1111.727626731452;1121.0863146535548;1121.6578943422253;1121.7812526557325;1152.262551966742;1155.6013175454498;1157.9826302605468;1158.6350299655583;1159.8782127876577;1120.9663710088669;1128.7008942630127;1131.7510147767478;1133.6769020829065;1135.4606561883122;832.0473058348218;832.1054866018993;832.5545832979327;836.619338201117;838.1367191792464;21234.89382553093;21318.89340553303;21601.783982160134;21657.133714651394;22892.771072289397;23075.307740767803;23994.040238390444;24238.515229695306;24392.87803560971;24413.145539906018;18002.729959050626;18229.17968691412;18278;18429.907850460797;18437.631247375113;4186.66506679468;4208.789560521962;4230.428892099589;4237;4239.660827133822;163062;169909;171882;171939.14030429767;172503;18596.628067438574;18697.813021869606;18728;18833.90583047076;19076.904615476833;34584.13539661529;35396.29207415837;36159.27681446356;36225.637743622756;36285;10655.893441065646;10667.89332106669;10696.78606427867;10757.408342541235;10789.892101078889;4969.105560998983;5060.671056381323;5083.5678967288195;5095.541401273903;5102.464241254689;6349.365063493706;6377.936220637827;6384.3934826191435;6404.231492220963;6413.326600706859;1161.7095726068483;1189.3280296632374;1200.5737963023;1209.8850609192114;1213.0356366688504;769.4152444142492;777.793884620576;780.9726659566888;793.9603019848985;801.5551368990266;13378.46486140563;13742.244176570184;13880.236586987812;13912.30438478072;14065.85934140666;757.5189754505928;760.0727112922226;762.3405754022731;762.6186906546727;777.4014009212874;6519.674016299166;6556.836079097965;6616.305287944792;6640.203175618956;6725.226598941086;156418.21790890972;156482;158848;159796;161433;137029;137256;139830;141343;142319;122672.24838653482;123941;124740;125498.37250813688;126000.36999814943;12523.56167534132;12605.810912836498;12618.810717839424;12635.431405586587;12879.227246365248;59837.40162598492;60446.697766510886;60937.390626094944;61680.383196167466;62780;72462.63768681123;74126.62936685282;74165.6291718538;74700.2529974715;75785.62107189429;17186.82813171852;17329.56676083108;17500.387486437914;17533.21100550504;17652.205650746004;18544.443666690022;18581.81418185855;18943.71584426207;19027.524311892314;19165.712514312017;18555.165017574513;18845;19014.524636884187;19037;19053.80946190576;16898.40855570049;17071.31714731397;17074.48776536706;17271.13644317754;17351.47945561635;18092.185851636972;18117.365892194237;18234.179461924512;18323.72514412258;18331.17509712093;12862.614121576367;12862.935685321514;13056.151350162208;13155.605331839677;13272.13731107475;14033.508827190999;14057.789133162807;14070.577882663536;14074.366653500821;14212.573622791333 17:53:47 INFO - PID 19682 | __end_tp_report 17:53:47 INFO - PID 19682 | __start_cc_report 17:53:47 INFO - PID 19682 | _x_x_mozilla_cycle_collect,264 17:53:47 INFO - PID 19682 | __end_cc_report 17:53:47 INFO - PID 19682 | __startTimestamp1508892827559__endTimestamp 17:53:47 INFO - PID 19682 | 17:53:47 INFO - PID 19682 | ------- Summary: start ------- 17:53:47 INFO - PID 19682 | Number of tests: 6 17:53:47 INFO - PID 19682 | 17:53:47 INFO - PID 19682 | [#0] dojo.html Cycles:165 Average:6527.37 Median:6749.76 stddev:732.61 (10.9%) stddev-sans-first:708.13 17:53:47 INFO - PID 19682 | Values: 4027.6 4047.0 4047.6 4057.1 4076.0 6501.6 6506.5 6576.4 6600.6 6601.5 6524.2 6529.7 6593.1 6616.0 6620.8 5857.8 5868.3 5882.2 5930.7 5947.9 5868.3 5876.1 5889.4 5918.3 5963.8 5883.9 5925.1 5989.4 6012.6 6019.9 5841.8 5994.4 6001.1 6007.1 6022.1 5816.7 5867.4 5890.7 5976.1 6007.0 6388.1 6394.0 6401.9 6433.7 6452.6 7045.4 7053.3 7073.5 7083.9 7086.2 7000.9 7058.4 7082.8 7176.8 7185.0 6482.7 6533.2 6578.4 6587.9 6632.3 7177.2 7177.2 7189.4 7192.4 7259.9 6913.9 6960.4 6997.7 7008.9 7018.1 7030.4 7031.2 7118.3 7137.7 7139.8 6912.5 6965.9 6974.3 7057.5 7062.3 7000.6 7005.0 7039.5 7039.8 7064.0 5239.2 5266.4 5306.7 5308.7 5309.2 4755.0 4801.9 4862.2 4862.4 4869.7 6551.5 6605.2 6610.2 6680.4 6689.6 7054.9 7056.9 7061.9 7100.1 7102.0 6520.5 6592.1 6684.2 6685.1 6698.0 5843.8 5915.9 5985.7 5988.0 6005.0 7243.3 7327.6 7410.4 7415.0 7425.5 6962.2 7015.2 7024.4 7044.9 7046.4 7264.3 7278.1 7314.6 7393.4 7406.0 6860.8 6921.1 6936.7 6940.8 6967.7 7036.9 7074.9 7075.0 7089.3 7115.1 6779.0 6827.1 6834.6 6886.7 6920.4 6737.9 6807.9 6808.4 6810.6 6821.1 6723.0 6728.4 6743.6 6749.8 6759.9 6845.4 6873.9 6877.5 6943.8 7008.9 6619.7 6692.8 6712.3 6753.0 6758.5 17:53:47 INFO - PID 19682 | 17:53:47 INFO - PID 19682 | [#1] ext.html Cycles:180 Average:47381.20 Median:3865.62 stddev:74168.00 (1918.7%) stddev-sans-first:74294.22 17:53:47 INFO - PID 19682 | Values: 977.2 999.6 1024.9 1051.9 1054.3 47042.8 47750.5 47876.0 47928.5 48257.0 46176.1 46339.0 46355.5 46483.0 46631.8 8249.6 8339.5 8373.3 8385.3 8386.8 8280.1 8340.5 8365.7 8367.4 8367.6 8277.3 8304.4 8350.5 8913.8 9114.3 8956.1 9037.1 9066.0 9069.9 9084.6 7850.0 7954.2 7970.6 7975.7 7982.4 42079.0 43334.0 43977.8 44068.3 44167.3 3840.1 3857.5 3861.8 3869.4 3883.6 35952.3 36111.3 36119.0 36319.0 36364.5 5546.5 5646.8 5720.8 5728.5 5766.0 246994.0 248072.0 248143.0 248321.0 248714.8 56330.4 56388.2 56443.7 56543.0 56736.4 56772.0 56896.4 57022.0 57038.1 57238.7 18782.9 18806.4 18976.3 19005.7 19037.2 15761.9 15799.7 15839.0 15842.3 15846.5 15574.3 15880.3 15931.0 16083.1 16093.1 6198.4 6288.6 6294.6 6310.2 6352.3 1076.5 1085.9 1098.6 1108.5 1120.8 26047.2 26199.2 26254.0 26340.4 26545.2 1215.7 1220.6 1229.0 1231.1 1238.2 13690.0 13872.7 14002.6 14010.2 14012.6 286747.0 328149.0 328435.0 332014.0 333272.0 67843.3 68249.7 68278.0 68458.0 68514.0 1504.4 1557.5 1573.1 1575.9 1595.4 31996.0 32271.0 32439.2 32643.3 32714.0 45015.3 45161.0 45195.0 45195.8 45295.5 276951.0 277604.0 278885.0 279310.0 279917.0 40090.0 40157.2 40201.6 40342.4 40702.6 49570.8 51108.0 51225.7 51356.2 51992.5 36174.0 36282.3 36814.6 36874.3 36950.0 36795.8 37000.4 37252.3 37687.0 37696.1 42437.2 43476.6 43675.0 44116.0 44240.0 35057.0 35166.5 35476.3 35536.6 35858.0 25539.5 25830.6 26033.3 26202.7 26856.5 17:53:47 INFO - PID 19682 | 17:53:47 INFO - PID 19682 | [#2] jquery.html Cycles:180 Average:40970.19 Median:22533.33 stddev:102824.56 (456.3%) stddev-sans-first:103068.41 17:53:47 INFO - PID 19682 | Values: 637.1 639.4 641.7 641.8 655.6 24430.4 25248.1 25267.9 25271.7 25297.0 27290.3 27594.0 27652.6 27667.0 27708.4 6641.3 6988.5 7007.6 7030.6 7036.8 6996.7 7030.8 7067.8 7084.5 7092.1 6688.6 6940.5 6947.5 6953.3 6974.3 6911.3 6952.3 6959.6 6969.5 6975.8 6477.7 6511.3 6537.5 6542.9 6577.0 30017.5 30403.5 30563.4 30569.2 30613.5 2393.5 2438.4 2438.6 2440.7 2443.0 20561.5 20980.0 20988.1 21009.0 21026.8 2619.8 2622.6 2713.6 2713.9 2731.3 134705.0 138187.0 156118.0 161716.0 163154.4 15881.6 16679.2 16749.2 17351.7 17385.7 27147.6 27210.2 27254.5 27306.0 27376.7 11523.5 11625.2 11638.6 11731.9 11819.3 10595.1 10674.8 10683.3 10697.3 10766.4 10013.0 10137.1 10174.2 10338.2 10430.5 3151.4 3163.4 3165.7 3166.4 3168.9 1049.8 1055.3 1069.4 1073.8 1080.1 21112.7 21525.9 21532.6 21926.5 22139.6 1117.5 1137.5 1157.2 1158.6 1160.3 11725.4 12060.9 12112.7 12140.9 12159.2 589849.0 597258.0 617200.0 632899.0 635244.0 129956.7 130507.0 132694.0 133207.0 133506.0 1144.6 1163.9 1245.3 1261.2 1289.4 22361.9 22704.8 22776.7 22869.2 23074.8 68611.3 69047.7 69478.7 70334.6 70897.6 83158.0 86798.6 87790.1 88011.0 89187.0 16129.9 16364.6 16386.8 16450.6 16491.3 25221.2 25238.5 25379.4 25471.1 25621.2 18994.1 20069.1 20113.3 20312.5 20327.3 17069.8 17665.6 17891.6 18354.0 18406.0 20674.8 20731.9 20885.6 20950.7 21046.4 16176.5 16237.6 16271.6 16313.1 16411.5 19743.0 20506.8 20545.7 20560.6 20883.3 17:53:47 INFO - PID 19682 | 17:53:47 INFO - PID 19682 | [#3] mootools.html Cycles:180 Average:11086.13 Median:26264.04 stddev:8190.85 (31.2%) stddev-sans-first:8181.56 17:53:47 INFO - PID 19682 | Values: 1408.5 1451.8 1457.5 1461.1 1483.4 17247.9 17805.7 17807.9 17812.4 17840.1 17353.8 17470.7 17500.6 17524.9 17531.4 2943.2 3026.3 3119.4 3120.1 3122.4 2753.4 3052.9 3080.7 3086.1 3098.2 3100.5 3133.6 3133.7 3136.8 3147.2 2932.0 2961.0 2965.5 2975.6 2981.3 2783.5 2844.2 2846.5 2851.2 2870.1 16942.7 17243.0 17267.1 17267.3 17334.1 8989.9 9228.9 9257.4 9272.1 9313.0 5744.8 6171.1 6239.8 6280.0 6439.6 2265.5 2266.1 2274.7 2275.3 2334.3 32504.3 32638.8 32650.3 32695.0 32716.2 7606.9 7625.0 7671.5 7795.6 7797.6 20823.8 20857.8 20870.9 21013.2 21022.6 8881.5 9036.3 9057.7 9069.0 9076.6 8173.0 8182.2 8199.0 8402.7 8408.1 6231.9 6284.6 6305.4 6312.3 6425.1 1724.6 1778.0 1858.3 1866.1 1916.2 1010.7 1018.0 1028.8 1041.2 1052.5 9986.7 10191.8 10256.2 10295.4 10315.7 1084.4 1101.0 1107.2 1117.7 1121.4 5990.5 6196.2 6202.8 6312.0 6378.9 26282.7 26535.6 26695.7 27085.7 27227.9 26126.9 26245.3 26626.0 26785.7 26896.6 12926.0 13127.2 13218.3 13248.5 13296.5 9338.9 9366.3 9390.8 9420.7 9438.6 22342.2 22412.0 22769.0 22984.2 23180.3 23765.3 23863.6 23874.5 23976.5 24052.6 12748.7 12952.5 13069.2 13070.3 13073.3 15991.1 16107.5 16110.8 16142.5 16355.0 13212.2 13263.8 13532.4 13635.8 13725.2 12052.0 12112.5 12129.5 12145.8 12494.4 11614.6 11687.4 11711.4 11720.8 11773.9 8935.8 8996.6 9057.4 9142.0 9226.4 9064.3 9255.9 9280.8 9300.5 9393.2 17:53:47 INFO - PID 19682 | 17:53:47 INFO - PID 19682 | [#4] prototype.html Cycles:180 Average:5737.54 Median:6335.79 stddev:1590.24 (25.1%) stddev-sans-first:1546.73 17:53:47 INFO - PID 19682 | Values: 572.7 573.7 578.5 609.5 617.2 6079.3 6249.7 6334.7 6352.3 6363.2 6267.8 6279.6 6300.7 6324.9 6336.8 5218.4 5227.4 5238.3 5266.2 5268.2 5054.2 5068.7 5141.1 5145.8 5242.1 5065.7 5080.2 5085.2 5111.9 5113.8 5010.3 5037.2 5045.0 5074.4 5074.7 4644.0 4655.2 4672.3 4672.4 4687.7 6239.7 6255.8 6287.4 6309.7 6380.4 5926.9 5950.0 5987.5 6035.2 6079.8 6678.4 6696.5 6710.0 6725.4 6773.4 5029.7 5222.5 5242.1 5250.9 5267.3 6873.4 6874.6 6960.3 6973.6 6980.6 5275.5 5298.0 5309.3 5339.2 5357.5 5342.4 5366.3 5413.9 5414.6 5417.8 5845.7 5906.9 5917.6 5974.1 6029.6 6694.6 6753.8 6762.6 6766.3 6830.3 1825.4 1854.5 1855.2 1859.7 1866.6 1280.3 1336.3 1336.9 1343.7 1366.2 6312.1 6324.1 6349.2 6374.2 6396.5 6718.5 6718.9 6727.1 6763.6 6823.9 6316.3 6375.5 6384.0 6392.5 6410.9 3562.2 3580.4 3606.3 3610.2 3628.2 7151.7 7180.1 7184.0 7214.3 7223.3 7034.8 7035.3 7046.2 7053.4 7062.3 7078.6 7208.9 7215.6 7233.5 7258.8 6797.7 6818.2 6828.4 6851.6 6887.7 6654.3 6710.3 6734.9 6813.9 6821.2 7098.0 7170.6 7186.8 7220.3 7265.0 5360.7 5373.6 5378.1 5379.8 5395.6 6549.4 6800.9 6841.0 6932.4 6932.7 6211.9 6564.9 6624.4 6655.2 6695.2 6577.8 6591.0 6661.2 6687.6 6694.4 6600.7 6602.5 6624.9 6625.7 6625.8 6695.6 6699.5 6714.3 6723.0 6758.3 6292.2 6435.9 6500.5 6537.0 6605.5 17:53:47 INFO - PID 19682 | 17:53:47 INFO - PID 19682 | [#5] yui.html Cycles:180 Average:29844.41 Median:18300.86 stddev:45064.99 (246.2%) stddev-sans-first:45139.37 17:53:47 INFO - PID 19682 | Values: 1000.2 1024.0 1030.1 1030.7 1041.2 20471.9 20812.0 21013.0 21062.8 21258.9 20344.7 20815.2 20824.9 20865.7 20895.4 1060.0 1080.3 1081.5 1092.0 1093.5 1084.4 1111.7 1121.1 1121.7 1121.8 1152.3 1155.6 1158.0 1158.6 1159.9 1121.0 1128.7 1131.8 1133.7 1135.5 832.0 832.1 832.6 836.6 838.1 21234.9 21318.9 21601.8 21657.1 22892.8 23075.3 23994.0 24238.5 24392.9 24413.1 18002.7 18229.2 18278.0 18429.9 18437.6 4186.7 4208.8 4230.4 4237.0 4239.7 163062.0 169909.0 171882.0 171939.1 172503.0 18596.6 18697.8 18728.0 18833.9 19076.9 34584.1 35396.3 36159.3 36225.6 36285.0 10655.9 10667.9 10696.8 10757.4 10789.9 4969.1 5060.7 5083.6 5095.5 5102.5 6349.4 6377.9 6384.4 6404.2 6413.3 1161.7 1189.3 1200.6 1209.9 1213.0 769.4 777.8 781.0 794.0 801.6 13378.5 13742.2 13880.2 13912.3 14065.9 757.5 760.1 762.3 762.6 777.4 6519.7 6556.8 6616.3 6640.2 6725.2 156418.2 156482.0 158848.0 159796.0 161433.0 137029.0 137256.0 139830.0 141343.0 142319.0 122672.2 123941.0 124740.0 125498.4 126000.4 12523.6 12605.8 12618.8 12635.4 12879.2 59837.4 60446.7 60937.4 61680.4 62780.0 72462.6 74126.6 74165.6 74700.3 75785.6 17186.8 17329.6 17500.4 17533.2 17652.2 18544.4 18581.8 18943.7 19027.5 19165.7 18555.2 18845.0 19014.5 19037.0 19053.8 16898.4 17071.3 17074.5 17271.1 17351.5 18092.2 18117.4 18234.2 18323.7 18331.2 12862.6 12862.9 13056.2 13155.6 13272.1 14033.5 14057.8 14070.6 14074.4 14212.6 17:53:47 INFO - PID 19682 | -------- Summary: end -------- 17:53:47 INFO - PID 19682 | 17:53:48 INFO - TEST-INFO | 19682: exit 0 17:53:48 INFO - TEST-OK | dromaeo_css | took 1106329ms 17:53:48 INFO - TEST-START | kraken 17:53:48 INFO - Initialising browser for kraken test... 17:53:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47104/getInfo.html -profile /tmp/tmpcLcWag/profile 17:53:48 INFO - TEST-INFO | started process 20048 (/builds/slave/test/build/application/firefox/firefox http://localhost:47104/getInfo.html) 17:53:52 INFO - TEST-INFO | 20048: exit 0 17:53:52 INFO - Browser initialized. 17:53:52 INFO - Running cycle 1/1 for kraken test... 17:53:52 INFO - Using env: {'DISPLAY': ':0', 17:53:52 INFO - 'HOME': '/home/cltbld', 17:53:52 INFO - 'JSGC_DISABLE_POISONING': '1', 17:53:52 INFO - 'LANG': 'en_US.UTF-8', 17:53:52 INFO - 'LANGUAGE': 'en_US:en', 17:53:52 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:53:52 INFO - 'LOGNAME': 'cltbld', 17:53:52 INFO - 'MAIL': '/var/mail/cltbld', 17:53:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:53:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:53:52 INFO - 'MOZ_CRASHREPORTER': '1', 17:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:52 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:53:52 INFO - 'MOZ_NO_REMOTE': '1', 17:53:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:52 INFO - 'NO_EM_RESTART': '1', 17:53:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:52 INFO - 'PWD': '/builds/slave/test', 17:53:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:53:52 INFO - 'RUST_BACKTRACE': 'full', 17:53:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:53:52 INFO - 'SHELL': '/bin/bash', 17:53:52 INFO - 'SHLVL': '1', 17:53:52 INFO - 'TERM': 'linux', 17:53:52 INFO - 'TMOUT': '86400', 17:53:52 INFO - 'USER': 'cltbld', 17:53:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882', 17:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:52 INFO - '_': '/tools/buildbot/bin/python'} 17:53:52 INFO - TEST-INFO | started process 20278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcLcWag/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:53:53 INFO - PID 20278 | 17:53:53 INFO - PID 20278 | (/builds/slave/test/build/application/firefox/firefox:20326): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:53:53 INFO - PID 20278 | 17:54:03 INFO - PID 20278 | RSS: Main: 143708160 17:54:03 INFO - PID 20278 | 17:54:06 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47104/tests/kraken/driver.html?testName=audio-beat-detection) 17:54:07 INFO - PID 20278 | RSS: Main: 149626880 17:54:07 INFO - PID 20278 | 17:54:09 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47104/tests/kraken/driver.html?testName=audio-dft) 17:54:10 INFO - PID 20278 | RSS: Main: 149876736 17:54:10 INFO - PID 20278 | 17:54:13 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47104/tests/kraken/driver.html?testName=audio-fft) 17:54:13 INFO - PID 20278 | RSS: Main: 151789568 17:54:13 INFO - PID 20278 | 17:54:15 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47104/tests/kraken/driver.html?testName=audio-oscillator) 17:54:16 INFO - PID 20278 | RSS: Main: 151687168 17:54:16 INFO - PID 20278 | 17:54:18 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47104/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:54:18 INFO - PID 20278 | RSS: Main: 151539712 17:54:18 INFO - PID 20278 | 17:54:22 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47104/tests/kraken/driver.html?testName=imaging-darkroom) 17:54:22 INFO - PID 20278 | RSS: Main: 151531520 17:54:22 INFO - PID 20278 | 17:54:26 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47104/tests/kraken/driver.html?testName=imaging-desaturate) 17:54:26 INFO - PID 20278 | RSS: Main: 152080384 17:54:26 INFO - PID 20278 | 17:54:29 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47104/tests/kraken/driver.html?testName=json-parse-financial) 17:54:30 INFO - PID 20278 | RSS: Main: 154423296 17:54:30 INFO - PID 20278 | 17:54:31 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47104/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:54:32 INFO - PID 20278 | RSS: Main: 153894912 17:54:32 INFO - PID 20278 | 17:54:33 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47104/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:54:34 INFO - PID 20278 | RSS: Main: 154447872 17:54:34 INFO - PID 20278 | 17:54:36 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47104/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:54:37 INFO - PID 20278 | RSS: Main: 150966272 17:54:37 INFO - PID 20278 | 17:54:39 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:54:39 INFO - PID 20278 | RSS: Main: 151334912 17:54:39 INFO - PID 20278 | 17:54:42 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:54:43 INFO - PID 20278 | RSS: Main: 152178688 17:54:43 INFO - PID 20278 | 17:54:44 INFO - PID 20278 | Cycle 1(1): loaded http://localhost:47104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47104/tests/kraken/driver.html?testName=ai-astar) 17:54:45 INFO - PID 20278 | RSS: Main: 153169920 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | __start_tp_report 17:54:45 INFO - PID 20278 | _x_x_mozilla_page_load 17:54:45 INFO - PID 20278 | _x_x_mozilla_page_load_details 17:54:45 INFO - PID 20278 | |i|pagename|runs| 17:54:45 INFO - PID 20278 | |0;ai-astar;106;105;104;105;105;106;107;106;105;107 17:54:45 INFO - PID 20278 | |1;audio-beat-detection;110;109;110;110;112;111;112;139;115;112 17:54:45 INFO - PID 20278 | |2;audio-dft;161;164;161;162;160;163;162;161;161;160 17:54:45 INFO - PID 20278 | |3;audio-fft;73;73;75;72;73;75;75;74;73;74 17:54:45 INFO - PID 20278 | |4;audio-oscillator;79;77;78;76;76;76;77;79;77;76 17:54:45 INFO - PID 20278 | |5;imaging-gaussian-blur;117;113;116;113;113;115;114;114;109;113 17:54:45 INFO - PID 20278 | |6;imaging-darkroom;150;146;148;148;148;148;148;148;148;149 17:54:45 INFO - PID 20278 | |7;imaging-desaturate;94;93;94;94;95;93;94;94;94;96 17:54:45 INFO - PID 20278 | |8;json-parse-financial;47;42;43;44;43;46;44;42;42;43 17:54:45 INFO - PID 20278 | |9;json-stringify-tinderbox;35;36;35;35;36;35;35;35;36;35 17:54:45 INFO - PID 20278 | |10;stanford-crypto-aes;70;69;75;69;69;69;69;67;70;68 17:54:45 INFO - PID 20278 | |11;stanford-crypto-ccm;104;104;103;104;103;108;100;105;106;103 17:54:45 INFO - PID 20278 | |12;stanford-crypto-pbkdf2;146;156;150;154;155;158;154;160;153;157 17:54:45 INFO - PID 20278 | |13;stanford-crypto-sha256-iterative;61;60;60;59;64;56;61;58;61;56 17:54:45 INFO - PID 20278 | __end_tp_report 17:54:45 INFO - PID 20278 | __start_cc_report 17:54:45 INFO - PID 20278 | _x_x_mozilla_cycle_collect,669 17:54:45 INFO - PID 20278 | __end_cc_report 17:54:45 INFO - PID 20278 | __startTimestamp1508892885161__endTimestamp 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | ------- Summary: start ------- 17:54:45 INFO - PID 20278 | Number of tests: 14 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#0] ai-astar Cycles:10 Average:105.60 Median:106.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 17:54:45 INFO - PID 20278 | Values: 106.0 105.0 104.0 105.0 105.0 106.0 107.0 106.0 105.0 107.0 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#1] audio-beat-detection Cycles:10 Average:114.00 Median:112.00 stddev:8.94 (8.0%) stddev-sans-first:9.37 17:54:45 INFO - PID 20278 | Values: 110.0 109.0 110.0 110.0 112.0 111.0 112.0 139.0 115.0 112.0 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 17:54:45 INFO - PID 20278 | Values: 161.0 164.0 161.0 162.0 160.0 163.0 162.0 161.0 161.0 160.0 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#3] audio-fft Cycles:10 Average:73.70 Median:74.00 stddev:1.06 (1.4%) stddev-sans-first:1.09 17:54:45 INFO - PID 20278 | Values: 73.0 73.0 75.0 72.0 73.0 75.0 75.0 74.0 73.0 74.0 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:77.00 stddev:1.20 (1.6%) stddev-sans-first:1.05 17:54:45 INFO - PID 20278 | Values: 79.0 77.0 78.0 76.0 76.0 76.0 77.0 79.0 77.0 76.0 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:2.16 (1.9%) stddev-sans-first:1.94 17:54:45 INFO - PID 20278 | Values: 117.0 113.0 116.0 113.0 113.0 115.0 114.0 114.0 109.0 113.0 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:0.78 17:54:45 INFO - PID 20278 | Values: 150.0 146.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 149.0 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 17:54:45 INFO - PID 20278 | Values: 94.0 93.0 94.0 94.0 95.0 93.0 94.0 94.0 94.0 96.0 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#8] json-parse-financial Cycles:10 Average:43.60 Median:43.50 stddev:1.71 (3.9%) stddev-sans-first:1.30 17:54:45 INFO - PID 20278 | Values: 47.0 42.0 43.0 44.0 43.0 46.0 44.0 42.0 42.0 43.0 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#9] json-stringify-tinderbox Cycles:10 Average:35.30 Median:35.00 stddev:0.48 (1.4%) stddev-sans-first:0.50 17:54:45 INFO - PID 20278 | Values: 35.0 36.0 35.0 35.0 36.0 35.0 35.0 35.0 36.0 35.0 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#10] stanford-crypto-aes Cycles:10 Average:69.50 Median:69.00 stddev:2.12 (3.1%) stddev-sans-first:2.24 17:54:45 INFO - PID 20278 | Values: 70.0 69.0 75.0 69.0 69.0 69.0 69.0 67.0 70.0 68.0 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#11] stanford-crypto-ccm Cycles:10 Average:104.00 Median:104.00 stddev:2.11 (2.0%) stddev-sans-first:2.24 17:54:45 INFO - PID 20278 | Values: 104.0 104.0 103.0 104.0 103.0 108.0 100.0 105.0 106.0 103.0 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:155.50 stddev:4.03 (2.6%) stddev-sans-first:2.95 17:54:45 INFO - PID 20278 | Values: 146.0 156.0 150.0 154.0 155.0 158.0 154.0 160.0 153.0 157.0 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:60.50 stddev:2.46 (4.1%) stddev-sans-first:2.55 17:54:45 INFO - PID 20278 | Values: 61.0 60.0 60.0 59.0 64.0 56.0 61.0 58.0 61.0 56.0 17:54:45 INFO - PID 20278 | -------- Summary: end -------- 17:54:45 INFO - PID 20278 | 17:54:45 INFO - PID 20278 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:54:45 INFO - TEST-INFO | 20278: exit 0 17:54:45 INFO - TEST-OK | kraken | took 57609ms 17:54:45 INFO - SUITE-END | took 1163s 17:54:45 INFO - Completed test suite (00:19:24) 17:54:45 INFO - javascript benchmark 17:54:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9505.863467718273, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4027.5972402759717, 4047.0, 4047.6154765297288, 4057.107436364001, 4076.021754778854, 6501.577397469161, 6506.54454188207, 6576.408123268905, 6600.636964966925, 6601.50488713346, 6524.217093948733, 6529.706163222654, 6593.0769692243, 6615.966920165404, 6620.801375958717, 5857.76568937242, 5868.2664666916635, 5882.235309409771, 5930.673812940276, 5947.88104237915, 5868.325142608591, 5876.0598304271325, 5889.411058894098, 5918.319393269786, 5963.791267305645, 5883.852903677421, 5925.081612350093, 5989.371116032819, 6012.639241645494, 6019.879602407949, 5841.824745257649, 5994.400559943971, 6001.129836173752, 6007.128966299906, 6022.126791615235, 5816.738246778905, 5867.383924687889, 5890.734916928705, 5976.133460648225, 6007.038873780174, 6388.105665206875, 6394.040893865911, 6401.871962560723, 6433.678316084177, 6452.645104519296, 7045.365917067437, 7053.294670532957, 7073.540219885691, 7083.929160708379, 7086.2205157432645, 7000.929990700079, 7058.435325173974, 7082.822929426754, 7176.784696459063, 7184.964075179643, 6482.708278127401, 6533.248676402274, 6578.440832529241, 6587.868242635121, 6632.270450250517, 7177.246389129171, 7177.246389129171, 7189.424846012306, 7192.3886469649615, 7259.9274007259255, 6913.930860691429, 6960.37356637905, 6997.685104170325, 7008.92991070093, 7018.052562904045, 7030.402415794612, 7031.156261248683, 7118.28817118284, 7137.714491420389, 7139.785806425712, 6912.516123871382, 6965.895511567331, 6974.337437943387, 7057.505974581833, 7062.329078737512, 7000.649967501605, 7005.0, 7039.472039596948, 7039.788806335818, 7064.011038454621, 5239.187925871496, 5266.394364648115, 5306.681599103988, 5308.681479111188, 5309.150535914235, 4755.0489902019735, 4801.927971080437, 4862.197737373293, 4862.440819305825, 4869.732164730903, 6551.508636852255, 6605.207375115017, 6610.206775187008, 6680.3987641112535, 6689.5986240825705, 7054.894176587355, 7056.894146587805, 7061.89407158893, 7100.076989991268, 7101.964490177619, 6520.543561950618, 6592.110065141144, 6684.1978962523835, 6685.09751183584, 6697.966510167418, 5843.766249349978, 5915.852103697356, 5985.700714964234, 5988.0, 6005.0, 7243.348098671145, 7327.63361831917, 7410.444216683771, 7414.962925185339, 7425.480216384801, 6962.234154242928, 7015.193252775996, 7024.438044956289, 7044.894326585208, 7046.365827075588, 7264.34620884123, 7278.053852999076, 7314.634268286671, 7393.408527317909, 7406.037215161994, 6860.828479288058, 6921.134858142732, 6936.7225310989015, 6940.7917762467205, 6967.7212911482975, 7036.859262814817, 7074.893876591958, 7074.964625176841, 7089.291070892869, 7115.146182458138, 6778.966105169443, 6827.146606674166, 6834.555753875982, 6886.690098945459, 6920.446364290945, 6737.865242695217, 6807.9319206807295, 6808.38724514796, 6810.591364517946, 6821.079154314302, 6723.0, 6728.428083612947, 6743.5953842769595, 6749.763758268437, 6759.898601520883, 6845.422092814447, 6873.931260687329, 6877.518573699793, 6943.75696850628, 7008.929910700827, 6619.66901654925, 6692.799216023527, 6712.2616512184595, 6752.966235168793, 6758.493113016445], "value": 6480.107582556358, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [977.2182254196646, 999.6401295533602, 1024.9436281004544, 1051.9474026298683, 1054.2830875004993, 47042.76478617611, 47750.52249477504, 47876.0, 47928.520714792845, 48257.0, 46176.07647847041, 46339.0, 46355.536444635545, 46483.0, 46631.76684116574, 8249.58752062396, 8339.499630022188, 8373.330133589297, 8385.287250583708, 8386.790330241762, 8280.089190189074, 8340.499570025819, 8365.749027529153, 8367.372447066464, 8367.623456944422, 8277.296429803444, 8304.377171712116, 8350.498970061815, 8913.821723565525, 9114.270858331318, 8956.059613740561, 9037.096290370977, 9066.048064953151, 9069.863952040725, 9084.636614535411, 7849.979502664617, 7954.164812694699, 7970.601469926481, 7975.680972761083, 7982.401319900972, 42079.0, 43334.0, 43977.78011109956, 44068.3389749154, 44167.33748993768, 3840.0783811885226, 3857.537095548524, 3861.8262178201767, 3869.419587061935, 3883.592222816592, 35952.28095438077, 36111.27777444463, 36119.0, 36319.0, 36364.454533182026, 5546.500814926676, 5646.774129034834, 5720.8283751487525, 5728.541716662657, 5765.971170144165, 246994.0, 248072.0, 248143.0, 248321.0, 248714.75642621852, 56330.43669563252, 56388.15417768737, 56443.71778141165, 56543.0, 56736.43263567394, 56772.0, 56896.431035689944, 57022.0, 57038.14442783361, 57238.7138064307, 18782.906085469484, 18806.435806925812, 18976.335828245945, 19005.714914276297, 19037.238510459705, 15761.921190394203, 15799.684006319809, 15839.049657020616, 15842.28709708066, 15846.524604261891, 15574.299156537983, 15880.285387157375, 15931.0, 16083.115428651536, 16093.114878681785, 6198.380161983766, 6288.622682639057, 6294.569459644505, 6310.242770867525, 6352.333005034405, 1076.4886678827652, 1085.9022687958122, 1098.5990113608634, 1108.490094556513, 1120.815065514181, 26047.218583442525, 26199.214023579323, 26254.0, 26340.419574825188, 26545.203643890713, 1215.7203843116133, 1220.5710635834625, 1228.969275768113, 1231.0889941443268, 1238.2446707508414, 13690.0, 13872.722545549033, 14002.57992260234, 14010.159390436402, 14012.579622611338, 286747.0, 328149.0, 328435.0, 332014.0, 333272.0, 67843.32156678468, 68249.65875170691, 68277.99999999901, 68458.0, 68514.0, 1504.4057597249243, 1557.548310989823, 1573.1347758732652, 1575.9369625214863, 1595.3618552579062, 31996.040118796474, 32271.0, 32439.189020274684, 32643.34713305768, 32714.0, 45015.324770127816, 45161.0, 45195.0, 45195.774021129684, 45295.547044529136, 276951.0, 277604.0, 278885.0, 279310.0, 279917.0, 40090.0, 40157.19685606213, 40201.59798401978, 40342.39486407765, 40702.59297407106, 49570.752146240484, 51108.0, 51225.74387128041, 51356.22965655443, 51992.480075198764, 36174.0, 36282.27435451329, 36814.63185368219, 36874.26251474902, 36950.0, 36795.81602091972, 37000.44499332566, 37252.25495490021, 37687.0, 37696.057598560255, 42437.1512569753, 43476.565234347254, 43675.0, 44116.0, 44240.0, 35057.0, 35166.47250291299, 35476.290474190886, 35536.644633554366, 35858.0, 25539.48921021532, 25830.61254081228, 26033.349166270993, 26202.73797262003, 26856.462870742867], "value": 19951.38890616874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.0600213322989, 639.4020778178133, 641.6726396832596, 641.8165945679685, 655.5574986883854, 24430.38924026898, 25248.116315928946, 25267.873660631692, 25271.74728252717, 25297.0, 27290.317742056457, 27594.0, 27652.58521122185, 27667.0, 27708.445831083416, 6641.335866413357, 6988.545744526615, 7007.649617519129, 7030.648467576626, 7036.753713620024, 6996.650167491631, 7030.753923612649, 7067.787966360992, 7084.539504932189, 7092.113485814273, 6688.5986840789465, 6940.514164008521, 6947.548409353401, 6953.33943275388, 6974.267701891305, 6911.343422374892, 6952.339527744856, 6959.61722105284, 6969.5121341505865, 6975.79072627822, 6477.708503117371, 6511.28375878653, 6537.477001839841, 6542.901856472156, 6577.04632828242, 30017.549736753965, 30403.543946840815, 30563.388732225452, 30569.23576910595, 30613.540796888065, 2393.4734358441287, 2438.366024833556, 2438.6220135878966, 2440.670509481215, 2443.0, 20561.4859628509, 20980.0, 20988.055537500695, 21009.0, 21026.789732102636, 2619.8428094314213, 2622.593498007812, 2713.6200931869553, 2713.9050133245437, 2731.2762118038536, 134705.0, 138187.0, 156118.0, 161716.0, 163154.3684563151, 15881.602959926095, 16679.166041697867, 16749.24628391725, 17351.739723904153, 17385.739213911547, 27147.592786108224, 27210.1836944892, 27254.45491090167, 27306.0, 27376.72623273742, 11523.48144333507, 11625.18623696333, 11638.635511683118, 11731.88268117308, 11819.290842549475, 10595.099416549525, 10674.839877401846, 10683.305585137097, 10697.251192416456, 10766.354018758899, 10013.0, 10137.13834324076, 10174.236932230113, 10338.172946164288, 10430.530626121843, 3151.416987857254, 3163.351512939842, 3165.7467402607735, 3166.366726654678, 3168.8574014169417, 1049.8162821506205, 1055.2560444886337, 1069.4492336446735, 1073.7906108308962, 1080.0603474976663, 21112.683309750366, 21525.892370538048, 21532.569348613255, 21926.45183870416, 22139.55720885573, 1117.4915413486844, 1137.5108703257513, 1157.2073129906041, 1158.6002829023973, 1160.3038177093845, 11725.4137293135, 12060.879391206152, 12112.697182570506, 12140.878591214152, 12159.209651372632, 589849.0, 597258.0, 617200.0, 632899.0, 635244.0, 129956.70043299635, 130507.0, 132694.0, 133207.0, 133506.0, 1144.6108323170163, 1163.8836116388463, 1245.3337464456654, 1261.2054405724334, 1289.3682095773004, 22361.888190558944, 22704.772952270927, 22776.658350125093, 22869.19957801469, 23074.769252307262, 68611.3138868625, 69047.65476172588, 69478.65260673664, 70334.64832675803, 70897.6455117721, 83158.0, 86798.56600717209, 87790.12209878075, 88011.0, 89187.0, 16129.919350403174, 16364.590885227964, 16386.754198687267, 16450.588735281235, 16491.34034638649, 25221.243362699148, 25238.49523009566, 25379.36551586225, 25471.10851120276, 25621.231363059138, 18994.145263462902, 20069.09689064025, 20113.2960346393, 20312.492187695425, 20327.28854490145, 17069.829301706824, 17665.646687065928, 17891.642167156322, 18354.0, 18405.987670677707, 20674.793252067288, 20731.8963405182, 20885.582288354453, 20950.685739714223, 21046.368608941757, 16176.514704558882, 16237.59406014859, 16271.593210169367, 16313.10277934725, 16411.507654770376, 19743.0, 20506.79493205049, 20545.691814623093, 20560.58878822445, 20883.26908558193], "value": 13377.630922765586, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.5422237772725, 1451.8402975672675, 1457.507661898154, 1461.1160248049923, 1483.3547406878006, 17247.913760431195, 17805.7329140063, 17807.910960445195, 17812.376566820163, 17840.107994600283, 17353.826461735378, 17470.737938930924, 17500.64998700025, 17524.948503089825, 17531.38640147595, 2943.249471384794, 3026.334206474572, 3119.3761247750426, 3120.1263646179104, 3122.35991621717, 2753.4493101379703, 3052.923676908073, 3080.722734953854, 3086.1204556701346, 3098.2254436390904, 3100.503919372901, 3133.623965124188, 3133.7022982816598, 3136.84315784211, 3147.2446612812987, 2932.0470846974818, 2961.0376627596115, 2965.5255159174644, 2975.5536669499534, 2981.329200929795, 2783.4572258409617, 2844.2320573445054, 2846.4734024205586, 2851.2301678546883, 2870.1102658176032, 16942.661146776994, 17243.0, 17267.136643167792, 17267.30930762768, 17334.133293335282, 8989.86515202266, 9228.907710922938, 9257.444553326755, 9272.119148680864, 9313.022132676038, 5744.770209191627, 6171.074338849164, 6239.781607643756, 6280.0, 6439.613623182578, 2265.490264690448, 2266.138867230442, 2274.65880117982, 2275.294658655822, 2334.2763743239652, 32504.349913001606, 32638.836805816056, 32650.346993060244, 32695.0, 32716.182095447566, 7606.885896711554, 7625.0, 7671.462997590115, 7795.649195786204, 7797.610119494003, 20823.79176208249, 20857.791422085887, 20870.895645521978, 21013.159473620883, 21022.579548409252, 8881.511516866505, 9036.32227582934, 9057.728268151966, 9069.0, 9076.591553380114, 8172.959135204286, 8182.22268884455, 8199.0, 8402.663893444316, 8408.117147699526, 6231.937680623227, 6284.622922624657, 6305.4009869062365, 6312.274088479791, 6425.100485931974, 1724.629204720991, 1777.9555511112067, 1858.27527264367, 1866.0949439521821, 1916.2430839818473, 1010.7169992402139, 1017.9541920613442, 1028.7942411517577, 1041.1774697988503, 1052.4895425718673, 9986.700398988041, 10191.796164076677, 10256.230782691178, 10295.3822770634, 10315.690529284133, 1084.38732116354, 1100.9504572294265, 1107.2360071550604, 1117.7317443813588, 1121.360824330124, 5990.460858522754, 6196.225471816023, 6202.782902598387, 6311.96844015777, 6378.904316435257, 26282.73717262841, 26535.601965970527, 26695.733042669326, 27085.729142708715, 27227.86386068057, 26126.86936565305, 26245.34386640311, 26626.0, 26785.732142678324, 26896.59655105175, 12926.030547708959, 13127.212367257804, 13218.272994985176, 13248.470061197444, 13296.468141274434, 9338.906610933804, 9366.344355895022, 9390.76523086901, 9420.717378478657, 9438.622455101719, 22342.21802236914, 22412.0, 22769.0, 22984.195553155558, 23180.304590862303, 23765.287041388787, 23863.642045368986, 23874.522509549366, 23976.520469590163, 24052.639210412206, 12748.745025099632, 12952.481900723866, 13069.215847049207, 13070.281134537692, 13073.346332683517, 15991.120488372786, 16107.516774496784, 16110.758338625164, 16142.515724528283, 16355.0, 13212.207267563977, 13263.80104298417, 13532.391042402918, 13635.795463067863, 13725.245111518961, 12052.0, 12112.45493952792, 12129.454174562343, 12145.757084858431, 12494.437750301076, 11614.593489227836, 11687.415629218334, 11711.355875426592, 11720.824187637021, 11773.88226117728, 8935.821283574422, 8996.55017249148, 9057.36598438103, 9142.0, 9226.40028398152, 9064.274858011211, 9255.907440925774, 9280.767980800263, 9300.488473133772, 9393.201577865684], "value": 7798.7258613460235, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.6792995922284, 573.6529399713176, 578.4735890339791, 609.4758507683392, 617.2469587103735, 6079.270487541496, 6249.687515624218, 6334.746610135589, 6352.269489008754, 6363.204599425072, 6267.811965641038, 6279.560430769848, 6300.684965751717, 6324.9051264231075, 6336.841578960528, 5218.425973142951, 5227.424983251839, 5238.292830467876, 5266.236395722618, 5268.235141227674, 5054.1660625996665, 5068.74656267187, 5141.100307446182, 5145.768440420171, 5242.1088414969545, 5065.721385323805, 5080.1617733074, 5085.211792172201, 5111.948880511184, 5113.846584602468, 5010.348654674869, 5037.219231019198, 5044.974775126101, 5074.441811400761, 5074.695518268915, 4644.0, 4655.208614535537, 4672.299155126724, 4672.392588963413, 4687.742174180418, 6239.65681887496, 6255.781047663356, 6287.434130928238, 6309.716062777186, 6380.393862583047, 5926.911096333559, 5949.970250148722, 5987.461128498456, 6035.215421995156, 6079.787207447718, 6678.365555272241, 6696.531242813005, 6710.0, 6725.394714475672, 6773.3903948644365, 5029.723365214912, 5222.451642577551, 5242.135047717122, 5250.8780607223525, 5267.3152490176035, 6873.381395674363, 6874.621895795729, 6960.338767817049, 6973.594110032031, 6980.616066116361, 5275.472452754694, 5298.0, 5309.283246761715, 5339.19472474768, 5357.544608708304, 5342.412334643186, 5366.275552800322, 5413.918791218135, 5414.648047876875, 5417.8103766367985, 5845.707714614252, 5906.940930590725, 5917.585768996215, 5974.103884417372, 6029.638221706711, 6694.556486882253, 6753.831154221086, 6762.560433571802, 6766.323367663194, 6830.282820303896, 1825.3884948542386, 1854.5456363190835, 1855.1559040636478, 1859.730339100823, 1866.5986812835306, 1280.257450678604, 1336.3318340829585, 1336.8729970652967, 1343.6775173958179, 1366.152985149214, 6312.116303717483, 6324.102769169231, 6349.174607301022, 6374.171357723466, 6396.456301214449, 6718.496112791462, 6718.865622687519, 6727.091842601186, 6763.560368576027, 6823.863522729617, 6316.336784637639, 6375.521835862236, 6383.957133717258, 6392.520560957947, 6410.8717825643225, 3562.2163124112653, 3580.445031020196, 3606.314800187956, 3610.1696609779897, 3628.165521929971, 7151.678174482161, 7180.066591343092, 7183.958326042694, 7214.314640109181, 7223.349898509159, 7034.788956331318, 7035.33164349386, 7046.224915259318, 7053.365197132282, 7062.293770623, 7078.610676412847, 7208.927910720826, 7215.639218039182, 7233.493655444068, 7258.818529536698, 6797.72809087631, 6818.21590517077, 6828.36119331347, 6851.554648947803, 6887.724491020504, 6654.3012983637955, 6710.328967103446, 6734.898976515454, 6813.931860681329, 6821.249662537216, 7098.0, 7170.569765813859, 7186.784396468114, 7220.277972202948, 7264.963675181591, 5360.678359298455, 5373.570114390917, 5378.139497680352, 5379.757910893941, 5395.622306438669, 6549.443297319781, 6800.93199068003, 6840.965795170992, 6932.376086152271, 6932.722691092502, 6211.9068213975925, 6564.901526477011, 6624.436922861611, 6655.23464801554, 6695.163104611924, 6577.80266592003, 6591.011348297794, 6661.16735408074, 6687.598744075371, 6694.364035416823, 6600.679864027118, 6602.504812139013, 6624.9337506624315, 6625.701843417154, 6625.834354141185, 6695.598264104169, 6699.497537684791, 6714.294999025032, 6722.991551267153, 6758.290379510081, 6292.179733746358, 6435.903461448176, 6500.512461565307, 6537.0, 6605.5376123670885], "value": 5284.6662660188495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1000.1898462245582, 1023.9948800255997, 1030.1346868630349, 1030.7062487191151, 1041.213883517944, 20471.874046927413, 20812.0, 21012.99999999998, 21062.789372106276, 21258.89370553147, 20344.69482957757, 20815.16739330425, 20824.8958755206, 20865.68701469479, 20895.37313880586, 1059.9523021464033, 1080.3193987787683, 1081.5403453532256, 1092.0, 1093.518851705251, 1084.3873211635441, 1111.727626731452, 1121.0863146535548, 1121.6578943422253, 1121.7812526557325, 1152.262551966742, 1155.6013175454498, 1157.9826302605468, 1158.6350299655583, 1159.8782127876577, 1120.9663710088669, 1128.7008942630127, 1131.7510147767478, 1133.6769020829065, 1135.4606561883122, 832.0473058348218, 832.1054866018993, 832.5545832979327, 836.619338201117, 838.1367191792464, 21234.89382553093, 21318.89340553303, 21601.783982160134, 21657.133714651394, 22892.771072289397, 23075.307740767803, 23994.040238390444, 24238.515229695306, 24392.87803560971, 24413.145539906018, 18002.729959050626, 18229.17968691412, 18278.0, 18429.907850460797, 18437.631247375113, 4186.66506679468, 4208.789560521962, 4230.428892099589, 4237.0, 4239.660827133822, 163062.0, 169909.0, 171882.0, 171939.14030429767, 172503.0, 18596.628067438574, 18697.813021869606, 18728.0, 18833.90583047076, 19076.904615476833, 34584.13539661529, 35396.29207415837, 36159.27681446356, 36225.637743622756, 36285.0, 10655.893441065646, 10667.89332106669, 10696.78606427867, 10757.408342541235, 10789.892101078889, 4969.105560998983, 5060.671056381323, 5083.5678967288195, 5095.541401273903, 5102.464241254689, 6349.365063493706, 6377.936220637827, 6384.3934826191435, 6404.231492220963, 6413.326600706859, 1161.7095726068483, 1189.3280296632374, 1200.5737963023, 1209.8850609192114, 1213.0356366688504, 769.4152444142492, 777.793884620576, 780.9726659566888, 793.9603019848985, 801.5551368990266, 13378.46486140563, 13742.244176570184, 13880.236586987812, 13912.30438478072, 14065.85934140666, 757.5189754505928, 760.0727112922226, 762.3405754022731, 762.6186906546727, 777.4014009212874, 6519.674016299166, 6556.836079097965, 6616.305287944792, 6640.203175618956, 6725.226598941086, 156418.21790890972, 156482.0, 158848.0, 159796.0, 161433.0, 137029.0, 137256.0, 139830.0, 141343.0, 142319.0, 122672.24838653482, 123941.0, 124740.0, 125498.37250813688, 126000.36999814943, 12523.56167534132, 12605.810912836498, 12618.810717839424, 12635.431405586587, 12879.227246365248, 59837.40162598492, 60446.697766510886, 60937.390626094944, 61680.383196167466, 62780.0, 72462.63768681123, 74126.62936685282, 74165.6291718538, 74700.2529974715, 75785.62107189429, 17186.82813171852, 17329.56676083108, 17500.387486437914, 17533.21100550504, 17652.205650746004, 18544.443666690022, 18581.81418185855, 18943.71584426207, 19027.524311892314, 19165.712514312017, 18555.165017574513, 18845.0, 19014.524636884187, 19037.0, 19053.80946190576, 16898.40855570049, 17071.31714731397, 17074.48776536706, 17271.13644317754, 17351.47945561635, 18092.185851636972, 18117.365892194237, 18234.179461924512, 18323.72514412258, 18331.17509712093, 12862.614121576367, 12862.935685321514, 13056.151350162208, 13155.605331839677, 13272.13731107475, 14033.508827190999, 14057.789133162807, 14070.577882663536, 14074.366653500821, 14212.573622791333], "value": 10350.151357049761, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1354.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 104.0, 105.0, 105.0, 106.0, 107.0, 106.0, 105.0, 107.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 110.0, 110.0, 112.0, 111.0, 112.0, 139.0, 115.0, 112.0], "value": 114.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 161.0, 162.0, 160.0, 163.0, 162.0, 161.0, 161.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 72.0, 73.0, 75.0, 75.0, 74.0, 73.0, 74.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 76.0, 76.0, 76.0, 77.0, 79.0, 77.0, 76.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 116.0, 113.0, 113.0, 115.0, 114.0, 114.0, 109.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 95.0, 93.0, 94.0, 94.0, 94.0, 96.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 42.0, 43.0, 44.0, 43.0, 46.0, 44.0, 42.0, 42.0, 43.0], "value": 43.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [35.0, 36.0, 35.0, 35.0, 36.0, 35.0, 35.0, 35.0, 36.0, 35.0], "value": 35.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 75.0, 69.0, 69.0, 69.0, 69.0, 67.0, 70.0, 68.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 104.0, 103.0, 104.0, 103.0, 108.0, 100.0, 105.0, 106.0, 103.0], "value": 104.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 156.0, 150.0, 154.0, 155.0, 158.0, 154.0, 160.0, 153.0, 157.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 59.0, 64.0, 56.0, 61.0, 58.0, 61.0, 56.0], "value": 59.6, "unit": "score"}]}]} 17:54:45 INFO - Return code: 0 17:54:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:54:45 INFO - # TBPL SUCCESS # 17:54:45 INFO - Running post-action listener: _package_coverage_data 17:54:45 INFO - Running post-action listener: _resource_record_post_action 17:54:45 INFO - [mozharness: 2017-10-25 00:54:45.942726Z] Finished run-tests step (success) 17:54:45 INFO - Running post-run listener: _resource_record_post_run 17:54:46 INFO - Total resource usage - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293298176; Read time: 4; Write time: 209560 17:54:46 INFO - TinderboxPrint: CPU usage
13.0% 17:54:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 17:54:46 INFO - TinderboxPrint: I/O write bytes / time
293,298,176 / 209,560 17:54:46 INFO - TinderboxPrint: CPU idle
8,174.0 (86.9%) 17:54:46 INFO - TinderboxPrint: CPU user
1,177.5 (12.5%) 17:54:46 INFO - TinderboxPrint: Swap in / out
0 / 0 17:54:46 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9121792; Read time: 0; Write time: 1256 17:54:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:54:46 INFO - run-tests - Wall time: 1164s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284176384; Read time: 4; Write time: 208304 17:54:46 INFO - Running post-run listener: _upload_blobber_files 17:54:46 INFO - Blob upload gear active. 17:54:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:54:46 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 17:54:46 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'] 17:54:46 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 17:54:46 INFO - (blobuploader) - INFO - Open directory for files ... 17:54:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:54:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:54:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:47 INFO - (blobuploader) - INFO - Done attempting. 17:54:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:54:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:54:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:48 INFO - (blobuploader) - INFO - Done attempting. 17:54:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:54:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:54:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:55 INFO - (blobuploader) - INFO - Done attempting. 17:54:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:54:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:54:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:56 INFO - (blobuploader) - INFO - Done attempting. 17:54:56 INFO - (blobuploader) - INFO - Iteration through files over. 17:54:56 INFO - Return code: 0 17:54:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:54:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:54:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5dcb0652f3e336cd54577b9ae96a04ae477b497cdd5d8fd8a501d3696ccdc095cdfd7ae5f9571acdcdecb0893be20ff26ef787d5866f4679ed5e6b553f65259b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1ef90ca7f6a4345bf2c6c3a0e5d7a1b4e05e3594f6f0f34098c5a0596045e4c6d62aa81026a444c88c567d6e1943bf455a04b731029588785e7c68300ff5318f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e0ee925e49d7058b7d1dfee73aad13ebe32305c59306d472947bc82c7e691356b69819d592ac68504fd22dc1cf4a42e6dc2b9748e98f01600de1eb33da870966", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/23b9214b15ca82ebe1962eb2f4272867c945f0a99281538e1c4947e4da811820193d238b13ac15907ed9e9757af872413a9479106b19be1bfe0043467d42f619"} 17:54:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:54:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:54:56 INFO - Contents: 17:54:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5dcb0652f3e336cd54577b9ae96a04ae477b497cdd5d8fd8a501d3696ccdc095cdfd7ae5f9571acdcdecb0893be20ff26ef787d5866f4679ed5e6b553f65259b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1ef90ca7f6a4345bf2c6c3a0e5d7a1b4e05e3594f6f0f34098c5a0596045e4c6d62aa81026a444c88c567d6e1943bf455a04b731029588785e7c68300ff5318f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e0ee925e49d7058b7d1dfee73aad13ebe32305c59306d472947bc82c7e691356b69819d592ac68504fd22dc1cf4a42e6dc2b9748e98f01600de1eb33da870966", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/23b9214b15ca82ebe1962eb2f4272867c945f0a99281538e1c4947e4da811820193d238b13ac15907ed9e9757af872413a9479106b19be1bfe0043467d42f619"} 17:54:56 INFO - Running post-run listener: copy_logs_to_upload_dir 17:54:56 INFO - Copying logs to upload dir... 17:54:56 INFO - mkdir: /builds/slave/test/build/upload/logs 17:54:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.532560 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-10-24 17:54:57.017027) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-24 17:54:57.021039) ========= 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=62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882 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/5dcb0652f3e336cd54577b9ae96a04ae477b497cdd5d8fd8a501d3696ccdc095cdfd7ae5f9571acdcdecb0893be20ff26ef787d5866f4679ed5e6b553f65259b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1ef90ca7f6a4345bf2c6c3a0e5d7a1b4e05e3594f6f0f34098c5a0596045e4c6d62aa81026a444c88c567d6e1943bf455a04b731029588785e7c68300ff5318f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e0ee925e49d7058b7d1dfee73aad13ebe32305c59306d472947bc82c7e691356b69819d592ac68504fd22dc1cf4a42e6dc2b9748e98f01600de1eb33da870966", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/23b9214b15ca82ebe1962eb2f4272867c945f0a99281538e1c4947e4da811820193d238b13ac15907ed9e9757af872413a9479106b19be1bfe0043467d42f619"} build_url:https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011533 build_url: 'https://queue.taskcluster.net/v1/task/GqEimflOS1iRhfkrfZBhzg/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/5dcb0652f3e336cd54577b9ae96a04ae477b497cdd5d8fd8a501d3696ccdc095cdfd7ae5f9571acdcdecb0893be20ff26ef787d5866f4679ed5e6b553f65259b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1ef90ca7f6a4345bf2c6c3a0e5d7a1b4e05e3594f6f0f34098c5a0596045e4c6d62aa81026a444c88c567d6e1943bf455a04b731029588785e7c68300ff5318f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e0ee925e49d7058b7d1dfee73aad13ebe32305c59306d472947bc82c7e691356b69819d592ac68504fd22dc1cf4a42e6dc2b9748e98f01600de1eb33da870966", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/23b9214b15ca82ebe1962eb2f4272867c945f0a99281538e1c4947e4da811820193d238b13ac15907ed9e9757af872413a9479106b19be1bfe0043467d42f619"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-24 17:54:57.051817) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 17:54:57.052241) ========= 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=62c568580acbfdaac3eec7be000001dc-1508891663.195516-1056523882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 17:54:57.138014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-24 17:54:57.138368) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-24 17:54:57.138729) ========= ========= Total master_lag: 0.20 =========