builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-079 starttime: 1507015885.11 results: success (0) revision: 1d3559680c3ec9916e08f10c0007ed476ccfdff1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:25.108934) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:25.109393) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:25.109665) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:25.127849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:25.128200) ========= 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=1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-03 00:31:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-10-03 00:31:25 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074940 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:25.221441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:25.221742) ========= 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=1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024680 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:25.273954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:25.274290) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1d3559680c3ec9916e08f10c0007ed476ccfdff1 --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 1d3559680c3ec9916e08f10c0007ed476ccfdff1 --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=1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-03 00:31:25,827 truncating revision to first 12 chars 2017-10-03 00:31:25,827 Setting DEBUG logging. 2017-10-03 00:31:25,827 attempt 1/10 2017-10-03 00:31:25,827 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1d3559680c3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-03 00:31:26,215 unpacking tar archive at: mozilla-beta-1d3559680c3e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.690664 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:25.981074) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:25.981345) ========= script_repo_revision: 1d3559680c3ec9916e08f10c0007ed476ccfdff1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:25.981706) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:25.985046) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 00:31:26.001333) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-10-03 00:31:26.001649) ========= /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=1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:31:26 INFO - MultiFileLogger online at 20171003 00:31:26 in /builds/slave/test 00:31:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 00:31:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:31:26 INFO - {'append_to_log': False, 00:31:26 INFO - 'base_work_dir': '/builds/slave/test', 00:31:26 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 00:31:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:31:26 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 00:31:26 INFO - 'buildbot_json_path': 'buildprops.json', 00:31:26 INFO - 'code_coverage': False, 00:31:26 INFO - 'config_files': ('talos/linux_config.py',), 00:31:26 INFO - 'default_actions': ('clobber', 00:31:26 INFO - 'read-buildbot-config', 00:31:26 INFO - 'download-and-extract', 00:31:26 INFO - 'populate-webroot', 00:31:26 INFO - 'create-virtualenv', 00:31:26 INFO - 'install', 00:31:26 INFO - 'setup-mitmproxy', 00:31:26 INFO - 'run-tests'), 00:31:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:31:26 INFO - 'disable_ccov_upload': False, 00:31:26 INFO - 'disable_stylo': False, 00:31:26 INFO - 'download_minidump_stackwalk': True, 00:31:26 INFO - 'download_symbols': 'ondemand', 00:31:26 INFO - 'enable_stylo': False, 00:31:26 INFO - 'enable_webrender': False, 00:31:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 00:31:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:31:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:31:26 INFO - 'gecko_profile': False, 00:31:26 INFO - 'gecko_profile_interval': 0, 00:31:26 INFO - 'installer_path': 'installer.exe', 00:31:26 INFO - 'log_level': 'info', 00:31:26 INFO - 'log_name': 'talos', 00:31:26 INFO - 'log_to_console': True, 00:31:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:31:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:31:26 INFO - 'opt_config_files': (), 00:31:26 INFO - 'pip_index': False, 00:31:26 INFO - 'suite': 'dromaeojs-e10s', 00:31:26 INFO - 'system_bits': '32', 00:31:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:31:26 INFO - 'title': 'talos-linux64-ix-079', 00:31:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:31:26 INFO - 'use_talos_json': True, 00:31:26 INFO - 'verify': 'False', 00:31:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:31:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:31:26 INFO - 'work_dir': 'build'} 00:31:26 INFO - [mozharness: 2017-10-03 07:31:26.698044Z] Running clobber step. 00:31:26 INFO - Running pre-action listener: _resource_record_pre_action 00:31:26 INFO - Running main action method: clobber 00:31:26 INFO - rmtree: /builds/slave/test/build 00:31:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:31:28 INFO - Running post-action listener: _resource_record_post_action 00:31:28 INFO - [mozharness: 2017-10-03 07:31:28.212522Z] Finished clobber step (success) 00:31:28 INFO - [mozharness: 2017-10-03 07:31:28.212620Z] Running read-buildbot-config step. 00:31:28 INFO - Running pre-action listener: _resource_record_pre_action 00:31:28 INFO - Running main action method: read_buildbot_config 00:31:28 INFO - Using buildbot properties: 00:31:28 INFO - { 00:31:28 INFO - "project": "", 00:31:28 INFO - "product": "firefox", 00:31:28 INFO - "who": "ffxbld@noreply.mozilla.org", 00:31:28 INFO - "installer_path": "public/build/target.tar.bz2", 00:31:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 00:31:28 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 00:31:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 00:31:28 INFO - "stage_platform": "linux64", 00:31:28 INFO - "basedir": "/builds/slave/test", 00:31:28 INFO - "buildnumber": 150, 00:31:28 INFO - "platform": "ubuntu64_hw", 00:31:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:31:28 INFO - "slavebuilddir": "test", 00:31:28 INFO - "taskId": "UbhT9tjaS0mwBa42-fS_DQ", 00:31:28 INFO - "branch": "mozilla-beta", 00:31:28 INFO - "script_repo_revision": "production", 00:31:28 INFO - "revision": "1d3559680c3ec9916e08f10c0007ed476ccfdff1", 00:31:28 INFO - "slavename": "talos-linux64-ix-079", 00:31:28 INFO - "repo_path": "releases/mozilla-beta" 00:31:28 INFO - } 00:31:28 INFO - Finding installer, test and symbols from parent task. 00:31:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UbhT9tjaS0mwBa42-fS_DQ'}, attempt #1 00:31:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UbhT9tjaS0mwBa42-fS_DQ'}, attempt #1 00:31:29 INFO - Task dependencies: OK-m40jUR-mNArco46uLcw 00:31:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw'}, attempt #1 00:31:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.tar.bz2 00:31:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.test_packages.json 00:31:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.crashreporter-symbols.zip 00:31:29 INFO - Running post-action listener: _resource_record_post_action 00:31:29 INFO - [mozharness: 2017-10-03 07:31:29.534679Z] Finished read-buildbot-config step (success) 00:31:29 INFO - [mozharness: 2017-10-03 07:31:29.534896Z] Running download-and-extract step. 00:31:29 INFO - Running pre-action listener: _resource_record_pre_action 00:31:29 INFO - Running main action method: download_and_extract 00:31:29 INFO - mkdir: /builds/slave/test/build/tests 00:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:31:29 INFO - trying https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.test_packages.json 00:31:29 INFO - Downloading https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 00:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 00:31:30 INFO - Downloaded 989 bytes. 00:31:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:31:30 INFO - Using the following test package requirements: 00:31:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 00:31:30 INFO - u'common': [u'target.common.tests.zip'], 00:31:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:31:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:31:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:31:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:31:30 INFO - u'mozbase': [u'target.common.tests.zip'], 00:31:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:31:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:31:30 INFO - u'web-platform': [u'target.common.tests.zip', 00:31:30 INFO - u'target.web-platform.tests.tar.gz'], 00:31:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:31:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 00:31:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.common.tests.zip 00:31:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:31:30 INFO - Fetch https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.common.tests.zip into memory 00:31:31 INFO - Content-Length response header: 55180526 00:31:31 INFO - Bytes received: 55180526 00:31:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.talos.tests.zip 00:31:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 00:31:41 INFO - Fetch https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.talos.tests.zip into memory 00:31:42 INFO - Content-Length response header: 14509184 00:31:42 INFO - Bytes received: 14509184 00:31: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')]} 00:31:43 INFO - trying https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.tar.bz2 00:31:43 INFO - Downloading https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 00:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 00:31:44 INFO - Downloaded 53476378 bytes. 00:31:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.tar.bz2 00:31:44 INFO - mkdir: /builds/slave/test/properties 00:31:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:31:44 INFO - Writing to file /builds/slave/test/properties/build_url 00:31:44 INFO - Contents: 00:31:44 INFO - build_url:https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.tar.bz2 00:31:44 INFO - Running post-action listener: _resource_record_post_action 00:31:44 INFO - Running post-action listener: find_tests_for_verification 00:31:44 INFO - Running post-action listener: set_extra_try_arguments 00:31:44 INFO - [mozharness: 2017-10-03 07:31:44.254904Z] Finished download-and-extract step (success) 00:31:44 INFO - [mozharness: 2017-10-03 07:31:44.255002Z] Running populate-webroot step. 00:31:44 INFO - Running pre-action listener: _resource_record_pre_action 00:31:44 INFO - Running main action method: populate_webroot 00:31:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:31:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:31:44 INFO - 'tests': ['tresize', 00:31:44 INFO - 'tcanvasmark']}, 00:31:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:31:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:31:44 INFO - 'tests': ['dromaeo_css', 00:31:44 INFO - 'kraken']}, 00:31:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:31:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:31:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:31:44 INFO - 'talos_options': ['--disable-stylo'], 00:31:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:31:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:31:44 INFO - 'tests': ['damp', 'tps']}, 00:31:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:31:44 INFO - 'talos_options': ['--disable-stylo'], 00:31:44 INFO - 'tests': ['damp', 'tps']}, 00:31:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:31:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:31:44 INFO - 'tests': ['dromaeo_dom']}, 00:31:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 00:31:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:31:44 INFO - 'tests': ['basic_compositor_video', 00:31:44 INFO - 'glvideo']}, 00:31:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 00:31:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 00:31:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:31:44 INFO - 'talos_options': ['--disable-stylo'], 00:31:44 INFO - 'tests': ['ts_paint_webext', 00:31:44 INFO - 'tp5o_webext']}, 00:31:44 INFO - 'other-e10s': {'tests': ['a11yr', 00:31:44 INFO - 'ts_paint', 00:31:44 INFO - 'tpaint', 00:31:44 INFO - 'sessionrestore', 00:31:44 INFO - 'sessionrestore_many_windows', 00:31:44 INFO - 'sessionrestore_no_auto_restore', 00:31:44 INFO - 'tabpaint']}, 00:31:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:31:44 INFO - 'tests': ['a11yr', 00:31:44 INFO - 'ts_paint', 00:31:44 INFO - 'tpaint', 00:31:44 INFO - 'sessionrestore', 00:31:44 INFO - 'sessionrestore_many_windows', 00:31:44 INFO - 'sessionrestore_no_auto_restore', 00:31:44 INFO - 'tabpaint']}, 00:31:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 00:31:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 00:31:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:31:44 INFO - 'tests': ['perf_reftest_singletons']}, 00:31:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:31:44 INFO - 'tests': ['bloom_basic']}, 00:31:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:31:44 INFO - 'tsvgr_opacity', 00:31:44 INFO - 'tart', 00:31:44 INFO - 'tscrollx', 00:31:44 INFO - 'tsvg_static']}, 00:31:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:31:44 INFO - 'tests': ['tsvgx', 00:31:44 INFO - 'tsvgr_opacity', 00:31:44 INFO - 'tart', 00:31:44 INFO - 'tscrollx', 00:31:44 INFO - 'tsvg_static']}, 00:31:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:31:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:31:44 INFO - 'talos_options': ['--disable-stylo'], 00:31:44 INFO - 'tests': ['tp5o']}, 00:31:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:31:44 INFO - 'talos_options': ['--mitmproxy', 00:31:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:31:44 INFO - '--firstNonBlankPaint'], 00:31:44 INFO - 'tests': ['tp6_google', 00:31:44 INFO - 'tp6_youtube', 00:31:44 INFO - 'tp6_amazon', 00:31:44 INFO - 'tp6_facebook']}, 00:31:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:31:44 INFO - 'talos_options': ['--disable-stylo', 00:31:44 INFO - '--mitmproxy', 00:31:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:31:44 INFO - '--firstNonBlankPaint'], 00:31:44 INFO - 'tests': ['tp6_google', 00:31:44 INFO - 'tp6_youtube', 00:31:44 INFO - 'tp6_amazon', 00:31:44 INFO - 'tp6_facebook']}, 00:31:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:31:44 INFO - 'talos_options': ['--stylo-threads=1', 00:31:44 INFO - '--mitmproxy', 00:31:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:31:44 INFO - '--firstNonBlankPaint'], 00:31:44 INFO - 'tests': ['tp6_google', 00:31:44 INFO - 'tp6_youtube', 00:31:44 INFO - 'tp6_amazon', 00:31:44 INFO - 'tp6_facebook']}, 00:31:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:31:44 INFO - 'talos_options': ['--xperf_path', 00:31:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:31:44 INFO - 'tests': ['tp5n']}, 00:31:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:31:44 INFO - 'talos_options': ['--disable-stylo', 00:31:44 INFO - '--xperf_path', 00:31:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:31:44 INFO - 'tests': ['tp5n']}}} 00:31:44 INFO - Running post-action listener: _resource_record_post_action 00:31:44 INFO - [mozharness: 2017-10-03 07:31:44.270056Z] Finished populate-webroot step (success) 00:31:44 INFO - [mozharness: 2017-10-03 07:31:44.270145Z] Running create-virtualenv step. 00:31:44 INFO - Running pre-action listener: _resource_record_pre_action 00:31:44 INFO - Running main action method: create_virtualenv 00:31:44 INFO - Creating virtualenv /builds/slave/test/build/venv 00:31:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:31:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 00:31:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 00:31:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:31:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:31:44 INFO - Installing distribute.............................................................................................................................................................................................done. 00:31:45 INFO - Installing pip...............done. 00:31:45 INFO - Return code: 0 00:31:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:31:45 INFO - Reading from file tmpfile_stdout 00:31:45 INFO - Output received: 00:31:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 00:31:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:31: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')]} 00:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31: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')]} 00:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b090>, '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 0x148bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1485f90>, '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': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', '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 00:31: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', 'pip>=1.5'] in /builds/slave/test/build 00:31: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 pip>=1.5 00:31:45 INFO - Using env: {'DISPLAY': ':0', 00:31:45 INFO - 'HOME': '/home/cltbld', 00:31:45 INFO - 'LANG': 'en_US.UTF-8', 00:31:45 INFO - 'LANGUAGE': 'en_US:en', 00:31:45 INFO - 'LOGNAME': 'cltbld', 00:31:45 INFO - 'MAIL': '/var/mail/cltbld', 00:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:45 INFO - 'MOZ_NO_REMOTE': '1', 00:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:31:45 INFO - 'NO_EM_RESTART': '1', 00:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:45 INFO - 'PWD': '/builds/slave/test', 00:31:45 INFO - 'SHELL': '/bin/bash', 00:31:45 INFO - 'SHLVL': '1', 00:31:45 INFO - 'TERM': 'linux', 00:31:45 INFO - 'TMOUT': '86400', 00:31:45 INFO - 'USER': 'cltbld', 00:31:45 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', 00:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:45 INFO - '_': '/tools/buildbot/bin/python'} 00:31:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 00:31:46 INFO - Downloading/unpacking pip>=1.5 00:31:46 INFO - Running setup.py egg_info for package pip 00:31:46 INFO - warning: no files found matching 'pip/cacert.pem' 00:31:46 INFO - warning: no files found matching '*.html' under directory 'docs' 00:31:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:31:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:31:46 INFO - Installing collected packages: pip 00:31:46 INFO - Found existing installation: pip 1.1 00:31:46 INFO - Uninstalling pip: 00:31:46 INFO - Successfully uninstalled pip 00:31:46 INFO - Running setup.py install for pip 00:31:46 INFO - warning: no files found matching 'pip/cacert.pem' 00:31:46 INFO - warning: no files found matching '*.html' under directory 'docs' 00:31:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:31:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:31:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 00:31:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 00:31:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 00:31:46 INFO - Successfully installed pip 00:31:46 INFO - Cleaning up... 00:31:46 INFO - Return code: 0 00:31:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:31:46 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')]} 00:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:46 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')]} 00:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:46 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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b090>, '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 0x148bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1485f90>, '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': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', '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 00:31:46 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 00:31:46 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 00:31:46 INFO - Using env: {'DISPLAY': ':0', 00:31:46 INFO - 'HOME': '/home/cltbld', 00:31:46 INFO - 'LANG': 'en_US.UTF-8', 00:31:46 INFO - 'LANGUAGE': 'en_US:en', 00:31:46 INFO - 'LOGNAME': 'cltbld', 00:31:46 INFO - 'MAIL': '/var/mail/cltbld', 00:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:46 INFO - 'MOZ_NO_REMOTE': '1', 00:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:31:46 INFO - 'NO_EM_RESTART': '1', 00:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:46 INFO - 'PWD': '/builds/slave/test', 00:31:46 INFO - 'SHELL': '/bin/bash', 00:31:46 INFO - 'SHLVL': '1', 00:31:46 INFO - 'TERM': 'linux', 00:31:46 INFO - 'TMOUT': '86400', 00:31:46 INFO - 'USER': 'cltbld', 00:31:46 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', 00:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:46 INFO - '_': '/tools/buildbot/bin/python'} 00:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:46 INFO - Downloading/unpacking psutil>=3.1.1 00:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:31:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:31:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:31:47 INFO - Installing collected packages: psutil 00:31:47 INFO - Running setup.py install for psutil 00:31:48 INFO - building 'psutil._psutil_linux' extension 00:31:48 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 00:31: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:31:48 INFO - building 'psutil._psutil_posix' extension 00:31:48 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 00:31: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 00:31:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:31:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:31:48 INFO - Successfully installed psutil 00:31:48 INFO - Cleaning up... 00:31:48 INFO - Return code: 0 00:31:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:31: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')]} 00:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31: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')]} 00:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31: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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b090>, '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 0x148bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1485f90>, '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': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', '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 00:31: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 00:31: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 00:31:48 INFO - Using env: {'DISPLAY': ':0', 00:31:48 INFO - 'HOME': '/home/cltbld', 00:31:48 INFO - 'LANG': 'en_US.UTF-8', 00:31:48 INFO - 'LANGUAGE': 'en_US:en', 00:31:48 INFO - 'LOGNAME': 'cltbld', 00:31:48 INFO - 'MAIL': '/var/mail/cltbld', 00:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:48 INFO - 'MOZ_NO_REMOTE': '1', 00:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:31:48 INFO - 'NO_EM_RESTART': '1', 00:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:48 INFO - 'PWD': '/builds/slave/test', 00:31:48 INFO - 'SHELL': '/bin/bash', 00:31:48 INFO - 'SHLVL': '1', 00:31:48 INFO - 'TERM': 'linux', 00:31:48 INFO - 'TMOUT': '86400', 00:31:48 INFO - 'USER': 'cltbld', 00:31:48 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', 00:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:48 INFO - '_': '/tools/buildbot/bin/python'} 00:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:31: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 00:31: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 00:31: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 00:31: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 00:31:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:31:49 INFO - Installing collected packages: mozsystemmonitor 00:31:49 INFO - Running setup.py install for mozsystemmonitor 00:31:50 INFO - Successfully installed mozsystemmonitor 00:31:50 INFO - Cleaning up... 00:31:50 INFO - Return code: 0 00:31:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:31: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')]} 00:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31: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')]} 00:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31: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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b090>, '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 0x148bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1485f90>, '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': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', '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 00:31: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 00:31: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 00:31:50 INFO - Using env: {'DISPLAY': ':0', 00:31:50 INFO - 'HOME': '/home/cltbld', 00:31:50 INFO - 'LANG': 'en_US.UTF-8', 00:31:50 INFO - 'LANGUAGE': 'en_US:en', 00:31:50 INFO - 'LOGNAME': 'cltbld', 00:31:50 INFO - 'MAIL': '/var/mail/cltbld', 00:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:50 INFO - 'MOZ_NO_REMOTE': '1', 00:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:31:50 INFO - 'NO_EM_RESTART': '1', 00:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:50 INFO - 'PWD': '/builds/slave/test', 00:31:50 INFO - 'SHELL': '/bin/bash', 00:31:50 INFO - 'SHLVL': '1', 00:31:50 INFO - 'TERM': 'linux', 00:31:50 INFO - 'TMOUT': '86400', 00:31:50 INFO - 'USER': 'cltbld', 00:31:50 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', 00:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:50 INFO - '_': '/tools/buildbot/bin/python'} 00:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:51 INFO - Downloading/unpacking jsonschema==2.5.1 00:31: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 00:31: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 00:31: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 00:31: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 00:31:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:31:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:31:52 INFO - Downloading functools32-3.2.3-2.tar.gz 00:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:31:52 INFO - warning: no files found matching '*.txt' 00:31:52 INFO - no previously-included directories found matching 'build' 00:31:52 INFO - no previously-included directories found matching 'dist' 00:31:52 INFO - no previously-included directories found matching '.git*' 00:31:52 INFO - Installing collected packages: jsonschema, functools32 00:31:52 INFO - Running setup.py install for functools32 00:31:52 INFO - warning: no files found matching '*.txt' 00:31:52 INFO - no previously-included directories found matching 'build' 00:31:52 INFO - no previously-included directories found matching 'dist' 00:31:52 INFO - no previously-included directories found matching '.git*' 00:31:52 INFO - Successfully installed jsonschema functools32 00:31:52 INFO - Cleaning up... 00:31:52 INFO - Return code: 0 00:31:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b090>, '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 0x148bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1485f90>, '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': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', '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 00:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:31:52 INFO - Using env: {'DISPLAY': ':0', 00:31:52 INFO - 'HOME': '/home/cltbld', 00:31:52 INFO - 'LANG': 'en_US.UTF-8', 00:31:52 INFO - 'LANGUAGE': 'en_US:en', 00:31:52 INFO - 'LOGNAME': 'cltbld', 00:31:52 INFO - 'MAIL': '/var/mail/cltbld', 00:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:52 INFO - 'MOZ_NO_REMOTE': '1', 00:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:31:52 INFO - 'NO_EM_RESTART': '1', 00:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:52 INFO - 'PWD': '/builds/slave/test', 00:31:52 INFO - 'SHELL': '/bin/bash', 00:31:52 INFO - 'SHLVL': '1', 00:31:52 INFO - 'TERM': 'linux', 00:31:52 INFO - 'TMOUT': '86400', 00:31:52 INFO - 'USER': 'cltbld', 00:31:52 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', 00:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:52 INFO - '_': '/tools/buildbot/bin/python'} 00:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:31:53 INFO - Cleaning up... 00:31:53 INFO - Return code: 0 00:31:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:31:53 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')]} 00:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:53 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')]} 00:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:53 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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b090>, '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 0x148bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1485f90>, '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': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', '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 00:31:53 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 00:31:53 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 00:31:53 INFO - Using env: {'DISPLAY': ':0', 00:31:53 INFO - 'HOME': '/home/cltbld', 00:31:53 INFO - 'LANG': 'en_US.UTF-8', 00:31:53 INFO - 'LANGUAGE': 'en_US:en', 00:31:53 INFO - 'LOGNAME': 'cltbld', 00:31:53 INFO - 'MAIL': '/var/mail/cltbld', 00:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:53 INFO - 'MOZ_NO_REMOTE': '1', 00:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:31:53 INFO - 'NO_EM_RESTART': '1', 00:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:53 INFO - 'PWD': '/builds/slave/test', 00:31:53 INFO - 'SHELL': '/bin/bash', 00:31:53 INFO - 'SHLVL': '1', 00:31:53 INFO - 'TERM': 'linux', 00:31:53 INFO - 'TMOUT': '86400', 00:31:53 INFO - 'USER': 'cltbld', 00:31:53 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', 00:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:53 INFO - '_': '/tools/buildbot/bin/python'} 00:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:53 INFO - Downloading/unpacking blobuploader==1.2.4 00:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:31:54 INFO - Downloading blobuploader-1.2.4.tar.gz 00:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:31:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:31: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 00:31: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 00:31: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 00:31: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 00:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:31:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:31: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 00:31: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 00:31: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 00:31: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 00:31:55 INFO - Downloading docopt-0.6.1.tar.gz 00:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:31:55 INFO - Installing collected packages: blobuploader, requests, docopt 00:31:55 INFO - Running setup.py install for blobuploader 00:31:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:31:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:31:55 INFO - Running setup.py install for requests 00:31:55 INFO - Running setup.py install for docopt 00:31:55 INFO - Successfully installed blobuploader requests docopt 00:31:55 INFO - Cleaning up... 00:31:55 INFO - Return code: 0 00:31:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:31: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')]} 00:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31: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')]} 00:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:55 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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b090>, '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 0x148bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1485f90>, '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': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', '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 00:31:55 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 00:31:55 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 00:31:55 INFO - Using env: {'DISPLAY': ':0', 00:31:55 INFO - 'HOME': '/home/cltbld', 00:31:55 INFO - 'LANG': 'en_US.UTF-8', 00:31:55 INFO - 'LANGUAGE': 'en_US:en', 00:31:55 INFO - 'LOGNAME': 'cltbld', 00:31:55 INFO - 'MAIL': '/var/mail/cltbld', 00:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:55 INFO - 'MOZ_NO_REMOTE': '1', 00:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:31:55 INFO - 'NO_EM_RESTART': '1', 00:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:55 INFO - 'PWD': '/builds/slave/test', 00:31:55 INFO - 'SHELL': '/bin/bash', 00:31:55 INFO - 'SHLVL': '1', 00:31:55 INFO - 'TERM': 'linux', 00:31:55 INFO - 'TMOUT': '86400', 00:31:55 INFO - 'USER': 'cltbld', 00:31:55 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', 00:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:55 INFO - '_': '/tools/buildbot/bin/python'} 00:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:31:56 INFO - Running setup.py (path:/tmp/pip-OfozYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:31:56 INFO - Running setup.py (path:/tmp/pip-DOvwMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:31:56 INFO - Running setup.py (path:/tmp/pip-vmtZoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:31:56 INFO - Running setup.py (path:/tmp/pip-EANkS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:31:56 INFO - Running setup.py (path:/tmp/pip-SZPYaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:31:56 INFO - Running setup.py (path:/tmp/pip-aI173S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:31:56 INFO - Running setup.py (path:/tmp/pip-PLNSlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:31:56 INFO - Running setup.py (path:/tmp/pip-Locxdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:31:56 INFO - Running setup.py (path:/tmp/pip-GdbZoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:31:56 INFO - Running setup.py (path:/tmp/pip-f2yKx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:31:56 INFO - Running setup.py (path:/tmp/pip-3J8FUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:31:56 INFO - Running setup.py (path:/tmp/pip-lmcUBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:31:56 INFO - Running setup.py (path:/tmp/pip-FAYaYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:31:57 INFO - Running setup.py (path:/tmp/pip-bTi2VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:31:57 INFO - Running setup.py (path:/tmp/pip-YF3709-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:31:57 INFO - Running setup.py (path:/tmp/pip-SWz1Wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:31:57 INFO - Running setup.py (path:/tmp/pip-pGWLeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:31:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:31:57 INFO - Running setup.py install for manifestparser 00:31:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:31:57 INFO - Running setup.py install for mozcrash 00:31:57 INFO - Running setup.py install for mozdebug 00:31:57 INFO - Running setup.py install for mozdevice 00:31:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:31:57 INFO - Running setup.py install for mozfile 00:31:57 INFO - Running setup.py install for mozhttpd 00:31:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:31:57 INFO - Running setup.py install for mozinfo 00:31:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:31:58 INFO - Running setup.py install for mozInstall 00:31:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:31:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:31:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:31:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:31:58 INFO - Running setup.py install for mozleak 00:31:58 INFO - Running setup.py install for mozlog 00:31:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:31:58 INFO - Running setup.py install for moznetwork 00:31:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:31:58 INFO - Running setup.py install for mozprocess 00:31:58 INFO - Running setup.py install for mozprofile 00:31:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:31:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:31:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:31:58 INFO - Running setup.py install for mozrunner 00:31:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:31:58 INFO - Running setup.py install for mozscreenshot 00:31:58 INFO - Running setup.py install for moztest 00:31:58 INFO - Running setup.py install for mozversion 00:31:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:31:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:31:59 INFO - Cleaning up... 00:31:59 INFO - Return code: 0 00:31:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:59 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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b090>, '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 0x148bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1485f90>, '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': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', '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 00:31:59 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 00:31:59 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 00:31:59 INFO - Using env: {'DISPLAY': ':0', 00:31:59 INFO - 'HOME': '/home/cltbld', 00:31:59 INFO - 'LANG': 'en_US.UTF-8', 00:31:59 INFO - 'LANGUAGE': 'en_US:en', 00:31:59 INFO - 'LOGNAME': 'cltbld', 00:31:59 INFO - 'MAIL': '/var/mail/cltbld', 00:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:59 INFO - 'MOZ_NO_REMOTE': '1', 00:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:31:59 INFO - 'NO_EM_RESTART': '1', 00:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:59 INFO - 'PWD': '/builds/slave/test', 00:31:59 INFO - 'SHELL': '/bin/bash', 00:31:59 INFO - 'SHLVL': '1', 00:31:59 INFO - 'TERM': 'linux', 00:31:59 INFO - 'TMOUT': '86400', 00:31:59 INFO - 'USER': 'cltbld', 00:31:59 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', 00:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:59 INFO - '_': '/tools/buildbot/bin/python'} 00:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:31:59 INFO - Running setup.py (path:/tmp/pip-Okg3I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:31:59 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)) 00:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:31:59 INFO - Running setup.py (path:/tmp/pip-uMONoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:31:59 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)) 00:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:31:59 INFO - Running setup.py (path:/tmp/pip-T06JaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:31:59 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)) 00:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:31:59 INFO - Running setup.py (path:/tmp/pip-cIr_ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:31:59 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)) 00:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:31:59 INFO - Running setup.py (path:/tmp/pip-fOlyjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:31:59 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)) 00:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:31:59 INFO - Running setup.py (path:/tmp/pip-VrjujZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:31:59 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)) 00:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:31:59 INFO - Running setup.py (path:/tmp/pip-E7Jrti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:31:59 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)) 00:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:31:59 INFO - Running setup.py (path:/tmp/pip-kaSQRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:31:59 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)) 00:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:31:59 INFO - Running setup.py (path:/tmp/pip-zP0QEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:31:59 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)) 00:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:31:59 INFO - Running setup.py (path:/tmp/pip-SVKIGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:32:00 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)) 00:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:32:00 INFO - Running setup.py (path:/tmp/pip-_kwPWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:32:00 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)) 00:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:32:00 INFO - Running setup.py (path:/tmp/pip-1JkE78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:32:00 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)) 00:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:32:00 INFO - Running setup.py (path:/tmp/pip-geElgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:32:00 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)) 00:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:32:00 INFO - Running setup.py (path:/tmp/pip-lW2fPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:32:00 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)) 00:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:32:00 INFO - Running setup.py (path:/tmp/pip-hXVMgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:32:00 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)) 00:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:32:00 INFO - Running setup.py (path:/tmp/pip-eH0uAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:32:00 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)) 00:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:32:00 INFO - Running setup.py (path:/tmp/pip-GaWDjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:32:00 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)) 00:32:00 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)) 00:32:00 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)) 00:32:00 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)) 00:32:00 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)) 00:32:00 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)) 00:32:00 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)) 00:32:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:01 INFO - Downloading blessings-1.6.tar.gz 00:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:32:01 INFO - Installing collected packages: blessings 00:32:01 INFO - Running setup.py install for blessings 00:32:01 INFO - Successfully installed blessings 00:32:01 INFO - Cleaning up... 00:32:01 INFO - Return code: 0 00:32:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:32:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:32:02 INFO - Reading from file tmpfile_stdout 00:32:02 INFO - Current package versions: 00:32:02 INFO - argparse == 1.2.1 00:32:02 INFO - blessings == 1.6 00:32:02 INFO - blobuploader == 1.2.4 00:32:02 INFO - docopt == 0.6.1 00:32:02 INFO - functools32 == 3.2.3-2 00:32:02 INFO - jsonschema == 2.5.1 00:32:02 INFO - manifestparser == 1.1 00:32:02 INFO - mozInstall == 1.13 00:32:02 INFO - mozcrash == 1.0 00:32:02 INFO - mozdebug == 0.1 00:32:02 INFO - mozdevice == 0.51 00:32:02 INFO - mozfile == 1.2 00:32:02 INFO - mozhttpd == 0.7 00:32:02 INFO - mozinfo == 0.10 00:32:02 INFO - mozleak == 0.1 00:32:02 INFO - mozlog == 3.5 00:32:02 INFO - moznetwork == 0.27 00:32:02 INFO - mozprocess == 0.25 00:32:02 INFO - mozprofile == 0.28 00:32:02 INFO - mozrunner == 6.13 00:32:02 INFO - mozscreenshot == 0.1 00:32:02 INFO - mozsystemmonitor == 0.3 00:32:02 INFO - moztest == 0.8 00:32:02 INFO - mozversion == 1.4 00:32:02 INFO - psutil == 3.1.1 00:32:02 INFO - requests == 1.2.3 00:32:02 INFO - wsgiref == 0.1.2 00:32:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:32:02 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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b090>, '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 0x148bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1485f90>, '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': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', '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 00:32:02 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 00:32:02 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 00:32:02 INFO - Using env: {'DISPLAY': ':0', 00:32:02 INFO - 'HOME': '/home/cltbld', 00:32:02 INFO - 'LANG': 'en_US.UTF-8', 00:32:02 INFO - 'LANGUAGE': 'en_US:en', 00:32:02 INFO - 'LOGNAME': 'cltbld', 00:32:02 INFO - 'MAIL': '/var/mail/cltbld', 00:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:02 INFO - 'MOZ_NO_REMOTE': '1', 00:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:02 INFO - 'NO_EM_RESTART': '1', 00:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:02 INFO - 'PWD': '/builds/slave/test', 00:32:02 INFO - 'SHELL': '/bin/bash', 00:32:02 INFO - 'SHLVL': '1', 00:32:02 INFO - 'TERM': 'linux', 00:32:02 INFO - 'TMOUT': '86400', 00:32:02 INFO - 'USER': 'cltbld', 00:32:02 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', 00:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:02 INFO - '_': '/tools/buildbot/bin/python'} 00:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:32:02 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)) 00:32:02 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)) 00:32:02 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)) 00:32:02 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)) 00:32:02 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)) 00:32:02 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)) 00:32:02 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)) 00:32:02 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)) 00:32:02 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)) 00:32:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 00:32: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 00:32: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 00:32: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 00:32: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 00:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 00:32:03 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)) 00:32:03 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)) 00:32:03 INFO - Installing collected packages: simplejson 00:32:03 INFO - Running setup.py install for simplejson 00:32:03 INFO - building 'simplejson._speedups' extension 00:32:03 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 00:32:04 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 00:32:04 INFO - Successfully installed simplejson 00:32:04 INFO - Cleaning up... 00:32:04 INFO - Return code: 0 00:32:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:32:04 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')]} 00:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:32:04 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')]} 00:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:32:04 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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b090>, '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 0x148bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1485f90>, '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': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', '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 00:32:04 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 00:32:04 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 00:32:04 INFO - Using env: {'DISPLAY': ':0', 00:32:04 INFO - 'HOME': '/home/cltbld', 00:32:04 INFO - 'LANG': 'en_US.UTF-8', 00:32:04 INFO - 'LANGUAGE': 'en_US:en', 00:32:04 INFO - 'LOGNAME': 'cltbld', 00:32:04 INFO - 'MAIL': '/var/mail/cltbld', 00:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:04 INFO - 'MOZ_NO_REMOTE': '1', 00:32:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:04 INFO - 'NO_EM_RESTART': '1', 00:32:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:04 INFO - 'PWD': '/builds/slave/test', 00:32:04 INFO - 'SHELL': '/bin/bash', 00:32:04 INFO - 'SHLVL': '1', 00:32:04 INFO - 'TERM': 'linux', 00:32:04 INFO - 'TMOUT': '86400', 00:32:04 INFO - 'USER': 'cltbld', 00:32:04 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', 00:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:04 INFO - '_': '/tools/buildbot/bin/python'} 00:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:32:04 INFO - Cleaning up... 00:32:04 INFO - Return code: 0 00:32:04 INFO - Running post-action listener: _resource_record_post_action 00:32:04 INFO - Running post-action listener: _start_resource_monitoring 00:32:04 INFO - Starting resource monitoring. 00:32:04 INFO - [mozharness: 2017-10-03 07:32:04.794123Z] Finished create-virtualenv step (success) 00:32:04 INFO - [mozharness: 2017-10-03 07:32:04.794632Z] Running install step. 00:32:04 INFO - Running pre-action listener: _resource_record_pre_action 00:32:04 INFO - Running main action method: install 00:32:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:32:05 INFO - Reading from file tmpfile_stdout 00:32:05 INFO - Detecting whether we're running mozinstall >=1.0... 00:32:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:32:05 INFO - Reading from file tmpfile_stdout 00:32:05 INFO - Output received: 00:32:05 INFO - Usage: mozinstall [options] installer 00:32:05 INFO - Options: 00:32:05 INFO - -h, --help show this help message and exit 00:32:05 INFO - -d DEST, --destination=DEST 00:32:05 INFO - Directory to install application into. [default: 00:32:05 INFO - "/builds/slave/test"] 00:32:05 INFO - --app=APP Application being installed. [default: firefox] 00:32:05 INFO - mkdir: /builds/slave/test/build/application 00:32:05 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'] 00:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 00:32:19 INFO - Reading from file tmpfile_stdout 00:32:19 INFO - Output received: 00:32:19 INFO - /builds/slave/test/build/application/firefox/firefox 00:32:19 INFO - Running post-action listener: _resource_record_post_action 00:32:19 INFO - [mozharness: 2017-10-03 07:32:19.734974Z] Finished install step (success) 00:32:19 INFO - [mozharness: 2017-10-03 07:32:19.735224Z] Running setup-mitmproxy step. 00:32:19 INFO - Running pre-action listener: _resource_record_pre_action 00:32:19 INFO - Running main action method: setup_mitmproxy 00:32:19 INFO - Skipping: mitmproxy is not required 00:32:19 INFO - Running post-action listener: _resource_record_post_action 00:32:19 INFO - [mozharness: 2017-10-03 07:32:19.736347Z] Finished setup-mitmproxy step (success) 00:32:19 INFO - [mozharness: 2017-10-03 07:32:19.736567Z] Running run-tests step. 00:32:19 INFO - Running pre-action listener: _resource_record_pre_action 00:32:19 INFO - Running pre-action listener: _set_gcov_prefix 00:32:19 INFO - Running main action method: run_tests 00:32:19 WARNING - Try message not found. 00:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:32:19 INFO - Python 2.7.3 00:32:19 INFO - Return code: 0 00:32:19 INFO - grabbing minidump binary from tooltool 00:32:19 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')]} 00:32:19 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 0x148b090>, '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 0x148bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1485f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:32:19 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 00:32:19 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 00:32:19 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 00:32:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:32:19 INFO - Return code: 0 00:32:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:32:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:32:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:32:19 INFO - ENV: RUST_BACKTRACE is now full 00:32:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:32:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:32:19 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/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 00:32:19 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/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --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 00:32:19 INFO - Using env: {'DISPLAY': ':0', 00:32:19 INFO - 'HOME': '/home/cltbld', 00:32:19 INFO - 'LANG': 'en_US.UTF-8', 00:32:19 INFO - 'LANGUAGE': 'en_US:en', 00:32:19 INFO - 'LOGNAME': 'cltbld', 00:32:19 INFO - 'MAIL': '/var/mail/cltbld', 00:32:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:32:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:19 INFO - 'MOZ_NO_REMOTE': '1', 00:32:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:19 INFO - 'NO_EM_RESTART': '1', 00:32:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:19 INFO - 'PWD': '/builds/slave/test', 00:32:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:32:19 INFO - 'RUST_BACKTRACE': 'full', 00:32:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:32:19 INFO - 'SHELL': '/bin/bash', 00:32:19 INFO - 'SHLVL': '1', 00:32:19 INFO - 'TERM': 'linux', 00:32:19 INFO - 'TMOUT': '86400', 00:32:19 INFO - 'USER': 'cltbld', 00:32:19 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', 00:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:19 INFO - '_': '/tools/buildbot/bin/python'} 00:32:19 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/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 00:32:20 INFO - mozversion application_buildid: 20171003050058 00:32:20 INFO - mozversion application_changeset: 1d3559680c3ec9916e08f10c0007ed476ccfdff1 00:32:20 INFO - mozversion application_display_name: Firefox 00:32:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:32:20 INFO - mozversion application_name: Firefox 00:32:20 INFO - mozversion application_remotingname: firefox 00:32:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 00:32:20 INFO - mozversion application_vendor: Mozilla 00:32:20 INFO - mozversion application_version: 57.0 00:32:20 INFO - mozversion platform_buildid: 20171003050058 00:32:20 INFO - mozversion platform_changeset: 1d3559680c3ec9916e08f10c0007ed476ccfdff1 00:32:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 00:32:20 INFO - mozversion platform_version: 57.0 00:32:20 INFO - using testdate: 1507015940 00:32:20 INFO - actual date: 1507015940 00:32:20 INFO - starting webserver on 'localhost:43860' 00:32:20 INFO - SUITE-START | Running 2 tests 00:32:20 INFO - TEST-START | dromaeo_css 00:32:20 INFO - Initialising browser for dromaeo_css test... 00:32:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43860/getInfo.html -profile /tmp/tmpeQDWB1/profile 00:32:20 INFO - TEST-INFO | started process 24407 (/builds/slave/test/build/application/firefox/firefox http://localhost:43860/getInfo.html) 00:32:25 INFO - TEST-INFO | 24407: exit 0 00:32:25 INFO - Browser initialized. 00:32:25 INFO - Running cycle 1/1 for dromaeo_css test... 00:32:25 INFO - Using env: {'DISPLAY': ':0', 00:32:25 INFO - 'HOME': '/home/cltbld', 00:32:25 INFO - 'JSGC_DISABLE_POISONING': '1', 00:32:25 INFO - 'LANG': 'en_US.UTF-8', 00:32:25 INFO - 'LANGUAGE': 'en_US:en', 00:32:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 00:32:25 INFO - 'LOGNAME': 'cltbld', 00:32:25 INFO - 'MAIL': '/var/mail/cltbld', 00:32:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:32:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:32:25 INFO - 'MOZ_CRASHREPORTER': '1', 00:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 00:32:25 INFO - 'MOZ_NO_REMOTE': '1', 00:32:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:25 INFO - 'NO_EM_RESTART': '1', 00:32:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:25 INFO - 'PWD': '/builds/slave/test', 00:32:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:32:25 INFO - 'RUST_BACKTRACE': 'full', 00:32:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:32:25 INFO - 'SHELL': '/bin/bash', 00:32:25 INFO - 'SHLVL': '1', 00:32:25 INFO - 'TERM': 'linux', 00:32:25 INFO - 'TMOUT': '86400', 00:32:25 INFO - 'USER': 'cltbld', 00:32:25 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', 00:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:25 INFO - '_': '/tools/buildbot/bin/python'} 00:32:25 INFO - TEST-INFO | started process 24638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeQDWB1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:32:25 INFO - PID 24638 | 00:32:25 INFO - PID 24638 | (/builds/slave/test/build/application/firefox/firefox:24686): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:32:25 INFO - PID 24638 | 00:32:36 INFO - PID 24638 | RSS: Main: 142548992 00:32:36 INFO - PID 24638 | 00:35:33 INFO - PID 24638 | Cycle 1(1): loaded http://localhost:43860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43860/tests/dromaeo/cssquery-ext.html) 00:35:34 INFO - PID 24638 | RSS: Main: 145043456 00:35:34 INFO - PID 24638 | 00:38:36 INFO - PID 24638 | Cycle 1(1): loaded http://localhost:43860/tests/dromaeo/cssquery-ext.html (next: http://localhost:43860/tests/dromaeo/cssquery-jquery.html) 00:38:37 INFO - PID 24638 | RSS: Main: 144179200 00:38:37 INFO - PID 24638 | 00:41:38 INFO - PID 24638 | Cycle 1(1): loaded http://localhost:43860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43860/tests/dromaeo/cssquery-mootools.html) 00:41:39 INFO - PID 24638 | RSS: Main: 144609280 00:41:39 INFO - PID 24638 | 00:44:40 INFO - PID 24638 | Cycle 1(1): loaded http://localhost:43860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43860/tests/dromaeo/cssquery-prototype.html) 00:44:41 INFO - PID 24638 | RSS: Main: 145039360 00:44:41 INFO - PID 24638 | 00:47:44 INFO - PID 24638 | Cycle 1(1): loaded http://localhost:43860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43860/tests/dromaeo/cssquery-yui.html) 00:47:44 INFO - PID 24638 | RSS: Main: 144101376 00:47:44 INFO - PID 24638 | 00:50:46 INFO - PID 24638 | Cycle 1(1): loaded http://localhost:43860/tests/dromaeo/cssquery-yui.html (next: http://localhost:43860/tests/dromaeo/cssquery-dojo.html) 00:50:46 INFO - PID 24638 | RSS: Main: 147451904 00:50:46 INFO - PID 24638 | 00:50:46 INFO - PID 24638 | __start_tp_report 00:50:46 INFO - PID 24638 | _x_x_mozilla_page_load 00:50:46 INFO - PID 24638 | _x_x_mozilla_page_load_details 00:50:46 INFO - PID 24638 | |i|pagename|runs| 00:50:46 INFO - PID 24638 | |0;dojo.html;3908.0425295802524;3930.1746633207026;3947.052707350233;3949.624785645363;3975.7018223633218;6570.441512471446;6583.144191255142;6607.339266073396;6647.102641143444;6673.432758215551;6565.737370505186;6582.901256481156;6609.438197753185;6678.131842860422;6680.732770689178;5863.413658634145;5955.612885162473;5979.611325263855;5997.760089596411;6000.669963152025;5895.115732640095;5935.139404786303;6005.87988240235;6018.7893423730175;6103.42017508336;5970.940290597082;5974.342822289566;6046.304674962392;6059.545534084939;6090.573659843791;5895.734691938873;5941.465268125846;5972.283326000886;6060.30306514752;6074.119252708332;5838.824835254949;5839.7664093436215;5866.14940833581;5871.060630299175;5937.821865344046;6418.679066046726;6559.409653131193;6565.901511477332;6579.473642108667;6663.50023748216;7116.893246601305;7123.394511466531;7126.3942564882045;7211.206767255598;7215.494915355927;7040.753573624898;7155.499115061948;7155.821104472378;7156.463265255126;7159.821004474878;6583.440407565363;6616.305287944745;6652.634105124216;6737.461003119739;6743.629100399476;7273.6726847292;7287.781366559012;7374.151972523228;7378;7389;7009.579425234502;7013.859722805515;7063.399611033017;7117.857642847114;7137.643117844087;6912.481563882729;7075.150981882207;7139.036230108973;7226.92773072273;7253.709851605982;7067.43460523157;7108.182559005677;7139.714411423589;7158.463115266376;7172.031775710212;7081;7096.432285417154;7164.176119746192;7179.748708795271;7208.315210055036;5185;5241.030409374278;5251.317328747315;5296.682199068068;5321.308229930084;4772.236442169236;4817.325574419584;4871.537203965618;4889.926651100236;4907.852764417074;6665.566738162004;6678.465722742169;6733.966330168318;6774.525783195129;6774.830629234309;7076.893846592306;7092.787216383414;7093.751718689821;7187.64061796908;7192.496525243183;6694.263631000586;6708;6729.831754206184;6742.325767423218;6771.492138089663;5963.165156878041;5971.402859713994;6042.788502402394;6043.7884674036195;6063.605865618721;7339.412846972229;7413.666385012687;7431.479796414307;7524.887126693104;7532.17146113927;7024.016637670628;7025.859482810418;7028.8945665814035;7032.929670703432;7097.467689923174;7404.481686281909;7446.73936412223;7458.328750412489;7479.588622625808;7524.360429363565;7059.788206353817;7069.505134640526;7153.678084486315;7163.6060016699585;7167.426605871622;7052.871540553487;7133.785986420416;7181.497295189287;7214.675339609626;7233.348998590152;6668.899966500603;6731.697073631601;6825.180978282638;6924.965375173092;6928.1339832520935;6813;6883.65581720922;6955.269696681776;6965.33829286217;6971.372576468142;6794;6818;6844.349786770249;6913.446924246149;6943.062686537455;6783.253842077466;6967.303269673195;6967.54710943787;7034.577925324497;7057.153141623038;6710.597364158166;6753.527253092433;6781.7287308509085;6837.282085381163;6858.451323894176 00:50:46 INFO - PID 24638 | |1;ext.html;991.2714155096005;1011.2769369900524;1016.740731113566;1017.1760873692306;1020.6376736258628;42625.78687106564;46485;46668.53331466684;46790;46904.76547617266;43587;43676;43773;43861.342079868824;43893.12213755731;8104.918950810505;8191.508509489449;8211.548364839931;8236.299914507274;8646.394752367336;8646.481211127353;8752.387332886701;8760.255378292853;8762.693305734301;8764.956175219115;8731.476111433334;8744.781380465507;8751.256143227802;8758.824823503526;8769.473831570094;8703.347248956323;8735.956320218422;8741.7814554636;8762.780930476725;8776.341774366916;8705.825883482295;8768.167024132697;8778;8780.121987801233;8794.956025219833;41879;42051;42127;42153.36769948453;42273;3947.2500224957166;3992.4210989406665;4015.4579131817122;4022.35642297231;4023.738457000315;34533.65466345329;34670.47994280088;34705.132371690655;34714.13214669628;34789.6521034789;5718.5711071669375;5728.570357223225;5743.971280143614;5766.711664416763;5866.853328666774;233213;233802.83098584568;234692;234958;236138.99999999828;54921;55087.173692394645;55116.72441637766;55324;56288.71855640696;58731.41268587345;58766.11850822241;58789.70605146947;58804.7059764707;58815.11777323343;17058.48824535266;17133.31466741341;17166.65666686659;17242.827571724374;17251.309947601956;13825.170489770646;13914.721705565831;13921.234332111628;13921.512747053805;13946.232957187452;15756.842431575538;15853.603659908595;15903.443379481894;16022;16052.678946421007;5997.250343707036;6036.879262414727;6061.696915154224;6211.782587609412;6260.530460215411;1125.1729978465821;1133.1416476977763;1147.2026941275733;1147.6442302885964;1149.316156886651;27020.054298099472;27245.863770681415;27306.5904011436;27335.589966150525;27370.45259094807;1241.7330273991136;1259.0871618076822;1268.1059852803935;1275;1280.5134049061296;14121.646958825906;14304.642383940276;14412.783808242884;14431.567052988426;14680.04579702316;303757;304653;305655;306391;306569;60544.39455605476;61183.08225376623;61810.69094654588;61924.07113893295;62004;1565.092246497029;1573.9606509837345;1609.6941581099788;1616.7089923813592;1620.0441739373825;29571.556426654046;32194.67805321917;32330;32605.510917335785;32792.34415311728;56412;56706;56716.43283567111;56790;56875.71562142163;243795;244072;245716;247234;247951;38194.809025954695;38465;38488.80755596204;38879.222415552096;39013.609863900994;48204.758976204896;48327;49026.509734902196;49091.50908490869;49224.75387623182;35986.820065899505;36093.819530902176;36127.63872361243;36201.63798362088;37088.258234835695;35226.823865880506;35857.46213806847;35959.460608090376;36965.445518317785;36998.07504812401;42594.361084583135;42772.572274276856;42874.92812679708;43277.783611081744;43282.35076473918;34609.30781384308;34643.653563464046;34736.131596710286;34821.47767783536;34838.47742283817;26444.735552644226;26493.867530662224;26622.201333960013;26817.180067611145;27585.310367240978 00:50:46 INFO - PID 24638 | |2;jquery.html;635.6351763211404;639.5459029698065;640.9068295109793;643.4206080667515;647.0356509749853;24253;25041.74958250419;25131.74868251317;25153.371165720866;25171.37071573207;26327;26670.466590668177;26774.06290779823;26898.865505672446;26928;6341.239051313849;6526.510511711629;6700.195976482829;6766.898496522556;6772.322767723237;6636.369544893228;6736.46108311334;6737.2925842786535;6738.292479289677;6739.123913891187;6593.439557637606;6632.30360812115;6674.432673222782;6912.3778859902595;6943.72225110995;6930.688119034656;6997.300269972988;6998.825029374307;6999.755008574675;7000.614966176859;6497.837554061139;6521.706523206467;6526.738930442777;6528.967355163194;6535.411812936859;29969.250768730737;30390;30736.077917662507;31046.37907241865;31063.0681079568;2261.1407665087327;2290.2556669082614;2312.8034117100065;2318.7565305643;2320.5706944215376;20569;21207;21240.787592124034;21258.787412125836;21263.787362126335;2603.609458581209;2636.3145582148586;2701.3381721478363;2702.04077552468;2707.9323016924736;130321;134352;155900;160954;162043;16338.264778085015;16782.83217167813;16829.83170168307;16846.157692115346;17249.741253881202;27042.729572704415;27104.59343109855;27202.31994200161;27206.911723531233;27246.182614521596;11120.277181983307;11161.218714690056;11325.716857078474;11346.829797553044;11484;10304.330218535772;10321.071103600712;10328.741781455523;10399.220058495492;10405.38861133898;10123.240756943258;10136.44249566281;10188.541515631814;10266.076053155102;10273.640422585173;2923.0561676485327;2958.4378967996013;2979;3015.819050856912;3086.42901063304;1056.4295280548572;1067.3169171730099;1071.041417930963;1080.4543705428707;1092.1044743310567;21959.780402196095;22057.558848822933;22097.55804883893;22171;22181.223657171922;1148.8736239013701;1149.5172027748365;1149.5286932357694;1157.3229660648446;1160.1762748448696;12013.579524716593;12078.21491603043;12257;12265.0187984961;12390.81413778794;585996;593011;593762;611113;618172;126008.36995815145;127683.3615831915;128518;128900;130920.69079309276;1159.5072094359864;1180.3095189314176;1243.7512497500536;1299.7660421124099;1306.033535183957;22249.888750556143;22447.663285051065;22568.887155564775;22595.88702056479;22829.77170228343;63035.68482157743;63151.6842415785;63833;65908;66117.66941165263;79422.6028869852;79772;80255.59872200602;80380;81282;15855.920720396785;16255.105969171336;16257.349706011628;16319.510414687104;16370.590735231715;23751;24801.759912004687;25021.624675630243;25031.374215644028;25044;20423.387298381072;20530.79469205289;20581.07385167701;20687.58624827465;20719.689204662245;17723.29106835712;18063.2774689011;18282.360117395827;18491.81508184901;18566.885986840294;20481.795182048583;20792.688109678063;20810;20865.165393384093;21032.05355758964;15823.604409889384;16009.919950400174;16092.919535402716;16121.758173627639;16124.67750645004;18902.14940327716;19827.30604428838;19930.90034549818;20099.799002009793;20124.698129527776 00:50:46 INFO - PID 24638 | |3;mootools.html;1393.5888912770731;1469.3608280398034;1472.2417954753312;1490.6198919275587;1499.1679617812117;17097.829021709797;17693.46919592411;17746.20142093607;17767.111644417775;17783;17506;17550.912245438787;17614.735778963324;17630.294788208488;17648.205830737614;3060.831654259015;3071.9692803071907;3152.7320177784914;3154.4164329598984;3155.9368812623734;3064.8007879487764;3108.502639577668;3123.5002399616064;3134.2477805326785;3134.9373012539736;3066.9693303066906;3173.952390714141;3180.936381272373;3193.297474555594;3202.8078315301154;3077.723004929545;3087.0893086539636;3099.457594920891;3120.8595613197463;3134.435801555719;3114.112477943798;3129.796563223383;3157.2264795125343;3159.510275907238;3163.572917656133;17016.06411647359;17366.826331736647;17380.3047878086;17393;17425.82574174255;8622.3533235007;8889.4666320021;8904.955475222583;8909.1536304051;8926.553672316359;5605.7937359166135;5663.830085097454;5795.768169273224;5836.066229403275;5842.532597392198;2219.5782801267706;2244.6857439958417;2257.4356410897276;2300.1719381022817;2311.456807650201;31733;31820.20449488758;31989.6801031989;32001.51997720013;32002.83998579992;7565.886511702329;7634.50375725576;7650.38796896247;7712.6529306181355;7805.2194780521495;20439.795602044087;20485.897570512054;20504.487387815425;20522.38432846987;20535.4866128348;8647.221750042527;8739.475631462132;8802.207801297915;8812.250958668585;8816.118388161261;7674.769756907302;7881.330086942674;8071.5157090573575;8156.551389673625;8304.916950830535;5838.824835254949;6063.181470501514;6114.388561143939;6145.66198859067;6150.415710507584;1647.571631375851;1689.0794516988271;1788.1595650044458;1811.184966764961;1821.0439519252498;1014.3558840136567;1055.261317078033;1056.587930707025;1057.2440704896037;1058.4972138234277;10499.835613162944;10501.579936802595;10581.89418105809;10603.204759642904;10739.516721747541;828.1304630138451;829.1252728371626;833.9124391938881;839.3788596438592;902.9187373136318;6228.377162283736;6386.593136156029;6441.227052753606;6510.934890651128;6582.275949645536;23858.403539911295;26181.607275890878;26247.21258362252;26297.474050518882;26300.86849565778;24297.878510607334;25422.618660720105;25689.229323120337;25742.227733168034;25759.48481030369;12988.935055324662;13017.284049377186;13207.933960330136;13287.534936277378;13297.734045319039;9744.317897747089;9949.303548751517;10066.848997265193;10162.949185254027;10165.898341016495;22347.329580112622;22499.100035998377;22562.774372256066;22667.773322266567;23119.959601818297;22930.770692292863;23063.4234144141;23447.531049379257;23547.646785298577;24369.878150609842;12582.685432864251;12613.81079283793;12617.369131543202;12734.108612397044;12744.49022039108;16243;16296;16431.096289703702;16432.753508697617;16472;13204.66988325261;13238.338083095614;13262.469501219843;13276.933615331862;13318.467261309439;11682.415879205835;12049.518019279481;12204.633860984184;12266.632001039983;12324.568640097554;11293.604723834625;11457.885421146015;11510.42447877586;11514.136439766884;11543.595974140864;8848.955755221183;8887;8974.102589740975;9062.456252624863;9071.365004449624;8934.28525717954;8951.507667078373;8969.641214351353;9034.638614455349;9096.363254572116 00:50:46 INFO - PID 24638 | |4;prototype.html;560.6159780550321;578.4995978478614;579.3250862744902;594.47983014862;604.8608819971406;6285.214348206474;6333.968330158348;6443;6498;6550.934490655104;6293.339199384056;6336.461400780928;6360.328661961976;6369.20384951881;6473.126127972734;5310.707911064899;5329.467053294659;5353.518183363496;5369.677819330833;5378.381486129106;5104.489551044903;5199.272101905717;5200.92198617021;5221.582273418117;5328.706921119337;5181.689098654074;5201.869953251161;5218.295530103444;5226.660267082647;5232.372115346145;5122.1804511278015;5144.588432925376;5145.845624631267;5188;5191.792328306863;4712.3167140764735;4713.811447542094;4727.125481785881;4751.004578077182;4765.332853400527;6323;6440.033994900756;6451.93548064518;6493.577917435352;6496.447801936841;6047.457898235922;6068.6358818471035;6104.328523862416;6121.908171377433;6195.690215489252;6844.178698556205;6882.862342753167;6888.965555172192;6904.203797461986;6906.929425938987;5120.206368012964;5268.736563171826;5308.761105750251;5314.441983591706;5334.333208348957;6917.204521480044;7148.964255178743;7160.427165826722;7235.204127546019;7266.636668166623;5395.379531353945;5423.810166644227;5427.701476418835;5456.208849716769;5485.396606373296;5465.988792073479;5481.397046324901;5518.19986102013;5522.30971128609;5544.833654990357;6084.209052823105;6107.328193898667;6128.142060111588;6145.877082458326;6181.381861813783;6920.619365934821;6936.895946560806;6968.198657154391;6976.616286104313;7003.719851205997;1891.2529550827621;1891.9783317008937;1906.4471303321882;1914.9138288777037;1917.3768525229357;1311.1280998136324;1356.9796453053211;1357.043284484436;1358.7418390505773;1362.591222633226;6487.545871789024;6513.73945042193;6579.30917253691;6579.868402632016;6587.670616469253;6777.762778302736;6885.724571017103;6947.89578156328;6960.025596416505;6967.9444563853785;6473.216516897779;6534.019897015486;6537.444317232993;6539.47684185264;6596.505262105361;3652.5616925969052;3702.500162478085;3705.981470092632;3727.5154229950476;3742.36379815432;7329.486935914435;7365.594892280976;7386.556806591621;7392.519486233377;7474;7199.2440793715905;7275.454340924452;7307.378872795872;7307.744228952068;7323.487355885037;7261.237570055174;7283.417326613964;7411.5553066816165;7415.295546923034;7466.139080821529;7005.614691192033;7057.424040225178;7070.575765454089;7137.536060156073;7162.964185179041;6907.827304317432;6929.411000064849;6938;6946.7495850747355;7007.964960175166;7329.890051649123;7355.154157271768;7383.778486645409;7391;7413.443991700752;5466.867921510535;5472.945270547243;5474.863128421821;5475.863103422287;5479.424660410599;6757.831054223684;6795.218549866829;7020.929790702027;7031.226565077735;7061.505694601328;6836.48726345536;6850.38346548813;6857.177138743383;6884.7641608443955;6890.276520965226;6743.325667433413;6789.15135608049;6818;6851.588904665537;6882.76709823465;6587.736490540325;6681.5656982296;6691.732330706717;6773.93226067733;6811.625360605214;6863.828404289733;6868.244493105854;6905.792826215222;6951.652417379212;6964.65176741171;6662.167229096363;6688.3646053624825;6697.3637504437;6725.697343619451;6743.426808721314 00:50:46 INFO - PID 24638 | |5;yui.html;1006.3056491021194;1013.6705570689528;1033.8087453821045;1054.6783231114507;1062.500624706388;21393;21940.561188776213;21985.340439786833;21990.780092199075;21994.45013874652;19549.21803127873;19618;19618;19667.508312292164;19750.802491975075;1060.978780424391;1075.8493810866446;1082.3668154129844;1082.4749996251812;1086.9293495922739;1097.6048622495896;1098.6484325015958;1101.5869049106584;1102.6802227354099;1104.116706634693;1049.6221360310283;1093.5625749700143;1145.4272863568217;1149.1553708024596;1149.5689116581282;1142.4858813533901;1144.2333636463588;1146.7419830538145;1147.23708733692;1147.3402793393832;835.3859912964027;835.4444294544121;838;838.0822998816286;838.5723281126608;20888.791112088988;21299.467513312135;21304.254351097792;21425.250116246014;22228.666570001464;23630.527389452116;23765;24164.2750717477;24207.2737817864;24220.757792422028;19546.80453195464;19643.508912277164;19781.40655780329;19789.80210197894;19805.306814261432;4198.055437526563;4234.13200293939;4237.915241695179;4250.574942505725;4251.59609837065;128712.35643821815;151026.24486877606;155083;159824;160816.99999999884;19031;19335.226590936487;19411.417657470298;19429.80570194308;19461.22155113808;35460.113497162776;35643;35975.64024359775;36192.457113143326;36198.45702314467;9968.003199679973;10035.598576056876;10148.898511014942;10169.13562347194;10203.693889183336;4666.2067448533835;4692.085043416501;4783.856484305476;4825.083234185494;4844.055409195244;5580.386157522669;5770.740316685759;5783.913241301384;5804.506616937523;6072.544559158081;1234.2224398628807;1281.0456210123518;1281.9935900320438;1297.3772589157256;1299.2918859221747;761.7638532055081;774.4578794843519;782.0927723840318;788.0700773087697;803.1567552467102;13316.15248997361;13936.094153879965;14846.554603361916;14870.925645371704;15063;767.0450289389745;774.4462709162975;775.4145620056934;781.3749000799338;783.1972228465868;6331.715072821734;6355.237371515355;6384.52116091295;6430.099786029959;6462.773802916875;154631;154660.45339546684;156439.21780391253;157147;157660;124567;128042;128467;129154;134281;113572;114233;116556.41721791506;117068;119409.40295298467;13965.441382344592;14217.857821421654;14442;14494.202818845064;14697.19165445868;54906.176407354724;55528.44471555233;55878.44121558895;56032.43967560435;56269.71865140648;93158;93504;93752.53123734337;96040.4102984292;96365.5181724115;21174.258900938392;21269;21369;21477.785222147577;21507.46231344229;24276.514469710153;24380.75619243856;24983.500329992934;25173.370665733502;25281.74718252794;21071.894640526698;21304.147834086463;21312;21579.13683452707;21643.35069947904;19827;20076.09657565442;21112.577748445252;22011.449713756643;22183.334499965025;21101.683474747584;21630.35108946734;21665.241716539844;21739.673904891122;21821.23625673094;15924.363025478851;16124.758128628315;16439;16457.67084658324;16585.91707041457;15727.842721572637;15893.284802183698;16167.191640417697;16295.837041629431;16342.754858677366 00:50:46 INFO - PID 24638 | __end_tp_report 00:50:46 INFO - PID 24638 | __start_cc_report 00:50:46 INFO - PID 24638 | _x_x_mozilla_cycle_collect,233 00:50:46 INFO - PID 24638 | __end_cc_report 00:50:46 INFO - PID 24638 | __startTimestamp1507017046611__endTimestamp 00:50:46 INFO - PID 24638 | 00:50:46 INFO - PID 24638 | ------- Summary: start ------- 00:50:46 INFO - PID 24638 | Number of tests: 6 00:50:46 INFO - PID 24638 | 00:50:46 INFO - PID 24638 | [#0] dojo.html Cycles:165 Average:6595.13 Median:6813.00 stddev:772.06 (11.3%) stddev-sans-first:745.10 00:50:46 INFO - PID 24638 | Values: 3908.0 3930.2 3947.1 3949.6 3975.7 6570.4 6583.1 6607.3 6647.1 6673.4 6565.7 6582.9 6609.4 6678.1 6680.7 5863.4 5955.6 5979.6 5997.8 6000.7 5895.1 5935.1 6005.9 6018.8 6103.4 5970.9 5974.3 6046.3 6059.5 6090.6 5895.7 5941.5 5972.3 6060.3 6074.1 5838.8 5839.8 5866.1 5871.1 5937.8 6418.7 6559.4 6565.9 6579.5 6663.5 7116.9 7123.4 7126.4 7211.2 7215.5 7040.8 7155.5 7155.8 7156.5 7159.8 6583.4 6616.3 6652.6 6737.5 6743.6 7273.7 7287.8 7374.2 7378.0 7389.0 7009.6 7013.9 7063.4 7117.9 7137.6 6912.5 7075.2 7139.0 7226.9 7253.7 7067.4 7108.2 7139.7 7158.5 7172.0 7081.0 7096.4 7164.2 7179.7 7208.3 5185.0 5241.0 5251.3 5296.7 5321.3 4772.2 4817.3 4871.5 4889.9 4907.9 6665.6 6678.5 6734.0 6774.5 6774.8 7076.9 7092.8 7093.8 7187.6 7192.5 6694.3 6708.0 6729.8 6742.3 6771.5 5963.2 5971.4 6042.8 6043.8 6063.6 7339.4 7413.7 7431.5 7524.9 7532.2 7024.0 7025.9 7028.9 7032.9 7097.5 7404.5 7446.7 7458.3 7479.6 7524.4 7059.8 7069.5 7153.7 7163.6 7167.4 7052.9 7133.8 7181.5 7214.7 7233.3 6668.9 6731.7 6825.2 6925.0 6928.1 6813.0 6883.7 6955.3 6965.3 6971.4 6794.0 6818.0 6844.3 6913.4 6943.1 6783.3 6967.3 6967.5 7034.6 7057.2 6710.6 6753.5 6781.7 6837.3 6858.5 00:50:46 INFO - PID 24638 | 00:50:46 INFO - PID 24638 | [#1] ext.html Cycles:180 Average:45376.35 Median:38476.90 stddev:68611.04 (178.3%) stddev-sans-first:68722.57 00:50:46 INFO - PID 24638 | Values: 991.3 1011.3 1016.7 1017.2 1020.6 42625.8 46485.0 46668.5 46790.0 46904.8 43587.0 43676.0 43773.0 43861.3 43893.1 8104.9 8191.5 8211.5 8236.3 8646.4 8646.5 8752.4 8760.3 8762.7 8765.0 8731.5 8744.8 8751.3 8758.8 8769.5 8703.3 8736.0 8741.8 8762.8 8776.3 8705.8 8768.2 8778.0 8780.1 8795.0 41879.0 42051.0 42127.0 42153.4 42273.0 3947.3 3992.4 4015.5 4022.4 4023.7 34533.7 34670.5 34705.1 34714.1 34789.7 5718.6 5728.6 5744.0 5766.7 5866.9 233213.0 233802.8 234692.0 234958.0 236139.0 54921.0 55087.2 55116.7 55324.0 56288.7 58731.4 58766.1 58789.7 58804.7 58815.1 17058.5 17133.3 17166.7 17242.8 17251.3 13825.2 13914.7 13921.2 13921.5 13946.2 15756.8 15853.6 15903.4 16022.0 16052.7 5997.3 6036.9 6061.7 6211.8 6260.5 1125.2 1133.1 1147.2 1147.6 1149.3 27020.1 27245.9 27306.6 27335.6 27370.5 1241.7 1259.1 1268.1 1275.0 1280.5 14121.6 14304.6 14412.8 14431.6 14680.0 303757.0 304653.0 305655.0 306391.0 306569.0 60544.4 61183.1 61810.7 61924.1 62004.0 1565.1 1574.0 1609.7 1616.7 1620.0 29571.6 32194.7 32330.0 32605.5 32792.3 56412.0 56706.0 56716.4 56790.0 56875.7 243795.0 244072.0 245716.0 247234.0 247951.0 38194.8 38465.0 38488.8 38879.2 39013.6 48204.8 48327.0 49026.5 49091.5 49224.8 35986.8 36093.8 36127.6 36201.6 37088.3 35226.8 35857.5 35959.5 36965.4 36998.1 42594.4 42772.6 42874.9 43277.8 43282.4 34609.3 34643.7 34736.1 34821.5 34838.5 26444.7 26493.9 26622.2 26817.2 27585.3 00:50:46 INFO - PID 24638 | 00:50:46 INFO - PID 24638 | [#2] jquery.html Cycles:180 Average:40006.99 Median:22348.78 stddev:100360.63 (449.1%) stddev-sans-first:100598.64 00:50:46 INFO - PID 24638 | Values: 635.6 639.5 640.9 643.4 647.0 24253.0 25041.7 25131.7 25153.4 25171.4 26327.0 26670.5 26774.1 26898.9 26928.0 6341.2 6526.5 6700.2 6766.9 6772.3 6636.4 6736.5 6737.3 6738.3 6739.1 6593.4 6632.3 6674.4 6912.4 6943.7 6930.7 6997.3 6998.8 6999.8 7000.6 6497.8 6521.7 6526.7 6529.0 6535.4 29969.3 30390.0 30736.1 31046.4 31063.1 2261.1 2290.3 2312.8 2318.8 2320.6 20569.0 21207.0 21240.8 21258.8 21263.8 2603.6 2636.3 2701.3 2702.0 2707.9 130321.0 134352.0 155900.0 160954.0 162043.0 16338.3 16782.8 16829.8 16846.2 17249.7 27042.7 27104.6 27202.3 27206.9 27246.2 11120.3 11161.2 11325.7 11346.8 11484.0 10304.3 10321.1 10328.7 10399.2 10405.4 10123.2 10136.4 10188.5 10266.1 10273.6 2923.1 2958.4 2979.0 3015.8 3086.4 1056.4 1067.3 1071.0 1080.5 1092.1 21959.8 22057.6 22097.6 22171.0 22181.2 1148.9 1149.5 1149.5 1157.3 1160.2 12013.6 12078.2 12257.0 12265.0 12390.8 585996.0 593011.0 593762.0 611113.0 618172.0 126008.4 127683.4 128518.0 128900.0 130920.7 1159.5 1180.3 1243.8 1299.8 1306.0 22249.9 22447.7 22568.9 22595.9 22829.8 63035.7 63151.7 63833.0 65908.0 66117.7 79422.6 79772.0 80255.6 80380.0 81282.0 15855.9 16255.1 16257.3 16319.5 16370.6 23751.0 24801.8 25021.6 25031.4 25044.0 20423.4 20530.8 20581.1 20687.6 20719.7 17723.3 18063.3 18282.4 18491.8 18566.9 20481.8 20792.7 20810.0 20865.2 21032.1 15823.6 16009.9 16092.9 16121.8 16124.7 18902.1 19827.3 19930.9 20099.8 20124.7 00:50:46 INFO - PID 24638 | 00:50:46 INFO - PID 24638 | [#3] mootools.html Cycles:180 Average:10954.54 Median:25555.92 stddev:8001.00 (31.3%) stddev-sans-first:7991.20 00:50:46 INFO - PID 24638 | Values: 1393.6 1469.4 1472.2 1490.6 1499.2 17097.8 17693.5 17746.2 17767.1 17783.0 17506.0 17550.9 17614.7 17630.3 17648.2 3060.8 3072.0 3152.7 3154.4 3155.9 3064.8 3108.5 3123.5 3134.2 3134.9 3067.0 3174.0 3180.9 3193.3 3202.8 3077.7 3087.1 3099.5 3120.9 3134.4 3114.1 3129.8 3157.2 3159.5 3163.6 17016.1 17366.8 17380.3 17393.0 17425.8 8622.4 8889.5 8905.0 8909.2 8926.6 5605.8 5663.8 5795.8 5836.1 5842.5 2219.6 2244.7 2257.4 2300.2 2311.5 31733.0 31820.2 31989.7 32001.5 32002.8 7565.9 7634.5 7650.4 7712.7 7805.2 20439.8 20485.9 20504.5 20522.4 20535.5 8647.2 8739.5 8802.2 8812.3 8816.1 7674.8 7881.3 8071.5 8156.6 8304.9 5838.8 6063.2 6114.4 6145.7 6150.4 1647.6 1689.1 1788.2 1811.2 1821.0 1014.4 1055.3 1056.6 1057.2 1058.5 10499.8 10501.6 10581.9 10603.2 10739.5 828.1 829.1 833.9 839.4 902.9 6228.4 6386.6 6441.2 6510.9 6582.3 23858.4 26181.6 26247.2 26297.5 26300.9 24297.9 25422.6 25689.2 25742.2 25759.5 12988.9 13017.3 13207.9 13287.5 13297.7 9744.3 9949.3 10066.8 10162.9 10165.9 22347.3 22499.1 22562.8 22667.8 23120.0 22930.8 23063.4 23447.5 23547.6 24369.9 12582.7 12613.8 12617.4 12734.1 12744.5 16243.0 16296.0 16431.1 16432.8 16472.0 13204.7 13238.3 13262.5 13276.9 13318.5 11682.4 12049.5 12204.6 12266.6 12324.6 11293.6 11457.9 11510.4 11514.1 11543.6 8849.0 8887.0 8974.1 9062.5 9071.4 8934.3 8951.5 8969.6 9034.6 9096.4 00:50:46 INFO - PID 24638 | 00:50:46 INFO - PID 24638 | [#4] prototype.html Cycles:180 Average:5881.46 Median:6505.87 stddev:1641.35 (25.2%) stddev-sans-first:1596.63 00:50:46 INFO - PID 24638 | Values: 560.6 578.5 579.3 594.5 604.9 6285.2 6334.0 6443.0 6498.0 6550.9 6293.3 6336.5 6360.3 6369.2 6473.1 5310.7 5329.5 5353.5 5369.7 5378.4 5104.5 5199.3 5200.9 5221.6 5328.7 5181.7 5201.9 5218.3 5226.7 5232.4 5122.2 5144.6 5145.8 5188.0 5191.8 4712.3 4713.8 4727.1 4751.0 4765.3 6323.0 6440.0 6451.9 6493.6 6496.4 6047.5 6068.6 6104.3 6121.9 6195.7 6844.2 6882.9 6889.0 6904.2 6906.9 5120.2 5268.7 5308.8 5314.4 5334.3 6917.2 7149.0 7160.4 7235.2 7266.6 5395.4 5423.8 5427.7 5456.2 5485.4 5466.0 5481.4 5518.2 5522.3 5544.8 6084.2 6107.3 6128.1 6145.9 6181.4 6920.6 6936.9 6968.2 6976.6 7003.7 1891.3 1892.0 1906.4 1914.9 1917.4 1311.1 1357.0 1357.0 1358.7 1362.6 6487.5 6513.7 6579.3 6579.9 6587.7 6777.8 6885.7 6947.9 6960.0 6967.9 6473.2 6534.0 6537.4 6539.5 6596.5 3652.6 3702.5 3706.0 3727.5 3742.4 7329.5 7365.6 7386.6 7392.5 7474.0 7199.2 7275.5 7307.4 7307.7 7323.5 7261.2 7283.4 7411.6 7415.3 7466.1 7005.6 7057.4 7070.6 7137.5 7163.0 6907.8 6929.4 6938.0 6946.7 7008.0 7329.9 7355.2 7383.8 7391.0 7413.4 5466.9 5472.9 5474.9 5475.9 5479.4 6757.8 6795.2 7020.9 7031.2 7061.5 6836.5 6850.4 6857.2 6884.8 6890.3 6743.3 6789.2 6818.0 6851.6 6882.8 6587.7 6681.6 6691.7 6773.9 6811.6 6863.8 6868.2 6905.8 6951.7 6964.7 6662.2 6688.4 6697.4 6725.7 6743.4 00:50:46 INFO - PID 24638 | 00:50:46 INFO - PID 24638 | [#5] yui.html Cycles:180 Average:29895.27 Median:20482.44 stddev:42575.38 (207.9%) stddev-sans-first:42639.55 00:50:46 INFO - PID 24638 | Values: 1006.3 1013.7 1033.8 1054.7 1062.5 21393.0 21940.6 21985.3 21990.8 21994.5 19549.2 19618.0 19618.0 19667.5 19750.8 1061.0 1075.8 1082.4 1082.5 1086.9 1097.6 1098.6 1101.6 1102.7 1104.1 1049.6 1093.6 1145.4 1149.2 1149.6 1142.5 1144.2 1146.7 1147.2 1147.3 835.4 835.4 838.0 838.1 838.6 20888.8 21299.5 21304.3 21425.3 22228.7 23630.5 23765.0 24164.3 24207.3 24220.8 19546.8 19643.5 19781.4 19789.8 19805.3 4198.1 4234.1 4237.9 4250.6 4251.6 128712.4 151026.2 155083.0 159824.0 160817.0 19031.0 19335.2 19411.4 19429.8 19461.2 35460.1 35643.0 35975.6 36192.5 36198.5 9968.0 10035.6 10148.9 10169.1 10203.7 4666.2 4692.1 4783.9 4825.1 4844.1 5580.4 5770.7 5783.9 5804.5 6072.5 1234.2 1281.0 1282.0 1297.4 1299.3 761.8 774.5 782.1 788.1 803.2 13316.2 13936.1 14846.6 14870.9 15063.0 767.0 774.4 775.4 781.4 783.2 6331.7 6355.2 6384.5 6430.1 6462.8 154631.0 154660.5 156439.2 157147.0 157660.0 124567.0 128042.0 128467.0 129154.0 134281.0 113572.0 114233.0 116556.4 117068.0 119409.4 13965.4 14217.9 14442.0 14494.2 14697.2 54906.2 55528.4 55878.4 56032.4 56269.7 93158.0 93504.0 93752.5 96040.4 96365.5 21174.3 21269.0 21369.0 21477.8 21507.5 24276.5 24380.8 24983.5 25173.4 25281.7 21071.9 21304.1 21312.0 21579.1 21643.4 19827.0 20076.1 21112.6 22011.4 22183.3 21101.7 21630.4 21665.2 21739.7 21821.2 15924.4 16124.8 16439.0 16457.7 16585.9 15727.8 15893.3 16167.2 16295.8 16342.8 00:50:46 INFO - PID 24638 | -------- Summary: end -------- 00:50:46 INFO - PID 24638 | 00:50:47 INFO - TEST-INFO | 24638: exit 0 00:50:47 INFO - TEST-OK | dromaeo_css | took 1107178ms 00:50:47 INFO - TEST-START | kraken 00:50:47 INFO - Initialising browser for kraken test... 00:50:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43860/getInfo.html -profile /tmp/tmpd1ZEUS/profile 00:50:47 INFO - TEST-INFO | started process 24996 (/builds/slave/test/build/application/firefox/firefox http://localhost:43860/getInfo.html) 00:50:52 INFO - TEST-INFO | 24996: exit 0 00:50:52 INFO - Browser initialized. 00:50:52 INFO - Running cycle 1/1 for kraken test... 00:50:52 INFO - Using env: {'DISPLAY': ':0', 00:50:52 INFO - 'HOME': '/home/cltbld', 00:50:52 INFO - 'JSGC_DISABLE_POISONING': '1', 00:50:52 INFO - 'LANG': 'en_US.UTF-8', 00:50:52 INFO - 'LANGUAGE': 'en_US:en', 00:50:52 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 00:50:52 INFO - 'LOGNAME': 'cltbld', 00:50:52 INFO - 'MAIL': '/var/mail/cltbld', 00:50:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:50:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:50:52 INFO - 'MOZ_CRASHREPORTER': '1', 00:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:52 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 00:50:52 INFO - 'MOZ_NO_REMOTE': '1', 00:50:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:52 INFO - 'NO_EM_RESTART': '1', 00:50:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:52 INFO - 'PWD': '/builds/slave/test', 00:50:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:50:52 INFO - 'RUST_BACKTRACE': 'full', 00:50:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:50:52 INFO - 'SHELL': '/bin/bash', 00:50:52 INFO - 'SHLVL': '1', 00:50:52 INFO - 'TERM': 'linux', 00:50:52 INFO - 'TMOUT': '86400', 00:50:52 INFO - 'USER': 'cltbld', 00:50:52 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090', 00:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:52 INFO - '_': '/tools/buildbot/bin/python'} 00:50:52 INFO - TEST-INFO | started process 25232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd1ZEUS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:50:53 INFO - PID 25232 | 00:50:53 INFO - PID 25232 | (/builds/slave/test/build/application/firefox/firefox:25280): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:50:53 INFO - PID 25232 | 00:51:03 INFO - PID 25232 | RSS: Main: 140726272 00:51:03 INFO - PID 25232 | 00:51:06 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43860/tests/kraken/driver.html?testName=audio-beat-detection) 00:51:07 INFO - PID 25232 | RSS: Main: 148385792 00:51:07 INFO - PID 25232 | 00:51:09 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43860/tests/kraken/driver.html?testName=audio-dft) 00:51:10 INFO - PID 25232 | RSS: Main: 148631552 00:51:10 INFO - PID 25232 | 00:51:13 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43860/tests/kraken/driver.html?testName=audio-fft) 00:51:13 INFO - PID 25232 | RSS: Main: 150171648 00:51:13 INFO - PID 25232 | 00:51:15 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43860/tests/kraken/driver.html?testName=audio-oscillator) 00:51:16 INFO - PID 25232 | RSS: Main: 150532096 00:51:16 INFO - PID 25232 | 00:51:18 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:51:19 INFO - PID 25232 | RSS: Main: 150024192 00:51:19 INFO - PID 25232 | 00:51:22 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43860/tests/kraken/driver.html?testName=imaging-darkroom) 00:51:22 INFO - PID 25232 | RSS: Main: 150384640 00:51:22 INFO - PID 25232 | 00:51:26 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43860/tests/kraken/driver.html?testName=imaging-desaturate) 00:51:26 INFO - PID 25232 | RSS: Main: 151629824 00:51:26 INFO - PID 25232 | 00:51:29 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43860/tests/kraken/driver.html?testName=json-parse-financial) 00:51:30 INFO - PID 25232 | RSS: Main: 152330240 00:51:30 INFO - PID 25232 | 00:51:31 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:51:32 INFO - PID 25232 | RSS: Main: 152199168 00:51:32 INFO - PID 25232 | 00:51:33 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43860/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:51:34 INFO - PID 25232 | RSS: Main: 152506368 00:51:34 INFO - PID 25232 | 00:51:36 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:51:37 INFO - PID 25232 | RSS: Main: 149348352 00:51:37 INFO - PID 25232 | 00:51:39 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:51:40 INFO - PID 25232 | RSS: Main: 149262336 00:51:40 INFO - PID 25232 | 00:51:42 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:51:43 INFO - PID 25232 | RSS: Main: 149200896 00:51:43 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | Cycle 1(1): loaded http://localhost:43860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43860/tests/kraken/driver.html?testName=ai-astar) 00:51:45 INFO - PID 25232 | RSS: Main: 150958080 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | __start_tp_report 00:51:45 INFO - PID 25232 | _x_x_mozilla_page_load 00:51:45 INFO - PID 25232 | _x_x_mozilla_page_load_details 00:51:45 INFO - PID 25232 | |i|pagename|runs| 00:51:45 INFO - PID 25232 | |0;ai-astar;105;105;104;105;104;107;106;107;107;107 00:51:45 INFO - PID 25232 | |1;audio-beat-detection;112;113;111;114;109;137;111;111;111;111 00:51:45 INFO - PID 25232 | |2;audio-dft;161;163;163;164;162;163;161;163;161;161 00:51:45 INFO - PID 25232 | |3;audio-fft;73;73;73;73;72;76;75;84;72;73 00:51:45 INFO - PID 25232 | |4;audio-oscillator;78;78;87;89;77;78;77;76;77;78 00:51:45 INFO - PID 25232 | |5;imaging-gaussian-blur;113;113;113;115;110;114;114;110;115;123 00:51:45 INFO - PID 25232 | |6;imaging-darkroom;150;149;149;149;149;149;149;148;149;152 00:51:45 INFO - PID 25232 | |7;imaging-desaturate;94;94;94;94;94;94;94;93;95;94 00:51:45 INFO - PID 25232 | |8;json-parse-financial;45;48;42;42;42;43;43;43;44;42 00:51:45 INFO - PID 25232 | |9;json-stringify-tinderbox;40;39;39;39;39;39;39;39;40;39 00:51:45 INFO - PID 25232 | |10;stanford-crypto-aes;72;69;86;68;78;69;71;75;75;70 00:51:45 INFO - PID 25232 | |11;stanford-crypto-ccm;112;100;105;110;106;103;105;106;104;108 00:51:45 INFO - PID 25232 | |12;stanford-crypto-pbkdf2;159;154;150;148;164;152;146;149;149;155 00:51:45 INFO - PID 25232 | |13;stanford-crypto-sha256-iterative;62;59;57;60;57;57;58;57;59;58 00:51:45 INFO - PID 25232 | __end_tp_report 00:51:45 INFO - PID 25232 | __start_cc_report 00:51:45 INFO - PID 25232 | _x_x_mozilla_cycle_collect,708 00:51:45 INFO - PID 25232 | __end_cc_report 00:51:45 INFO - PID 25232 | __startTimestamp1507017105374__endTimestamp 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | ------- Summary: start ------- 00:51:45 INFO - PID 25232 | Number of tests: 14 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#0] ai-astar Cycles:10 Average:105.70 Median:106.50 stddev:1.25 (1.2%) stddev-sans-first:1.30 00:51:45 INFO - PID 25232 | Values: 105.0 105.0 104.0 105.0 104.0 107.0 106.0 107.0 107.0 107.0 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#1] audio-beat-detection Cycles:10 Average:114.00 Median:111.50 stddev:8.19 (7.3%) stddev-sans-first:8.66 00:51:45 INFO - PID 25232 | Values: 112.0 113.0 111.0 114.0 109.0 137.0 111.0 111.0 111.0 111.0 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 00:51:45 INFO - PID 25232 | Values: 161.0 163.0 163.0 164.0 162.0 163.0 161.0 163.0 161.0 161.0 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#3] audio-fft Cycles:10 Average:74.40 Median:73.00 stddev:3.60 (4.9%) stddev-sans-first:3.78 00:51:45 INFO - PID 25232 | Values: 73.0 73.0 73.0 73.0 72.0 76.0 75.0 84.0 72.0 73.0 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:78.00 stddev:4.55 (5.8%) stddev-sans-first:4.80 00:51:45 INFO - PID 25232 | Values: 78.0 78.0 87.0 89.0 77.0 78.0 77.0 76.0 77.0 78.0 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:3.62 (3.2%) stddev-sans-first:3.82 00:51:45 INFO - PID 25232 | Values: 113.0 113.0 113.0 115.0 110.0 114.0 114.0 110.0 115.0 123.0 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 00:51:45 INFO - PID 25232 | Values: 150.0 149.0 149.0 149.0 149.0 149.0 149.0 148.0 149.0 152.0 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 00:51:45 INFO - PID 25232 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 95.0 94.0 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#8] json-parse-financial Cycles:10 Average:43.40 Median:43.00 stddev:1.90 (4.4%) stddev-sans-first:1.92 00:51:45 INFO - PID 25232 | Values: 45.0 48.0 42.0 42.0 42.0 43.0 43.0 43.0 44.0 42.0 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#9] json-stringify-tinderbox Cycles:10 Average:39.20 Median:39.00 stddev:0.42 (1.1%) stddev-sans-first:0.33 00:51:45 INFO - PID 25232 | Values: 40.0 39.0 39.0 39.0 39.0 39.0 39.0 39.0 40.0 39.0 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.50 stddev:5.50 (7.5%) stddev-sans-first:5.81 00:51:45 INFO - PID 25232 | Values: 72.0 69.0 86.0 68.0 78.0 69.0 71.0 75.0 75.0 70.0 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#11] stanford-crypto-ccm Cycles:10 Average:105.90 Median:106.00 stddev:3.45 (3.3%) stddev-sans-first:2.86 00:51:45 INFO - PID 25232 | Values: 112.0 100.0 105.0 110.0 106.0 103.0 105.0 106.0 104.0 108.0 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:153.00 stddev:5.54 (3.6%) stddev-sans-first:5.37 00:51:45 INFO - PID 25232 | Values: 159.0 154.0 150.0 148.0 164.0 152.0 146.0 149.0 149.0 155.0 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.40 Median:58.50 stddev:1.65 (2.8%) stddev-sans-first:1.12 00:51:45 INFO - PID 25232 | Values: 62.0 59.0 57.0 60.0 57.0 57.0 58.0 57.0 59.0 58.0 00:51:45 INFO - PID 25232 | -------- Summary: end -------- 00:51:45 INFO - PID 25232 | 00:51:45 INFO - PID 25232 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 00:51:46 INFO - TEST-INFO | 25232: exit 0 00:51:46 INFO - TEST-OK | kraken | took 58906ms 00:51:46 INFO - SUITE-END | took 1166s 00:51:46 INFO - Completed test suite (00:19:26) 00:51:46 INFO - javascript benchmark 00:51:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9556.980389938986, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3908.0425295802524, 3930.1746633207026, 3947.052707350233, 3949.624785645363, 3975.7018223633218, 6570.441512471446, 6583.144191255142, 6607.339266073396, 6647.102641143444, 6673.432758215551, 6565.737370505186, 6582.901256481156, 6609.438197753185, 6678.131842860422, 6680.732770689178, 5863.413658634145, 5955.612885162473, 5979.611325263855, 5997.760089596411, 6000.669963152025, 5895.115732640095, 5935.139404786303, 6005.87988240235, 6018.7893423730175, 6103.42017508336, 5970.940290597082, 5974.342822289566, 6046.304674962392, 6059.545534084939, 6090.573659843791, 5895.734691938873, 5941.465268125846, 5972.283326000886, 6060.30306514752, 6074.119252708332, 5838.824835254949, 5839.7664093436215, 5866.14940833581, 5871.060630299175, 5937.821865344046, 6418.679066046726, 6559.409653131193, 6565.901511477332, 6579.473642108667, 6663.50023748216, 7116.893246601305, 7123.394511466531, 7126.3942564882045, 7211.206767255598, 7215.494915355927, 7040.753573624898, 7155.499115061948, 7155.821104472378, 7156.463265255126, 7159.821004474878, 6583.440407565363, 6616.305287944745, 6652.634105124216, 6737.461003119739, 6743.629100399476, 7273.6726847292, 7287.781366559012, 7374.151972523228, 7378.0, 7389.0, 7009.579425234502, 7013.859722805515, 7063.399611033017, 7117.857642847114, 7137.643117844087, 6912.481563882729, 7075.150981882207, 7139.036230108973, 7226.92773072273, 7253.709851605982, 7067.43460523157, 7108.182559005677, 7139.714411423589, 7158.463115266376, 7172.031775710212, 7081.0, 7096.432285417154, 7164.176119746192, 7179.748708795271, 7208.315210055036, 5185.0, 5241.030409374278, 5251.317328747315, 5296.682199068068, 5321.308229930084, 4772.236442169236, 4817.325574419584, 4871.537203965618, 4889.926651100236, 4907.852764417074, 6665.566738162004, 6678.465722742169, 6733.966330168318, 6774.525783195129, 6774.830629234309, 7076.893846592306, 7092.787216383414, 7093.751718689821, 7187.64061796908, 7192.496525243183, 6694.263631000586, 6708.0, 6729.831754206184, 6742.325767423218, 6771.492138089663, 5963.165156878041, 5971.402859713994, 6042.788502402394, 6043.7884674036195, 6063.605865618721, 7339.412846972229, 7413.666385012687, 7431.479796414307, 7524.887126693104, 7532.17146113927, 7024.016637670628, 7025.859482810418, 7028.8945665814035, 7032.929670703432, 7097.467689923174, 7404.481686281909, 7446.73936412223, 7458.328750412489, 7479.588622625808, 7524.360429363565, 7059.788206353817, 7069.505134640526, 7153.678084486315, 7163.6060016699585, 7167.426605871622, 7052.871540553487, 7133.785986420416, 7181.497295189287, 7214.675339609626, 7233.348998590152, 6668.899966500603, 6731.697073631601, 6825.180978282638, 6924.965375173092, 6928.1339832520935, 6813.0, 6883.65581720922, 6955.269696681776, 6965.33829286217, 6971.372576468142, 6794.0, 6818.0, 6844.349786770249, 6913.446924246149, 6943.062686537455, 6783.253842077466, 6967.303269673195, 6967.54710943787, 7034.577925324497, 7057.153141623038, 6710.597364158166, 6753.527253092433, 6781.7287308509085, 6837.282085381163, 6858.451323894176], "value": 6542.559679100947, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [991.2714155096005, 1011.2769369900524, 1016.740731113566, 1017.1760873692306, 1020.6376736258628, 42625.78687106564, 46485.0, 46668.53331466684, 46790.0, 46904.76547617266, 43587.0, 43676.0, 43773.0, 43861.342079868824, 43893.12213755731, 8104.918950810505, 8191.508509489449, 8211.548364839931, 8236.299914507274, 8646.394752367336, 8646.481211127353, 8752.387332886701, 8760.255378292853, 8762.693305734301, 8764.956175219115, 8731.476111433334, 8744.781380465507, 8751.256143227802, 8758.824823503526, 8769.473831570094, 8703.347248956323, 8735.956320218422, 8741.7814554636, 8762.780930476725, 8776.341774366916, 8705.825883482295, 8768.167024132697, 8778.0, 8780.121987801233, 8794.956025219833, 41879.0, 42051.0, 42127.0, 42153.36769948453, 42273.0, 3947.2500224957166, 3992.4210989406665, 4015.4579131817122, 4022.35642297231, 4023.738457000315, 34533.65466345329, 34670.47994280088, 34705.132371690655, 34714.13214669628, 34789.6521034789, 5718.5711071669375, 5728.570357223225, 5743.971280143614, 5766.711664416763, 5866.853328666774, 233213.0, 233802.83098584568, 234692.0, 234958.0, 236138.99999999828, 54921.0, 55087.173692394645, 55116.72441637766, 55324.0, 56288.71855640696, 58731.41268587345, 58766.11850822241, 58789.70605146947, 58804.7059764707, 58815.11777323343, 17058.48824535266, 17133.31466741341, 17166.65666686659, 17242.827571724374, 17251.309947601956, 13825.170489770646, 13914.721705565831, 13921.234332111628, 13921.512747053805, 13946.232957187452, 15756.842431575538, 15853.603659908595, 15903.443379481894, 16022.0, 16052.678946421007, 5997.250343707036, 6036.879262414727, 6061.696915154224, 6211.782587609412, 6260.530460215411, 1125.1729978465821, 1133.1416476977763, 1147.2026941275733, 1147.6442302885964, 1149.316156886651, 27020.054298099472, 27245.863770681415, 27306.5904011436, 27335.589966150525, 27370.45259094807, 1241.7330273991136, 1259.0871618076822, 1268.1059852803935, 1275.0, 1280.5134049061296, 14121.646958825906, 14304.642383940276, 14412.783808242884, 14431.567052988426, 14680.04579702316, 303757.0, 304653.0, 305655.0, 306391.0, 306569.0, 60544.39455605476, 61183.08225376623, 61810.69094654588, 61924.07113893295, 62004.0, 1565.092246497029, 1573.9606509837345, 1609.6941581099788, 1616.7089923813592, 1620.0441739373825, 29571.556426654046, 32194.67805321917, 32330.0, 32605.510917335785, 32792.34415311728, 56412.0, 56706.0, 56716.43283567111, 56790.0, 56875.71562142163, 243795.0, 244072.0, 245716.0, 247234.0, 247951.0, 38194.809025954695, 38465.0, 38488.80755596204, 38879.222415552096, 39013.609863900994, 48204.758976204896, 48327.0, 49026.509734902196, 49091.50908490869, 49224.75387623182, 35986.820065899505, 36093.819530902176, 36127.63872361243, 36201.63798362088, 37088.258234835695, 35226.823865880506, 35857.46213806847, 35959.460608090376, 36965.445518317785, 36998.07504812401, 42594.361084583135, 42772.572274276856, 42874.92812679708, 43277.783611081744, 43282.35076473918, 34609.30781384308, 34643.653563464046, 34736.131596710286, 34821.47767783536, 34838.47742283817, 26444.735552644226, 26493.867530662224, 26622.201333960013, 26817.180067611145, 27585.310367240978], "value": 19754.409435814166, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.6351763211404, 639.5459029698065, 640.9068295109793, 643.4206080667515, 647.0356509749853, 24253.0, 25041.74958250419, 25131.74868251317, 25153.371165720866, 25171.37071573207, 26327.0, 26670.466590668177, 26774.06290779823, 26898.865505672446, 26928.0, 6341.239051313849, 6526.510511711629, 6700.195976482829, 6766.898496522556, 6772.322767723237, 6636.369544893228, 6736.46108311334, 6737.2925842786535, 6738.292479289677, 6739.123913891187, 6593.439557637606, 6632.30360812115, 6674.432673222782, 6912.3778859902595, 6943.72225110995, 6930.688119034656, 6997.300269972988, 6998.825029374307, 6999.755008574675, 7000.614966176859, 6497.837554061139, 6521.706523206467, 6526.738930442777, 6528.967355163194, 6535.411812936859, 29969.250768730737, 30390.0, 30736.077917662507, 31046.37907241865, 31063.0681079568, 2261.1407665087327, 2290.2556669082614, 2312.8034117100065, 2318.7565305643, 2320.5706944215376, 20569.0, 21207.0, 21240.787592124034, 21258.787412125836, 21263.787362126335, 2603.609458581209, 2636.3145582148586, 2701.3381721478363, 2702.04077552468, 2707.9323016924736, 130321.0, 134352.0, 155900.0, 160954.0, 162043.0, 16338.264778085015, 16782.83217167813, 16829.83170168307, 16846.157692115346, 17249.741253881202, 27042.729572704415, 27104.59343109855, 27202.31994200161, 27206.911723531233, 27246.182614521596, 11120.277181983307, 11161.218714690056, 11325.716857078474, 11346.829797553044, 11484.0, 10304.330218535772, 10321.071103600712, 10328.741781455523, 10399.220058495492, 10405.38861133898, 10123.240756943258, 10136.44249566281, 10188.541515631814, 10266.076053155102, 10273.640422585173, 2923.0561676485327, 2958.4378967996013, 2979.0, 3015.819050856912, 3086.42901063304, 1056.4295280548572, 1067.3169171730099, 1071.041417930963, 1080.4543705428707, 1092.1044743310567, 21959.780402196095, 22057.558848822933, 22097.55804883893, 22171.0, 22181.223657171922, 1148.8736239013701, 1149.5172027748365, 1149.5286932357694, 1157.3229660648446, 1160.1762748448696, 12013.579524716593, 12078.21491603043, 12257.0, 12265.0187984961, 12390.81413778794, 585996.0, 593011.0, 593762.0, 611113.0, 618172.0, 126008.36995815145, 127683.3615831915, 128518.0, 128900.0, 130920.69079309276, 1159.5072094359864, 1180.3095189314176, 1243.7512497500536, 1299.7660421124099, 1306.033535183957, 22249.888750556143, 22447.663285051065, 22568.887155564775, 22595.88702056479, 22829.77170228343, 63035.68482157743, 63151.6842415785, 63833.0, 65908.0, 66117.66941165263, 79422.6028869852, 79772.0, 80255.59872200602, 80380.0, 81282.0, 15855.920720396785, 16255.105969171336, 16257.349706011628, 16319.510414687104, 16370.590735231715, 23751.0, 24801.759912004687, 25021.624675630243, 25031.374215644028, 25044.0, 20423.387298381072, 20530.79469205289, 20581.07385167701, 20687.58624827465, 20719.689204662245, 17723.29106835712, 18063.2774689011, 18282.360117395827, 18491.81508184901, 18566.885986840294, 20481.795182048583, 20792.688109678063, 20810.0, 20865.165393384093, 21032.05355758964, 15823.604409889384, 16009.919950400174, 16092.919535402716, 16121.758173627639, 16124.67750645004, 18902.14940327716, 19827.30604428838, 19930.90034549818, 20099.799002009793, 20124.698129527776], "value": 13180.821519797972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.5888912770731, 1469.3608280398034, 1472.2417954753312, 1490.6198919275587, 1499.1679617812117, 17097.829021709797, 17693.46919592411, 17746.20142093607, 17767.111644417775, 17783.0, 17506.0, 17550.912245438787, 17614.735778963324, 17630.294788208488, 17648.205830737614, 3060.831654259015, 3071.9692803071907, 3152.7320177784914, 3154.4164329598984, 3155.9368812623734, 3064.8007879487764, 3108.502639577668, 3123.5002399616064, 3134.2477805326785, 3134.9373012539736, 3066.9693303066906, 3173.952390714141, 3180.936381272373, 3193.297474555594, 3202.8078315301154, 3077.723004929545, 3087.0893086539636, 3099.457594920891, 3120.8595613197463, 3134.435801555719, 3114.112477943798, 3129.796563223383, 3157.2264795125343, 3159.510275907238, 3163.572917656133, 17016.06411647359, 17366.826331736647, 17380.3047878086, 17393.0, 17425.82574174255, 8622.3533235007, 8889.4666320021, 8904.955475222583, 8909.1536304051, 8926.553672316359, 5605.7937359166135, 5663.830085097454, 5795.768169273224, 5836.066229403275, 5842.532597392198, 2219.5782801267706, 2244.6857439958417, 2257.4356410897276, 2300.1719381022817, 2311.456807650201, 31733.0, 31820.20449488758, 31989.6801031989, 32001.51997720013, 32002.83998579992, 7565.886511702329, 7634.50375725576, 7650.38796896247, 7712.6529306181355, 7805.2194780521495, 20439.795602044087, 20485.897570512054, 20504.487387815425, 20522.38432846987, 20535.4866128348, 8647.221750042527, 8739.475631462132, 8802.207801297915, 8812.250958668585, 8816.118388161261, 7674.769756907302, 7881.330086942674, 8071.5157090573575, 8156.551389673625, 8304.916950830535, 5838.824835254949, 6063.181470501514, 6114.388561143939, 6145.66198859067, 6150.415710507584, 1647.571631375851, 1689.0794516988271, 1788.1595650044458, 1811.184966764961, 1821.0439519252498, 1014.3558840136567, 1055.261317078033, 1056.587930707025, 1057.2440704896037, 1058.4972138234277, 10499.835613162944, 10501.579936802595, 10581.89418105809, 10603.204759642904, 10739.516721747541, 828.1304630138451, 829.1252728371626, 833.9124391938881, 839.3788596438592, 902.9187373136318, 6228.377162283736, 6386.593136156029, 6441.227052753606, 6510.934890651128, 6582.275949645536, 23858.403539911295, 26181.607275890878, 26247.21258362252, 26297.474050518882, 26300.86849565778, 24297.878510607334, 25422.618660720105, 25689.229323120337, 25742.227733168034, 25759.48481030369, 12988.935055324662, 13017.284049377186, 13207.933960330136, 13287.534936277378, 13297.734045319039, 9744.317897747089, 9949.303548751517, 10066.848997265193, 10162.949185254027, 10165.898341016495, 22347.329580112622, 22499.100035998377, 22562.774372256066, 22667.773322266567, 23119.959601818297, 22930.770692292863, 23063.4234144141, 23447.531049379257, 23547.646785298577, 24369.878150609842, 12582.685432864251, 12613.81079283793, 12617.369131543202, 12734.108612397044, 12744.49022039108, 16243.0, 16296.0, 16431.096289703702, 16432.753508697617, 16472.0, 13204.66988325261, 13238.338083095614, 13262.469501219843, 13276.933615331862, 13318.467261309439, 11682.415879205835, 12049.518019279481, 12204.633860984184, 12266.632001039983, 12324.568640097554, 11293.604723834625, 11457.885421146015, 11510.42447877586, 11514.136439766884, 11543.595974140864, 8848.955755221183, 8887.0, 8974.102589740975, 9062.456252624863, 9071.365004449624, 8934.28525717954, 8951.507667078373, 8969.641214351353, 9034.638614455349, 9096.363254572116], "value": 7712.841420640516, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.6159780550321, 578.4995978478614, 579.3250862744902, 594.47983014862, 604.8608819971406, 6285.214348206474, 6333.968330158348, 6443.0, 6498.0, 6550.934490655104, 6293.339199384056, 6336.461400780928, 6360.328661961976, 6369.20384951881, 6473.126127972734, 5310.707911064899, 5329.467053294659, 5353.518183363496, 5369.677819330833, 5378.381486129106, 5104.489551044903, 5199.272101905717, 5200.92198617021, 5221.582273418117, 5328.706921119337, 5181.689098654074, 5201.869953251161, 5218.295530103444, 5226.660267082647, 5232.372115346145, 5122.1804511278015, 5144.588432925376, 5145.845624631267, 5188.0, 5191.792328306863, 4712.3167140764735, 4713.811447542094, 4727.125481785881, 4751.004578077182, 4765.332853400527, 6323.0, 6440.033994900756, 6451.93548064518, 6493.577917435352, 6496.447801936841, 6047.457898235922, 6068.6358818471035, 6104.328523862416, 6121.908171377433, 6195.690215489252, 6844.178698556205, 6882.862342753167, 6888.965555172192, 6904.203797461986, 6906.929425938987, 5120.206368012964, 5268.736563171826, 5308.761105750251, 5314.441983591706, 5334.333208348957, 6917.204521480044, 7148.964255178743, 7160.427165826722, 7235.204127546019, 7266.636668166623, 5395.379531353945, 5423.810166644227, 5427.701476418835, 5456.208849716769, 5485.396606373296, 5465.988792073479, 5481.397046324901, 5518.19986102013, 5522.30971128609, 5544.833654990357, 6084.209052823105, 6107.328193898667, 6128.142060111588, 6145.877082458326, 6181.381861813783, 6920.619365934821, 6936.895946560806, 6968.198657154391, 6976.616286104313, 7003.719851205997, 1891.2529550827621, 1891.9783317008937, 1906.4471303321882, 1914.9138288777037, 1917.3768525229357, 1311.1280998136324, 1356.9796453053211, 1357.043284484436, 1358.7418390505773, 1362.591222633226, 6487.545871789024, 6513.73945042193, 6579.30917253691, 6579.868402632016, 6587.670616469253, 6777.762778302736, 6885.724571017103, 6947.89578156328, 6960.025596416505, 6967.9444563853785, 6473.216516897779, 6534.019897015486, 6537.444317232993, 6539.47684185264, 6596.505262105361, 3652.5616925969052, 3702.500162478085, 3705.981470092632, 3727.5154229950476, 3742.36379815432, 7329.486935914435, 7365.594892280976, 7386.556806591621, 7392.519486233377, 7474.0, 7199.2440793715905, 7275.454340924452, 7307.378872795872, 7307.744228952068, 7323.487355885037, 7261.237570055174, 7283.417326613964, 7411.5553066816165, 7415.295546923034, 7466.139080821529, 7005.614691192033, 7057.424040225178, 7070.575765454089, 7137.536060156073, 7162.964185179041, 6907.827304317432, 6929.411000064849, 6938.0, 6946.7495850747355, 7007.964960175166, 7329.890051649123, 7355.154157271768, 7383.778486645409, 7391.0, 7413.443991700752, 5466.867921510535, 5472.945270547243, 5474.863128421821, 5475.863103422287, 5479.424660410599, 6757.831054223684, 6795.218549866829, 7020.929790702027, 7031.226565077735, 7061.505694601328, 6836.48726345536, 6850.38346548813, 6857.177138743383, 6884.7641608443955, 6890.276520965226, 6743.325667433413, 6789.15135608049, 6818.0, 6851.588904665537, 6882.76709823465, 6587.736490540325, 6681.5656982296, 6691.732330706717, 6773.93226067733, 6811.625360605214, 6863.828404289733, 6868.244493105854, 6905.792826215222, 6951.652417379212, 6964.65176741171, 6662.167229096363, 6688.3646053624825, 6697.3637504437, 6725.697343619451, 6743.426808721314], "value": 5409.2712244158265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1006.3056491021194, 1013.6705570689528, 1033.8087453821045, 1054.6783231114507, 1062.500624706388, 21393.0, 21940.561188776213, 21985.340439786833, 21990.780092199075, 21994.45013874652, 19549.21803127873, 19618.0, 19618.0, 19667.508312292164, 19750.802491975075, 1060.978780424391, 1075.8493810866446, 1082.3668154129844, 1082.4749996251812, 1086.9293495922739, 1097.6048622495896, 1098.6484325015958, 1101.5869049106584, 1102.6802227354099, 1104.116706634693, 1049.6221360310283, 1093.5625749700143, 1145.4272863568217, 1149.1553708024596, 1149.5689116581282, 1142.4858813533901, 1144.2333636463588, 1146.7419830538145, 1147.23708733692, 1147.3402793393832, 835.3859912964027, 835.4444294544121, 838.0, 838.0822998816286, 838.5723281126608, 20888.791112088988, 21299.467513312135, 21304.254351097792, 21425.250116246014, 22228.666570001464, 23630.527389452116, 23765.0, 24164.2750717477, 24207.2737817864, 24220.757792422028, 19546.80453195464, 19643.508912277164, 19781.40655780329, 19789.80210197894, 19805.306814261432, 4198.055437526563, 4234.13200293939, 4237.915241695179, 4250.574942505725, 4251.59609837065, 128712.35643821815, 151026.24486877606, 155083.0, 159824.0, 160816.99999999884, 19031.0, 19335.226590936487, 19411.417657470298, 19429.80570194308, 19461.22155113808, 35460.113497162776, 35643.0, 35975.64024359775, 36192.457113143326, 36198.45702314467, 9968.003199679973, 10035.598576056876, 10148.898511014942, 10169.13562347194, 10203.693889183336, 4666.2067448533835, 4692.085043416501, 4783.856484305476, 4825.083234185494, 4844.055409195244, 5580.386157522669, 5770.740316685759, 5783.913241301384, 5804.506616937523, 6072.544559158081, 1234.2224398628807, 1281.0456210123518, 1281.9935900320438, 1297.3772589157256, 1299.2918859221747, 761.7638532055081, 774.4578794843519, 782.0927723840318, 788.0700773087697, 803.1567552467102, 13316.15248997361, 13936.094153879965, 14846.554603361916, 14870.925645371704, 15063.0, 767.0450289389745, 774.4462709162975, 775.4145620056934, 781.3749000799338, 783.1972228465868, 6331.715072821734, 6355.237371515355, 6384.52116091295, 6430.099786029959, 6462.773802916875, 154631.0, 154660.45339546684, 156439.21780391253, 157147.0, 157660.0, 124567.0, 128042.0, 128467.0, 129154.0, 134281.0, 113572.0, 114233.0, 116556.41721791506, 117068.0, 119409.40295298467, 13965.441382344592, 14217.857821421654, 14442.0, 14494.202818845064, 14697.19165445868, 54906.176407354724, 55528.44471555233, 55878.44121558895, 56032.43967560435, 56269.71865140648, 93158.0, 93504.0, 93752.53123734337, 96040.4102984292, 96365.5181724115, 21174.258900938392, 21269.0, 21369.0, 21477.785222147577, 21507.46231344229, 24276.514469710153, 24380.75619243856, 24983.500329992934, 25173.370665733502, 25281.74718252794, 21071.894640526698, 21304.147834086463, 21312.0, 21579.13683452707, 21643.35069947904, 19827.0, 20076.09657565442, 21112.577748445252, 22011.449713756643, 22183.334499965025, 21101.683474747584, 21630.35108946734, 21665.241716539844, 21739.673904891122, 21821.23625673094, 15924.363025478851, 16124.758128628315, 16439.0, 16457.67084658324, 16585.91707041457, 15727.842721572637, 15893.284802183698, 16167.191640417697, 16295.837041629431, 16342.754858677366], "value": 10719.907211826907, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1365.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 104.0, 105.0, 104.0, 107.0, 106.0, 107.0, 107.0, 107.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 111.0, 114.0, 109.0, 137.0, 111.0, 111.0, 111.0, 111.0], "value": 114.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 164.0, 162.0, 163.0, 161.0, 163.0, 161.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 73.0, 72.0, 76.0, 75.0, 84.0, 72.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 87.0, 89.0, 77.0, 78.0, 77.0, 76.0, 77.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 115.0, 110.0, 114.0, 114.0, 110.0, 115.0, 123.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 148.0, 149.0, 152.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 95.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 48.0, 42.0, 42.0, 42.0, 43.0, 43.0, 43.0, 44.0, 42.0], "value": 43.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 39.0, 39.0, 39.0, 39.0, 39.0, 39.0, 39.0, 40.0, 39.0], "value": 39.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 86.0, 68.0, 78.0, 69.0, 71.0, 75.0, 75.0, 70.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 100.0, 105.0, 110.0, 106.0, 103.0, 105.0, 106.0, 104.0, 108.0], "value": 105.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 154.0, 150.0, 148.0, 164.0, 152.0, 146.0, 149.0, 149.0, 155.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 57.0, 60.0, 57.0, 57.0, 58.0, 57.0, 59.0, 58.0], "value": 58.4, "unit": "score"}]}]} 00:51:46 INFO - Return code: 0 00:51:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:51:46 INFO - # TBPL SUCCESS # 00:51:46 INFO - Running post-action listener: _package_coverage_data 00:51:46 INFO - Running post-action listener: _resource_record_post_action 00:51:46 INFO - [mozharness: 2017-10-03 07:51:46.662324Z] Finished run-tests step (success) 00:51:46 INFO - Running post-run listener: _resource_record_post_run 00:51:46 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 280326144; Read time: 16; Write time: 139560 00:51:46 INFO - TinderboxPrint: CPU usage
13.1% 00:51:46 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 00:51:46 INFO - TinderboxPrint: I/O write bytes / time
280,326,144 / 139,560 00:51:46 INFO - TinderboxPrint: CPU idle
8,186.5 (86.9%) 00:51:46 INFO - TinderboxPrint: CPU user
1,181.2 (12.5%) 00:51:46 INFO - TinderboxPrint: Swap in / out
0 / 0 00:51:46 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9297920; Read time: 0; Write time: 1092 00:51:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 00:51:46 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 8192; Write bytes: 271028224; Read time: 16; Write time: 138468 00:51:47 INFO - Running post-run listener: _upload_blobber_files 00:51:47 INFO - Blob upload gear active. 00:51:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:51:47 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 00:51:47 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'] 00:51:47 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 00:51:47 INFO - (blobuploader) - INFO - Open directory for files ... 00:51:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:51:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:51:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:51:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:51:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:51:48 INFO - (blobuploader) - INFO - Done attempting. 00:51:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:51:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:51:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:51:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:51:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:51:49 INFO - (blobuploader) - INFO - Done attempting. 00:51:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:51:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:51:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:51:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:51:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:51:50 INFO - (blobuploader) - INFO - Done attempting. 00:51:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:51:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:51:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:51:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:51:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:51:57 INFO - (blobuploader) - INFO - Done attempting. 00:51:57 INFO - (blobuploader) - INFO - Iteration through files over. 00:51:57 INFO - Return code: 0 00:51:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:51:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:51:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/405457b1e79abba794469168efd4050432f400368c7f3db06405c10550322fe59a7f1b91bae113837ed38d0291bcb57d0581c396755076b824b5cfe77d8516c2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5741807e754e3052adc50b18ea7f98ee47fe795c161dd3ebcf852e70f41ca9d805386f1e1e46961f2f9147189409daa1939aaeb87e0d7b1350cf49ec3c960f12", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1feab019d8e6850ed5bb53413f41c90765a4fd4c8728f043ac2c35cb3e2f52c5a6a1efecc966317e1459f340c38e3dbd6e3d1d477d90857d07623bee2473e883", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1e261625bae9bdcc9a14c64acbd8ff7370ced789253a21de2c9429c763a2dbe18f412e8681d2bfe98c24fce5b2e7dbbd838fa91b133ff33a1da2b92bd2f2731b"} 00:51:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:51:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:51:58 INFO - Contents: 00:51:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/405457b1e79abba794469168efd4050432f400368c7f3db06405c10550322fe59a7f1b91bae113837ed38d0291bcb57d0581c396755076b824b5cfe77d8516c2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5741807e754e3052adc50b18ea7f98ee47fe795c161dd3ebcf852e70f41ca9d805386f1e1e46961f2f9147189409daa1939aaeb87e0d7b1350cf49ec3c960f12", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1feab019d8e6850ed5bb53413f41c90765a4fd4c8728f043ac2c35cb3e2f52c5a6a1efecc966317e1459f340c38e3dbd6e3d1d477d90857d07623bee2473e883", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1e261625bae9bdcc9a14c64acbd8ff7370ced789253a21de2c9429c763a2dbe18f412e8681d2bfe98c24fce5b2e7dbbd838fa91b133ff33a1da2b92bd2f2731b"} 00:51:58 INFO - Running post-run listener: copy_logs_to_upload_dir 00:51:58 INFO - Copying logs to upload dir... 00:51:58 INFO - mkdir: /builds/slave/test/build/upload/logs 00:51:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.522553 ========= master_lag: 0.55 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-10-03 00:51:58.077397) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 00:51:58.084210) ========= 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=1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090 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/405457b1e79abba794469168efd4050432f400368c7f3db06405c10550322fe59a7f1b91bae113837ed38d0291bcb57d0581c396755076b824b5cfe77d8516c2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5741807e754e3052adc50b18ea7f98ee47fe795c161dd3ebcf852e70f41ca9d805386f1e1e46961f2f9147189409daa1939aaeb87e0d7b1350cf49ec3c960f12", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1feab019d8e6850ed5bb53413f41c90765a4fd4c8728f043ac2c35cb3e2f52c5a6a1efecc966317e1459f340c38e3dbd6e3d1d477d90857d07623bee2473e883", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1e261625bae9bdcc9a14c64acbd8ff7370ced789253a21de2c9429c763a2dbe18f412e8681d2bfe98c24fce5b2e7dbbd838fa91b133ff33a1da2b92bd2f2731b"} build_url:https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/OK-m40jUR-mNArco46uLcw/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/405457b1e79abba794469168efd4050432f400368c7f3db06405c10550322fe59a7f1b91bae113837ed38d0291bcb57d0581c396755076b824b5cfe77d8516c2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5741807e754e3052adc50b18ea7f98ee47fe795c161dd3ebcf852e70f41ca9d805386f1e1e46961f2f9147189409daa1939aaeb87e0d7b1350cf49ec3c960f12", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1feab019d8e6850ed5bb53413f41c90765a4fd4c8728f043ac2c35cb3e2f52c5a6a1efecc966317e1459f340c38e3dbd6e3d1d477d90857d07623bee2473e883", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1e261625bae9bdcc9a14c64acbd8ff7370ced789253a21de2c9429c763a2dbe18f412e8681d2bfe98c24fce5b2e7dbbd838fa91b133ff33a1da2b92bd2f2731b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 00:51:58.116221) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 00:51:58.116665) ========= 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=1258088b6da462a47ba2cd90000001a2-1507014665.97866-1191009090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 00:51:58.197844) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 00:51:58.198201) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 00:51:58.198527) ========= ========= Total master_lag: 0.71 =========