builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1505066783.19 results: success (0) revision: fd87bb184e299fec695f69bd2977276c25719b98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.187258) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.187844) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.188127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.296315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.296573) ========= 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=d2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-10 11:06:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 99.5M=0s 2017-09-10 11:06:23 (99.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127377 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.471511) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.471843) ========= 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=d2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020572 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.523192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.523510) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fd87bb184e299fec695f69bd2977276c25719b98 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev fd87bb184e299fec695f69bd2977276c25719b98 --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=d2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-10 11:06:23,589 truncating revision to first 12 chars 2017-09-10 11:06:23,589 Setting DEBUG logging. 2017-09-10 11:06:23,589 attempt 1/10 2017-09-10 11:06:23,590 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fd87bb184e29?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-10 11:06:24,192 unpacking tar archive at: mozilla-central-fd87bb184e29/testing/mozharness/ program finished with exit code 0 elapsedTime=0.909273 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:24.453457) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:24.453776) ========= script_repo_revision: fd87bb184e299fec695f69bd2977276c25719b98 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:24.454237) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:24.454598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:24.469536) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-10 11:06:24.469932) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:06:24 INFO - MultiFileLogger online at 20170910 11:06:24 in /builds/slave/test 11:06:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:06:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:24 INFO - {'append_to_log': False, 11:06:24 INFO - 'base_work_dir': '/builds/slave/test', 11:06:24 INFO - 'blob_upload_branch': 'Firefox', 11:06:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:24 INFO - 'branch': 'Firefox', 11:06:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:24 INFO - 'code_coverage': False, 11:06:24 INFO - 'config_files': ('talos/linux_config.py',), 11:06:24 INFO - 'default_actions': ('clobber', 11:06:24 INFO - 'read-buildbot-config', 11:06:24 INFO - 'download-and-extract', 11:06:24 INFO - 'populate-webroot', 11:06:24 INFO - 'create-virtualenv', 11:06:24 INFO - 'install', 11:06:24 INFO - 'setup-mitmproxy', 11:06:24 INFO - 'run-tests'), 11:06:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:24 INFO - 'disable_ccov_upload': False, 11:06:24 INFO - 'disable_stylo': False, 11:06:24 INFO - 'download_minidump_stackwalk': True, 11:06:24 INFO - 'download_symbols': 'ondemand', 11:06:24 INFO - 'enable_stylo': False, 11:06:24 INFO - 'enable_webrender': False, 11:06:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:06:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:24 INFO - 'gecko_profile': False, 11:06:24 INFO - 'gecko_profile_interval': 0, 11:06:24 INFO - 'installer_path': 'installer.exe', 11:06:24 INFO - 'log_level': 'info', 11:06:24 INFO - 'log_name': 'talos', 11:06:24 INFO - 'log_to_console': True, 11:06:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:06:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:06:24 INFO - 'opt_config_files': (), 11:06:24 INFO - 'pip_index': False, 11:06:24 INFO - 'suite': 'dromaeojs-e10s', 11:06:24 INFO - 'system_bits': '32', 11:06:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:24 INFO - 'title': 'talos-linux64-ix-043', 11:06:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:24 INFO - 'use_talos_json': True, 11:06:24 INFO - 'verify': 'False', 11:06:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:24 INFO - 'work_dir': 'build'} 11:06:24 INFO - [mozharness: 2017-09-10 18:06:24.764963Z] Running clobber step. 11:06:24 INFO - Running pre-action listener: _resource_record_pre_action 11:06:24 INFO - Running main action method: clobber 11:06:24 INFO - rmtree: /builds/slave/test/build 11:06:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:06:25 INFO - Running post-action listener: _resource_record_post_action 11:06:25 INFO - [mozharness: 2017-09-10 18:06:25.738656Z] Finished clobber step (success) 11:06:25 INFO - [mozharness: 2017-09-10 18:06:25.738752Z] Running read-buildbot-config step. 11:06:25 INFO - Running pre-action listener: _resource_record_pre_action 11:06:25 INFO - Running main action method: read_buildbot_config 11:06:25 INFO - Using buildbot properties: 11:06:25 INFO - { 11:06:25 INFO - "project": "", 11:06:25 INFO - "product": "firefox", 11:06:25 INFO - "who": "ffxbld@noreply.mozilla.org", 11:06:25 INFO - "installer_path": "public/build/target.tar.bz2", 11:06:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:06:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:06:25 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:06:25 INFO - "stage_platform": "linux64-qr", 11:06:25 INFO - "basedir": "/builds/slave/test", 11:06:25 INFO - "buildnumber": 44, 11:06:25 INFO - "platform": "ubuntu64_hw_qr", 11:06:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:06:25 INFO - "slavebuilddir": "test", 11:06:25 INFO - "taskId": "LS97OCOIST-NpLxeCxvGAg", 11:06:25 INFO - "branch": "mozilla-central", 11:06:25 INFO - "script_repo_revision": "production", 11:06:25 INFO - "revision": "fd87bb184e299fec695f69bd2977276c25719b98", 11:06:25 INFO - "slavename": "talos-linux64-ix-043", 11:06:25 INFO - "repo_path": "mozilla-central" 11:06:25 INFO - } 11:06:25 INFO - Finding installer, test and symbols from parent task. 11:06:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LS97OCOIST-NpLxeCxvGAg'}, attempt #1 11:06:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LS97OCOIST-NpLxeCxvGAg'}, attempt #1 11:06:26 INFO - Task dependencies: UZWMEdQaTLGG8H3YMvQkdw 11:06:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw'}, attempt #1 11:06:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2 11:06:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.test_packages.json 11:06:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.crashreporter-symbols.zip 11:06:27 INFO - Running post-action listener: _resource_record_post_action 11:06:27 INFO - [mozharness: 2017-09-10 18:06:27.126595Z] Finished read-buildbot-config step (success) 11:06:27 INFO - [mozharness: 2017-09-10 18:06:27.126813Z] Running download-and-extract step. 11:06:27 INFO - Running pre-action listener: _resource_record_pre_action 11:06:27 INFO - Running main action method: download_and_extract 11:06:27 INFO - mkdir: /builds/slave/test/build/tests 11:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:27 INFO - trying https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.test_packages.json 11:06:27 INFO - Downloading https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:06:27 INFO - Downloaded 989 bytes. 11:06:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:06:27 INFO - Using the following test package requirements: 11:06:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:06:27 INFO - u'common': [u'target.common.tests.zip'], 11:06:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:06:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:06:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:06:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:06:27 INFO - u'mozbase': [u'target.common.tests.zip'], 11:06:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:06:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:06:27 INFO - u'web-platform': [u'target.common.tests.zip', 11:06:27 INFO - u'target.web-platform.tests.tar.gz'], 11:06:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:06:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:06:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.common.tests.zip 11:06:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:06:27 INFO - Fetch https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.common.tests.zip into memory 11:06:28 INFO - Content-Length response header: 55028530 11:06:28 INFO - Bytes received: 55028530 11:06:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.talos.tests.zip 11:06:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:06:40 INFO - Fetch https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.talos.tests.zip into memory 11:06:41 INFO - Content-Length response header: 14497963 11:06:41 INFO - Bytes received: 14497963 11:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:41 INFO - trying https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2 11:06:41 INFO - Downloading https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:06:43 INFO - Downloaded 62940438 bytes. 11:06:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2 11:06:43 INFO - mkdir: /builds/slave/test/properties 11:06:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:06:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:06:43 INFO - Contents: 11:06:43 INFO - build_url:https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2 11:06:43 INFO - Running post-action listener: _resource_record_post_action 11:06:43 INFO - Running post-action listener: find_tests_for_verification 11:06:43 INFO - Running post-action listener: set_extra_try_arguments 11:06:43 INFO - [mozharness: 2017-09-10 18:06:43.299454Z] Finished download-and-extract step (success) 11:06:43 INFO - [mozharness: 2017-09-10 18:06:43.299552Z] Running populate-webroot step. 11:06:43 INFO - Running pre-action listener: _resource_record_pre_action 11:06:43 INFO - Running main action method: populate_webroot 11:06:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:06:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['tresize', 11:06:43 INFO - 'tcanvasmark']}, 11:06:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:06:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['dromaeo_css', 11:06:43 INFO - 'kraken']}, 11:06:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'tests': ['damp', 'tps']}, 11:06:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['damp', 'tps']}, 11:06:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:06:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['dromaeo_dom']}, 11:06:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:06:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['basic_compositor_video', 11:06:43 INFO - 'glvideo']}, 11:06:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:06:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['ts_paint_webext', 11:06:43 INFO - 'tp5o_webext']}, 11:06:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:06:43 INFO - 'ts_paint', 11:06:43 INFO - 'tpaint', 11:06:43 INFO - 'sessionrestore', 11:06:43 INFO - 'sessionrestore_many_windows', 11:06:43 INFO - 'sessionrestore_no_auto_restore', 11:06:43 INFO - 'tabpaint']}, 11:06:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['a11yr', 11:06:43 INFO - 'ts_paint', 11:06:43 INFO - 'tpaint', 11:06:43 INFO - 'sessionrestore', 11:06:43 INFO - 'sessionrestore_many_windows', 11:06:43 INFO - 'sessionrestore_no_auto_restore', 11:06:43 INFO - 'tabpaint']}, 11:06:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:06:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:06:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['bloom_basic_singleton']}, 11:06:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['bloom_basic']}, 11:06:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:06:43 INFO - 'tsvgr_opacity', 11:06:43 INFO - 'tart', 11:06:43 INFO - 'tscrollx', 11:06:43 INFO - 'tsvg_static']}, 11:06:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['tsvgx', 11:06:43 INFO - 'tsvgr_opacity', 11:06:43 INFO - 'tart', 11:06:43 INFO - 'tscrollx', 11:06:43 INFO - 'tsvg_static']}, 11:06:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:06:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['tp5o']}, 11:06:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:06:43 INFO - 'talos_options': ['--mitmproxy', 11:06:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:06:43 INFO - '--firstNonBlankPaint'], 11:06:43 INFO - 'tests': ['tp6_google', 11:06:43 INFO - 'tp6_youtube', 11:06:43 INFO - 'tp6_amazon', 11:06:43 INFO - 'tp6_facebook']}, 11:06:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:06:43 INFO - 'talos_options': ['--disable-stylo', 11:06:43 INFO - '--mitmproxy', 11:06:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:06:43 INFO - '--firstNonBlankPaint'], 11:06:43 INFO - 'tests': ['tp6_google', 11:06:43 INFO - 'tp6_youtube', 11:06:43 INFO - 'tp6_amazon', 11:06:43 INFO - 'tp6_facebook']}, 11:06:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:06:43 INFO - 'talos_options': ['--stylo-threads=1', 11:06:43 INFO - '--mitmproxy', 11:06:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:06:43 INFO - '--firstNonBlankPaint'], 11:06:43 INFO - 'tests': ['tp6_google', 11:06:43 INFO - 'tp6_youtube', 11:06:43 INFO - 'tp6_amazon', 11:06:43 INFO - 'tp6_facebook']}, 11:06:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'talos_options': ['--xperf_path', 11:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:43 INFO - 'tests': ['tp5n']}, 11:06:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'talos_options': ['--disable-stylo', 11:06:43 INFO - '--xperf_path', 11:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:43 INFO - 'tests': ['tp5n']}}} 11:06:43 INFO - Running post-action listener: _resource_record_post_action 11:06:43 INFO - [mozharness: 2017-09-10 18:06:43.314439Z] Finished populate-webroot step (success) 11:06:43 INFO - [mozharness: 2017-09-10 18:06:43.314528Z] Running create-virtualenv step. 11:06:43 INFO - Running pre-action listener: _resource_record_pre_action 11:06:43 INFO - Running main action method: create_virtualenv 11:06:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:06:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:06:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:06:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:06:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:06:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:06:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:06:44 INFO - Installing pip...............done. 11:06:44 INFO - Return code: 0 11:06:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:06:44 INFO - Reading from file tmpfile_stdout 11:06:44 INFO - Output received: 11:06:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:06:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:06:44 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')]} 11:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:44 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')]} 11:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:44 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 0x16301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0090>, '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 0x19a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', '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 11:06:44 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 11:06:44 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 11:06:44 INFO - Using env: {'DISPLAY': ':0', 11:06:44 INFO - 'HOME': '/home/cltbld', 11:06:44 INFO - 'LANG': 'en_US.UTF-8', 11:06:44 INFO - 'LANGUAGE': 'en_US:en', 11:06:44 INFO - 'LOGNAME': 'cltbld', 11:06:44 INFO - 'MAIL': '/var/mail/cltbld', 11:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:44 INFO - 'MOZ_NO_REMOTE': '1', 11:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:44 INFO - 'NO_EM_RESTART': '1', 11:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:44 INFO - 'PWD': '/builds/slave/test', 11:06:44 INFO - 'SHELL': '/bin/bash', 11:06:44 INFO - 'SHLVL': '1', 11:06:44 INFO - 'TERM': 'linux', 11:06:44 INFO - 'TMOUT': '86400', 11:06:44 INFO - 'USER': 'cltbld', 11:06:44 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', 11:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:44 INFO - '_': '/tools/buildbot/bin/python'} 11:06:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:06:46 INFO - Downloading/unpacking pip>=1.5 11:06:46 INFO - Running setup.py egg_info for package pip 11:06:46 INFO - warning: no files found matching 'pip/cacert.pem' 11:06:46 INFO - warning: no files found matching '*.html' under directory 'docs' 11:06:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:06:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:06:46 INFO - Installing collected packages: pip 11:06:46 INFO - Found existing installation: pip 1.1 11:06:46 INFO - Uninstalling pip: 11:06:46 INFO - Successfully uninstalled pip 11:06:46 INFO - Running setup.py install for pip 11:06:46 INFO - warning: no files found matching 'pip/cacert.pem' 11:06:46 INFO - warning: no files found matching '*.html' under directory 'docs' 11:06:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:06:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:06:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:06:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:06:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:06:46 INFO - Successfully installed pip 11:06:46 INFO - Cleaning up... 11:06:46 INFO - Return code: 0 11:06:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06: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')]} 11:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06: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 0x16301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0090>, '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 0x19a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', '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 11:06: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 11:06: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 11:06:46 INFO - Using env: {'DISPLAY': ':0', 11:06:46 INFO - 'HOME': '/home/cltbld', 11:06:46 INFO - 'LANG': 'en_US.UTF-8', 11:06:46 INFO - 'LANGUAGE': 'en_US:en', 11:06:46 INFO - 'LOGNAME': 'cltbld', 11:06:46 INFO - 'MAIL': '/var/mail/cltbld', 11:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:46 INFO - 'MOZ_NO_REMOTE': '1', 11:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:46 INFO - 'NO_EM_RESTART': '1', 11:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:46 INFO - 'PWD': '/builds/slave/test', 11:06:46 INFO - 'SHELL': '/bin/bash', 11:06:46 INFO - 'SHLVL': '1', 11:06:46 INFO - 'TERM': 'linux', 11:06:46 INFO - 'TMOUT': '86400', 11:06:46 INFO - 'USER': 'cltbld', 11:06:46 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', 11:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:46 INFO - '_': '/tools/buildbot/bin/python'} 11:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:46 INFO - Downloading/unpacking psutil>=3.1.1 11:06: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 11:06: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 11:06: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 11:06: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 11:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:06:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:48 INFO - Installing collected packages: psutil 11:06:48 INFO - Running setup.py install for psutil 11:06:48 INFO - building 'psutil._psutil_linux' extension 11:06: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 11:06:49 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 11:06:49 INFO - building 'psutil._psutil_posix' extension 11:06:49 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 11:06:49 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 11:06:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:49 INFO - Successfully installed psutil 11:06:49 INFO - Cleaning up... 11:06:49 INFO - Return code: 0 11:06:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0090>, '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 0x19a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', '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 11:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:06:49 INFO - Using env: {'DISPLAY': ':0', 11:06:49 INFO - 'HOME': '/home/cltbld', 11:06:49 INFO - 'LANG': 'en_US.UTF-8', 11:06:49 INFO - 'LANGUAGE': 'en_US:en', 11:06:49 INFO - 'LOGNAME': 'cltbld', 11:06:49 INFO - 'MAIL': '/var/mail/cltbld', 11:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:49 INFO - 'MOZ_NO_REMOTE': '1', 11:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:49 INFO - 'NO_EM_RESTART': '1', 11:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:49 INFO - 'PWD': '/builds/slave/test', 11:06:49 INFO - 'SHELL': '/bin/bash', 11:06:49 INFO - 'SHLVL': '1', 11:06:49 INFO - 'TERM': 'linux', 11:06:49 INFO - 'TMOUT': '86400', 11:06:49 INFO - 'USER': 'cltbld', 11:06:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', 11:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:49 INFO - '_': '/tools/buildbot/bin/python'} 11:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:06:50 INFO - Installing collected packages: mozsystemmonitor 11:06:50 INFO - Running setup.py install for mozsystemmonitor 11:06:50 INFO - Successfully installed mozsystemmonitor 11:06:50 INFO - Cleaning up... 11:06:50 INFO - Return code: 0 11:06:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06: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')]} 11:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06: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 0x16301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0090>, '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 0x19a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', '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 11:06: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 11:06: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 11:06:50 INFO - Using env: {'DISPLAY': ':0', 11:06:50 INFO - 'HOME': '/home/cltbld', 11:06:50 INFO - 'LANG': 'en_US.UTF-8', 11:06:50 INFO - 'LANGUAGE': 'en_US:en', 11:06:50 INFO - 'LOGNAME': 'cltbld', 11:06:50 INFO - 'MAIL': '/var/mail/cltbld', 11:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:50 INFO - 'MOZ_NO_REMOTE': '1', 11:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:50 INFO - 'NO_EM_RESTART': '1', 11:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:50 INFO - 'PWD': '/builds/slave/test', 11:06:50 INFO - 'SHELL': '/bin/bash', 11:06:50 INFO - 'SHLVL': '1', 11:06:50 INFO - 'TERM': 'linux', 11:06:50 INFO - 'TMOUT': '86400', 11:06:50 INFO - 'USER': 'cltbld', 11:06:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', 11:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:50 INFO - '_': '/tools/buildbot/bin/python'} 11:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:51 INFO - Downloading/unpacking jsonschema==2.5.1 11:06: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 11:06: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 11:06: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 11:06: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 11:06:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:06:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:06: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 11:06: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 11:06: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 11:06: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 11:06:52 INFO - Downloading functools32-3.2.3-2.tar.gz 11:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:06:52 INFO - warning: no files found matching '*.txt' 11:06:52 INFO - no previously-included directories found matching 'build' 11:06:52 INFO - no previously-included directories found matching 'dist' 11:06:52 INFO - no previously-included directories found matching '.git*' 11:06:52 INFO - Installing collected packages: jsonschema, functools32 11:06:52 INFO - Running setup.py install for functools32 11:06:52 INFO - warning: no files found matching '*.txt' 11:06:52 INFO - no previously-included directories found matching 'build' 11:06:52 INFO - no previously-included directories found matching 'dist' 11:06:52 INFO - no previously-included directories found matching '.git*' 11:06:52 INFO - Successfully installed jsonschema functools32 11:06:52 INFO - Cleaning up... 11:06:52 INFO - Return code: 0 11:06:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06: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')]} 11:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06: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 0x16301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0090>, '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 0x19a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', '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 11:06: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 11:06: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 11:06:52 INFO - Using env: {'DISPLAY': ':0', 11:06:52 INFO - 'HOME': '/home/cltbld', 11:06:52 INFO - 'LANG': 'en_US.UTF-8', 11:06:52 INFO - 'LANGUAGE': 'en_US:en', 11:06:52 INFO - 'LOGNAME': 'cltbld', 11:06:52 INFO - 'MAIL': '/var/mail/cltbld', 11:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:52 INFO - 'MOZ_NO_REMOTE': '1', 11:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:52 INFO - 'NO_EM_RESTART': '1', 11:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:52 INFO - 'PWD': '/builds/slave/test', 11:06:52 INFO - 'SHELL': '/bin/bash', 11:06:52 INFO - 'SHLVL': '1', 11:06:52 INFO - 'TERM': 'linux', 11:06:52 INFO - 'TMOUT': '86400', 11:06:52 INFO - 'USER': 'cltbld', 11:06:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', 11:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:52 INFO - '_': '/tools/buildbot/bin/python'} 11:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:06:52 INFO - Cleaning up... 11:06:52 INFO - Return code: 0 11:06:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06: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')]} 11:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0090>, '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 0x19a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', '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 11:06:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:06:52 INFO - Using env: {'DISPLAY': ':0', 11:06:52 INFO - 'HOME': '/home/cltbld', 11:06:52 INFO - 'LANG': 'en_US.UTF-8', 11:06:52 INFO - 'LANGUAGE': 'en_US:en', 11:06:52 INFO - 'LOGNAME': 'cltbld', 11:06:52 INFO - 'MAIL': '/var/mail/cltbld', 11:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:52 INFO - 'MOZ_NO_REMOTE': '1', 11:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:52 INFO - 'NO_EM_RESTART': '1', 11:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:52 INFO - 'PWD': '/builds/slave/test', 11:06:52 INFO - 'SHELL': '/bin/bash', 11:06:52 INFO - 'SHLVL': '1', 11:06:52 INFO - 'TERM': 'linux', 11:06:52 INFO - 'TMOUT': '86400', 11:06:52 INFO - 'USER': 'cltbld', 11:06:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', 11:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:52 INFO - '_': '/tools/buildbot/bin/python'} 11:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:53 INFO - Downloading/unpacking blobuploader==1.2.4 11:06: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 11:06: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 11:06: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 11:06: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 11:06:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:06:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:06: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 11:06: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 11:06: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 11:06: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 11:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:06:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:06: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 11:06: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 11:06: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 11:06: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 11:06:54 INFO - Downloading docopt-0.6.1.tar.gz 11:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:06:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:06:54 INFO - Running setup.py install for blobuploader 11:06:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:06:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:06:54 INFO - Running setup.py install for requests 11:06:55 INFO - Running setup.py install for docopt 11:06:55 INFO - Successfully installed blobuploader requests docopt 11:06:55 INFO - Cleaning up... 11:06:55 INFO - Return code: 0 11:06:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06: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')]} 11:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06: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 0x16301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0090>, '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 0x19a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', '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 11:06: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 11:06: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 11:06:55 INFO - Using env: {'DISPLAY': ':0', 11:06:55 INFO - 'HOME': '/home/cltbld', 11:06:55 INFO - 'LANG': 'en_US.UTF-8', 11:06:55 INFO - 'LANGUAGE': 'en_US:en', 11:06:55 INFO - 'LOGNAME': 'cltbld', 11:06:55 INFO - 'MAIL': '/var/mail/cltbld', 11:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:55 INFO - 'MOZ_NO_REMOTE': '1', 11:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:55 INFO - 'NO_EM_RESTART': '1', 11:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:55 INFO - 'PWD': '/builds/slave/test', 11:06:55 INFO - 'SHELL': '/bin/bash', 11:06:55 INFO - 'SHLVL': '1', 11:06:55 INFO - 'TERM': 'linux', 11:06:55 INFO - 'TMOUT': '86400', 11:06:55 INFO - 'USER': 'cltbld', 11:06:55 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', 11:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:55 INFO - '_': '/tools/buildbot/bin/python'} 11:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:55 INFO - Running setup.py (path:/tmp/pip-rW9bG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:55 INFO - Running setup.py (path:/tmp/pip-cN8BsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:55 INFO - Running setup.py (path:/tmp/pip-m2d6T4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:55 INFO - Running setup.py (path:/tmp/pip-hmk9Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:55 INFO - Running setup.py (path:/tmp/pip-jXe9VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:55 INFO - Running setup.py (path:/tmp/pip-KkNohp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:55 INFO - Running setup.py (path:/tmp/pip-AKJC6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:56 INFO - Running setup.py (path:/tmp/pip-ymEXK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:56 INFO - Running setup.py (path:/tmp/pip-Q4_tmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:56 INFO - Running setup.py (path:/tmp/pip-hR80Nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:56 INFO - Running setup.py (path:/tmp/pip-FXnMCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:56 INFO - Running setup.py (path:/tmp/pip-eZ_3yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:56 INFO - Running setup.py (path:/tmp/pip-ebGY0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:56 INFO - Running setup.py (path:/tmp/pip-uZrerC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:56 INFO - Running setup.py (path:/tmp/pip-kR_MPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:56 INFO - Running setup.py (path:/tmp/pip-1hZtWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:56 INFO - Running setup.py (path:/tmp/pip-oDslyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:06:56 INFO - Running setup.py install for manifestparser 11:06:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:06:56 INFO - Running setup.py install for mozcrash 11:06:56 INFO - Running setup.py install for mozdebug 11:06:57 INFO - Running setup.py install for mozdevice 11:06:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Running setup.py install for mozfile 11:06:57 INFO - Running setup.py install for mozhttpd 11:06:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Running setup.py install for mozinfo 11:06:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Running setup.py install for mozInstall 11:06:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Running setup.py install for mozleak 11:06:57 INFO - Running setup.py install for mozlog 11:06:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Running setup.py install for moznetwork 11:06:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Running setup.py install for mozprocess 11:06:57 INFO - Running setup.py install for mozprofile 11:06:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:06:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:06:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:06:58 INFO - Running setup.py install for mozrunner 11:06:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:06:58 INFO - Running setup.py install for mozscreenshot 11:06:58 INFO - Running setup.py install for moztest 11:06:58 INFO - Running setup.py install for mozversion 11:06:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:06:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:06:58 INFO - Cleaning up... 11:06:58 INFO - Return code: 0 11:06:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:58 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')]} 11:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:58 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')]} 11:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:58 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 0x16301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0090>, '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 0x19a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', '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 11:06:58 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 11:06:58 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 11:06:58 INFO - Using env: {'DISPLAY': ':0', 11:06:58 INFO - 'HOME': '/home/cltbld', 11:06:58 INFO - 'LANG': 'en_US.UTF-8', 11:06:58 INFO - 'LANGUAGE': 'en_US:en', 11:06:58 INFO - 'LOGNAME': 'cltbld', 11:06:58 INFO - 'MAIL': '/var/mail/cltbld', 11:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:58 INFO - 'MOZ_NO_REMOTE': '1', 11:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:58 INFO - 'NO_EM_RESTART': '1', 11:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:58 INFO - 'PWD': '/builds/slave/test', 11:06:58 INFO - 'SHELL': '/bin/bash', 11:06:58 INFO - 'SHLVL': '1', 11:06:58 INFO - 'TERM': 'linux', 11:06:58 INFO - 'TMOUT': '86400', 11:06:58 INFO - 'USER': 'cltbld', 11:06:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', 11:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:58 INFO - '_': '/tools/buildbot/bin/python'} 11:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:58 INFO - Running setup.py (path:/tmp/pip-_d40pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:58 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)) 11:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:58 INFO - Running setup.py (path:/tmp/pip-ORzF57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:58 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)) 11:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:58 INFO - Running setup.py (path:/tmp/pip-gOivpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:58 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)) 11:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:58 INFO - Running setup.py (path:/tmp/pip-DzTUs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:58 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)) 11:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:58 INFO - Running setup.py (path:/tmp/pip-azpuDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06: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)) 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:59 INFO - Running setup.py (path:/tmp/pip-ittDjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06: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)) 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:59 INFO - Running setup.py (path:/tmp/pip-zbIvhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06: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)) 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:59 INFO - Running setup.py (path:/tmp/pip-Cg0seo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06: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)) 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:59 INFO - Running setup.py (path:/tmp/pip-fmtCK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06: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)) 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:59 INFO - Running setup.py (path:/tmp/pip-vwyiLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:59 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)) 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:59 INFO - Running setup.py (path:/tmp/pip-PM24mJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:59 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)) 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:59 INFO - Running setup.py (path:/tmp/pip-NaMkPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:59 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)) 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:59 INFO - Running setup.py (path:/tmp/pip-kUJ2uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:59 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)) 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:59 INFO - Running setup.py (path:/tmp/pip-rw3VZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:59 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)) 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:59 INFO - Running setup.py (path:/tmp/pip-IBpuX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:59 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)) 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:59 INFO - Running setup.py (path:/tmp/pip-IOUwj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:59 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)) 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:59 INFO - Running setup.py (path:/tmp/pip-ncjthK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:59 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)) 11:06:59 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)) 11:06:59 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)) 11:06:59 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)) 11:06:59 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)) 11:06:59 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)) 11:06:59 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)) 11:06:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:00 INFO - Downloading blessings-1.6.tar.gz 11:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:01 INFO - Installing collected packages: blessings 11:07:01 INFO - Running setup.py install for blessings 11:07:01 INFO - Successfully installed blessings 11:07:01 INFO - Cleaning up... 11:07:01 INFO - Return code: 0 11:07:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:01 INFO - Reading from file tmpfile_stdout 11:07:01 INFO - Current package versions: 11:07:01 INFO - argparse == 1.2.1 11:07:01 INFO - blessings == 1.6 11:07:01 INFO - blobuploader == 1.2.4 11:07:01 INFO - docopt == 0.6.1 11:07:01 INFO - functools32 == 3.2.3-2 11:07:01 INFO - jsonschema == 2.5.1 11:07:01 INFO - manifestparser == 1.1 11:07:01 INFO - mozInstall == 1.13 11:07:01 INFO - mozcrash == 1.0 11:07:01 INFO - mozdebug == 0.1 11:07:01 INFO - mozdevice == 0.51 11:07:01 INFO - mozfile == 1.2 11:07:01 INFO - mozhttpd == 0.7 11:07:01 INFO - mozinfo == 0.10 11:07:01 INFO - mozleak == 0.1 11:07:01 INFO - mozlog == 3.5 11:07:01 INFO - moznetwork == 0.27 11:07:01 INFO - mozprocess == 0.25 11:07:01 INFO - mozprofile == 0.28 11:07:01 INFO - mozrunner == 6.13 11:07:01 INFO - mozscreenshot == 0.1 11:07:01 INFO - mozsystemmonitor == 0.3 11:07:01 INFO - moztest == 0.8 11:07:01 INFO - mozversion == 1.4 11:07:01 INFO - psutil == 3.1.1 11:07:01 INFO - requests == 1.2.3 11:07:01 INFO - wsgiref == 0.1.2 11:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:01 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')]} 11:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:01 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')]} 11:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:01 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 0x16301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0090>, '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 0x19a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', '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 11:07:01 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 11:07:01 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 11:07:01 INFO - Using env: {'DISPLAY': ':0', 11:07:01 INFO - 'HOME': '/home/cltbld', 11:07:01 INFO - 'LANG': 'en_US.UTF-8', 11:07:01 INFO - 'LANGUAGE': 'en_US:en', 11:07:01 INFO - 'LOGNAME': 'cltbld', 11:07:01 INFO - 'MAIL': '/var/mail/cltbld', 11:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:01 INFO - 'MOZ_NO_REMOTE': '1', 11:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:01 INFO - 'NO_EM_RESTART': '1', 11:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:01 INFO - 'PWD': '/builds/slave/test', 11:07:01 INFO - 'SHELL': '/bin/bash', 11:07:01 INFO - 'SHLVL': '1', 11:07:01 INFO - 'TERM': 'linux', 11:07:01 INFO - 'TMOUT': '86400', 11:07:01 INFO - 'USER': 'cltbld', 11:07:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', 11:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:01 INFO - '_': '/tools/buildbot/bin/python'} 11:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:01 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)) 11:07:01 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)) 11:07:01 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)) 11:07:01 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)) 11:07:01 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)) 11:07:01 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)) 11:07:01 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)) 11:07:01 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)) 11:07:01 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)) 11:07:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:07:02 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)) 11:07:02 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)) 11:07:02 INFO - Installing collected packages: simplejson 11:07:02 INFO - Running setup.py install for simplejson 11:07:02 INFO - building 'simplejson._speedups' extension 11:07:02 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 11:07:03 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 11:07:03 INFO - Successfully installed simplejson 11:07:03 INFO - Cleaning up... 11:07:03 INFO - Return code: 0 11:07:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:03 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 0x16301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0090>, '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 0x19a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', '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 11:07:03 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 11:07:03 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 11:07:03 INFO - Using env: {'DISPLAY': ':0', 11:07:03 INFO - 'HOME': '/home/cltbld', 11:07:03 INFO - 'LANG': 'en_US.UTF-8', 11:07:03 INFO - 'LANGUAGE': 'en_US:en', 11:07:03 INFO - 'LOGNAME': 'cltbld', 11:07:03 INFO - 'MAIL': '/var/mail/cltbld', 11:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:03 INFO - 'MOZ_NO_REMOTE': '1', 11:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:03 INFO - 'NO_EM_RESTART': '1', 11:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:03 INFO - 'PWD': '/builds/slave/test', 11:07:03 INFO - 'SHELL': '/bin/bash', 11:07:03 INFO - 'SHLVL': '1', 11:07:03 INFO - 'TERM': 'linux', 11:07:03 INFO - 'TMOUT': '86400', 11:07:03 INFO - 'USER': 'cltbld', 11:07:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', 11:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:03 INFO - '_': '/tools/buildbot/bin/python'} 11:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:07:04 INFO - Cleaning up... 11:07:04 INFO - Return code: 0 11:07:04 INFO - Running post-action listener: _resource_record_post_action 11:07:04 INFO - Running post-action listener: _start_resource_monitoring 11:07:04 INFO - Starting resource monitoring. 11:07:04 INFO - [mozharness: 2017-09-10 18:07:04.157564Z] Finished create-virtualenv step (success) 11:07:04 INFO - [mozharness: 2017-09-10 18:07:04.158586Z] Running install step. 11:07:04 INFO - Running pre-action listener: _resource_record_pre_action 11:07:04 INFO - Running main action method: install 11:07:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:04 INFO - Reading from file tmpfile_stdout 11:07:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:04 INFO - Reading from file tmpfile_stdout 11:07:04 INFO - Output received: 11:07:04 INFO - Usage: mozinstall [options] installer 11:07:04 INFO - Options: 11:07:04 INFO - -h, --help show this help message and exit 11:07:04 INFO - -d DEST, --destination=DEST 11:07:04 INFO - Directory to install application into. [default: 11:07:04 INFO - "/builds/slave/test"] 11:07:04 INFO - --app=APP Application being installed. [default: firefox] 11:07:04 INFO - mkdir: /builds/slave/test/build/application 11:07:04 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'] 11:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:07:21 INFO - Reading from file tmpfile_stdout 11:07:21 INFO - Output received: 11:07:21 INFO - /builds/slave/test/build/application/firefox/firefox 11:07:21 INFO - Running post-action listener: _resource_record_post_action 11:07:21 INFO - [mozharness: 2017-09-10 18:07:21.055445Z] Finished install step (success) 11:07:21 INFO - [mozharness: 2017-09-10 18:07:21.055695Z] Running setup-mitmproxy step. 11:07:21 INFO - Running pre-action listener: _resource_record_pre_action 11:07:21 INFO - Running main action method: setup_mitmproxy 11:07:21 INFO - Skipping: mitmproxy is not required 11:07:21 INFO - Running post-action listener: _resource_record_post_action 11:07:21 INFO - [mozharness: 2017-09-10 18:07:21.056823Z] Finished setup-mitmproxy step (success) 11:07:21 INFO - [mozharness: 2017-09-10 18:07:21.057043Z] Running run-tests step. 11:07:21 INFO - Running pre-action listener: _resource_record_pre_action 11:07:21 INFO - Running pre-action listener: _set_gcov_prefix 11:07:21 INFO - Running main action method: run_tests 11:07:21 WARNING - Try message not found. 11:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:07:21 INFO - Python 2.7.3 11:07:21 INFO - Return code: 0 11:07:21 INFO - grabbing minidump binary from tooltool 11:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0090>, '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 0x19a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:07:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:07:21 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:07:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:07:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:07:21 INFO - Return code: 0 11:07:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:07:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:07:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:07:21 INFO - ENV: RUST_BACKTRACE is now full 11:07:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:07:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 11:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 11:07:21 INFO - Using env: {'DISPLAY': ':0', 11:07:21 INFO - 'HOME': '/home/cltbld', 11:07:21 INFO - 'LANG': 'en_US.UTF-8', 11:07:21 INFO - 'LANGUAGE': 'en_US:en', 11:07:21 INFO - 'LOGNAME': 'cltbld', 11:07:21 INFO - 'MAIL': '/var/mail/cltbld', 11:07:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:07:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:07:21 INFO - 'MOZ_ACCELERATED': '1', 11:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:21 INFO - 'MOZ_NO_REMOTE': '1', 11:07:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:07:21 INFO - 'MOZ_WEBRENDER': '1', 11:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:21 INFO - 'NO_EM_RESTART': '1', 11:07:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:21 INFO - 'PWD': '/builds/slave/test', 11:07:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:07:21 INFO - 'RUST_BACKTRACE': 'full', 11:07:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:07:21 INFO - 'SHELL': '/bin/bash', 11:07:21 INFO - 'SHLVL': '1', 11:07:21 INFO - 'TERM': 'linux', 11:07:21 INFO - 'TMOUT': '86400', 11:07:21 INFO - 'USER': 'cltbld', 11:07:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', 11:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:21 INFO - '_': '/tools/buildbot/bin/python'} 11:07:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 11:07:21 INFO - mozversion application_buildid: 20170910171456 11:07:21 INFO - mozversion application_changeset: fd87bb184e299fec695f69bd2977276c25719b98 11:07:21 INFO - mozversion application_display_name: Nightly 11:07:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:07:21 INFO - mozversion application_name: Firefox 11:07:21 INFO - mozversion application_remotingname: firefox 11:07:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:07:21 INFO - mozversion application_vendor: Mozilla 11:07:21 INFO - mozversion application_version: 57.0a1 11:07:21 INFO - mozversion platform_buildid: 20170910171456 11:07:21 INFO - mozversion platform_changeset: fd87bb184e299fec695f69bd2977276c25719b98 11:07:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:07:21 INFO - mozversion platform_version: 57.0a1 11:07:21 INFO - using testdate: 1505066841 11:07:21 INFO - actual date: 1505066841 11:07:21 INFO - starting webserver on 'localhost:39350' 11:07:21 INFO - SUITE-START | Running 2 tests 11:07:21 INFO - TEST-START | dromaeo_css 11:07:21 INFO - Initialising browser for dromaeo_css test... 11:07:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39350/getInfo.html -profile /tmp/tmp0MduCX/profile 11:07:21 INFO - TEST-INFO | started process 3571 (/builds/slave/test/build/application/firefox/firefox http://localhost:39350/getInfo.html) 11:07:31 INFO - TEST-INFO | 3571: exit 0 11:07:31 INFO - Browser initialized. 11:07:31 INFO - Running cycle 1/1 for dromaeo_css test... 11:07:31 INFO - Using env: {'DISPLAY': ':0', 11:07:31 INFO - 'HOME': '/home/cltbld', 11:07:31 INFO - 'JSGC_DISABLE_POISONING': '1', 11:07:31 INFO - 'LANG': 'en_US.UTF-8', 11:07:31 INFO - 'LANGUAGE': 'en_US:en', 11:07:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:07:31 INFO - 'LOGNAME': 'cltbld', 11:07:31 INFO - 'MAIL': '/var/mail/cltbld', 11:07:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:07:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:07:31 INFO - 'MOZ_ACCELERATED': '1', 11:07:31 INFO - 'MOZ_CRASHREPORTER': '1', 11:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:07:31 INFO - 'MOZ_NO_REMOTE': '1', 11:07:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:07:31 INFO - 'MOZ_WEBRENDER': '1', 11:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:31 INFO - 'NO_EM_RESTART': '1', 11:07:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:31 INFO - 'PWD': '/builds/slave/test', 11:07:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:07:31 INFO - 'RUST_BACKTRACE': 'full', 11:07:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:07:31 INFO - 'SHELL': '/bin/bash', 11:07:31 INFO - 'SHLVL': '1', 11:07:31 INFO - 'TERM': 'linux', 11:07:31 INFO - 'TMOUT': '86400', 11:07:31 INFO - 'USER': 'cltbld', 11:07:31 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', 11:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:31 INFO - '_': '/tools/buildbot/bin/python'} 11:07:31 INFO - TEST-INFO | started process 3786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0MduCX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:07:32 INFO - PID 3786 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:07:32 INFO - PID 3786 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:07:32 INFO - PID 3786 | 11:07:32 INFO - PID 3786 | (/builds/slave/test/build/application/firefox/firefox:3846): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:07:32 INFO - PID 3786 | 11:07:43 INFO - PID 3786 | RSS: Main: 206008320 11:07:43 INFO - PID 3786 | 11:10:40 INFO - PID 3786 | Cycle 1(1): loaded http://localhost:39350/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39350/tests/dromaeo/cssquery-ext.html) 11:10:42 INFO - PID 3786 | RSS: Main: 219844608 11:10:42 INFO - PID 3786 | 11:13:44 INFO - PID 3786 | Cycle 1(1): loaded http://localhost:39350/tests/dromaeo/cssquery-ext.html (next: http://localhost:39350/tests/dromaeo/cssquery-jquery.html) 11:13:45 INFO - PID 3786 | RSS: Main: 218046464 11:13:45 INFO - PID 3786 | 11:16:47 INFO - PID 3786 | Cycle 1(1): loaded http://localhost:39350/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39350/tests/dromaeo/cssquery-mootools.html) 11:16:47 INFO - PID 3786 | RSS: Main: 221552640 11:16:47 INFO - PID 3786 | 11:19:49 INFO - PID 3786 | Cycle 1(1): loaded http://localhost:39350/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39350/tests/dromaeo/cssquery-prototype.html) 11:19:50 INFO - PID 3786 | RSS: Main: 216141824 11:19:50 INFO - PID 3786 | 11:22:54 INFO - PID 3786 | Cycle 1(1): loaded http://localhost:39350/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39350/tests/dromaeo/cssquery-yui.html) 11:22:54 INFO - PID 3786 | RSS: Main: 220332032 11:22:54 INFO - PID 3786 | 11:25:56 INFO - PID 3786 | Cycle 1(1): loaded http://localhost:39350/tests/dromaeo/cssquery-yui.html (next: http://localhost:39350/tests/dromaeo/cssquery-dojo.html) 11:25:56 INFO - PID 3786 | RSS: Main: 217468928 11:25:56 INFO - PID 3786 | 11:25:56 INFO - PID 3786 | __start_tp_report 11:25:56 INFO - PID 3786 | _x_x_mozilla_page_load 11:25:56 INFO - PID 3786 | _x_x_mozilla_page_load_details 11:25:56 INFO - PID 3786 | |i|pagename|runs| 11:25:56 INFO - PID 3786 | |0;dojo.html;3089.5829063076485;3113.9065828025155;3129.687031296869;3129.718325350718;3169.3661267746456;6003.429674180946;6158.784442544512;6166.3525329840395;6207.193064901562;6265.718042688079;6093.146959425684;6100.298465676448;6111.02223644217;6226.657533835637;6354.459870910967;5774.4802967733;5796.739146738407;5801.448862358069;5835.562332825034;5864.73608687608;5719.6854173020465;5720.11338242573;5738.684372359518;5775.162601422791;5782.9421705782825;5705.914411283834;5738.770449182028;5782.653040817564;5804.2744656917885;5826.82519524415;5476.698781567012;5565.276514053147;5583.832485025415;5634.295713035871;5641.717914104278;5608.046632072557;5622.465865742748;5649.49154576086;5653.010723123437;5660.915086273709;6095.664738439384;6104.908426373608;6127.142200091991;6178.660173690445;6180.165677633507;6666.433353164987;6729.394354508117;6772.390484856337;6801.829954251134;6804.21751498579;6773.153355830521;6784.76253331131;6837.863242735118;6845.863082738367;6875.931240687579;6024.608400453956;6093.725782339805;6164.568480206387;6168.629882207082;6254.562180647356;6842.247352791189;6845.281245469254;6940.201876784134;6945.861082778316;6945.861082778316;6630.734770609218;6648.135742353463;6664.600123992576;6669.933300667029;6677.599344039373;6677.799666010027;6689.9965005249605;6705.832354191087;6756.560823546453;6804.55770374924;6432.131662225634;6623.536352455282;6671.966640166866;6707.463402927851;6722.394984451325;6570.178727659043;6590.901136482957;6721.899171512431;6730.889403248507;6732.427743641747;5210.21846722987;5214.8527323988665;5284.524392804666;5296.549793267538;5298.311219541512;4526.909461810811;4585.358049873021;4594.517575654508;4599.770011499411;4640.23436133041;5711.657300561979;5740.052891272893;5743.282089738783;5773.682447465346;5807.535397168216;6387.520935929824;6415.358464153641;6631.137952066297;6747.122874026345;6810.455163586901;5706.3722990471015;5727.799527016535;5744.454276843777;5765.711714414262;5771.365149833515;5752.712364381764;5771.422857714279;5780.913286300709;5785.652860828363;5789.478946894799;6317.684115794192;6376.7130479128555;6407.750488654668;6415.422611964852;6482.773102941469;6478.125453063776;6641.933580664131;6644.966775166094;6677.699503522256;6732.966335168293;6329.841753956188;6406.327335629878;6469.288378278292;6512.479001679949;6515.641639709862;6576.76981305652;6587.538872278895;6648.867022659617;6656;6666.366695163952;6658;6661.866762664817;6687.164104486939;6748.561343512656;6758.290379510081;6342.365763423805;6400.359964003563;6412.23053233615;6499.610023398611;6522.34776522344;6496.935030649822;6515.315891831479;6518.967405162944;6527.412532871875;6530.118434011348;6395.42441180296;6435.485161187187;6458.321876202931;6488.091667166506;6500.089987401673;6498.480121590356;6508.479321654351;6588.439982601532;6595.142631458071;6622.205335359788;6076.756929722938;6206.906896396648;6267.9373206267355;6384.978403455425;6417.1657684500715 11:25:56 INFO - PID 3786 | |1;ext.html;767.7044337929897;789.6249281591241;792.2117493094372;795.2604078207269;797.0554892452444;38567;41756.79121604395;41988.37017444737;42022.36966445506;42217.15565688692;38511.22977540448;38689.41965870507;38924.80537597308;38945.22109557807;38987;6925.307469253072;7024.894626580605;7045.084139061941;7047.436205103605;7063;6939.132608423947;6943.930560694404;7025.8594828103405;7031.015657807885;7033.402160816337;6970.059042029337;6994.545354551963;7004.089468369105;7017.578945263275;7025.192102908154;7210.315020073111;7880.408969327266;7887.96056019722;7898.921010789876;7946.086200086977;7672.808179795494;7812.882806757903;7813.218678132198;7815.179406162328;7818.45270831042;37885.621143788485;38059.23881522354;38536.80731596324;38556;38633;3541.1678255609913;3572.2319701264355;3574.928501429983;3575.410057340536;3576.213233088716;31950.360992780246;32208.03375898727;32472.18819529507;32482;32496;5157.381114266274;5182.015417070782;5217.765200565984;5221.686698798047;5267.394249661262;177858;177882;178380;179615;180808.9999999987;39338;40150.79924600358;46536;46642.5335746645;47023;49835.75082124566;50170.749146254035;50187;50278;50538.241926371134;14959.40162393492;15118.622034449227;15119.697606047817;15152.31814568347;15159.469418570297;12150;12195.695107622381;12232.755344893052;12234.143609947218;12402.06984476168;13633.795493067611;13748.862511374959;13783.104098233583;13787.793183102262;13991.16053036821;5523.392426833045;5569.303837020372;5631.183478395692;5703.08750599902;5719.399463056319;1006.3710181136789;1026.097034609539;1026.5483187397522;1037.3153718545723;1045.5399624165343;22332.441688957904;22843.771562284495;22881.542369152525;22884.199053033062;23533.411664708176;1108.9279196852178;1111.1943840715417;1128.1877048525048;1137.9772404551863;1139.1797905508022;12436.067294952914;12451.315177665134;12495.062870284764;12505.74988500225;12526.248425094524;213470;215130;215163;216735;217802;51331;51690.74154629278;51742.741286294084;51786;51845.222321665206;1418.9645258868404;1474.277603974045;1476.963075923089;1479.2012313350886;1482.7182835261267;21892.89053554722;22055.558888822456;22154.22460213885;22448;22641.094356225567;36501.26997460089;36697.63302367049;36709.26581468302;36945.26109477849;36952.07619809526;135270;136084.31957840148;136421;136569;136903;29394.706052939197;29867;32948.341033179684;33478.4978225322;33574.49638255379;42439;42716.14567708566;42797.786011069744;43152.784236078616;43158;31142.22144446407;31724.841375792974;31757.364852702354;31767.364652706354;32336.83831580827;31159;31251.218719532193;31814.681853181173;31848.52227216547;31888.521672174473;33872.830635846665;34618.65381346154;34747;34767.82616086904;34933.58435310118;30172.849135754182;30670.539941900442;30986.690133098382;30996.845015774776;31629.051128466184;23007.53984920326;23220.651690224324;23258.418539536648;23299;23659.580425174543 11:25:56 INFO - PID 3786 | |2;jquery.html;548.9423610520895;567.2229046206697;570.3953808962502;573.7463641942355;593.0629605223747;21718.457038574044;22375.328740137782;22419.887900560516;22568.887155564218;22635.094596216153;22767.31698049057;23832;24100;24201.515969680597;24278.635820462707;6568;6708.664566771667;6736.191657001143;6738.056672065914;6740.764073257437;6570.540062195648;6739.326067393246;6739.8652026959435;6755;6767.661616919159;6286.968565157191;6582.308857569958;6584.93415065848;6592.604443733368;6692.498062645297;6570.342965703416;6604.702788374535;6624.53628246023;6641.634710090967;6667.666616669196;5870.823875283749;6104.633721976696;6113.113598528233;6136.6011209271255;6160.414760597736;27754;28338.57492137599;28372.43255134886;28397.14808555726;28441.288967775763;2010.7184994100837;2031.2687432524278;2033.9491512712152;2034.4608678700156;2039.4697378681649;18451.35420260298;18931.716024259647;19168.61662766737;19191;19226.423207303804;2393.904243830245;2432.2338463384153;2467.740887206853;2468.358226861029;2471.1351027140536;112426.99999999919;117174;117888;123809;124870.37564812209;20265.58140930121;20646.277380291616;20940.685889711665;20952.580948380946;21016.474588135417;39814.80092599519;39985.600143998185;40045.79977100154;40325.39511907324;40402.79798600988;10442.791144177074;10568.947155264328;10575.259731818853;10596.152307815357;10775.299605525615;8728.476291422536;8767.649294028168;8815.603297851612;8840.602172902234;8907.064758200426;10613.20400969915;10678.94660526708;10849.96925292096;10901.890981090088;10960.725981850359;4112.642827866796;4148.087420767426;4218.641415479658;4224;4256.9574304257185;963.325672029582;974.8732664753537;988.7429268390271;989.8465737810651;990;18522.351717689817;18553.35063272779;18825.246990120242;18962.336318228794;19008.904955475133;1028.4395004722444;1035.2132379391567;1047.61238341814;1053.1837825685002;1057.1965306367063;10296.588136474456;10421.166306695446;10500;10622.946885265525;10629.096526795154;418380;424244;424342;426130;430566;106615;109608.4519577413;110194.44902775435;110398.44800775945;111199;1172.7244097636878;1178.8113901775675;1193.8746431624727;1206.7164216409137;1208.099965525689;16852.662946741242;16863.831361686225;16880.280074606828;16909.15454227308;17073.658526829146;53578.732106339216;54324;55136;55547.44452555423;55560;64314.67842660757;64672;65055.34944650493;65453.67273163794;65667.01499477607;18393.724094138866;19349.8065019348;19477.123529440927;19572.8042719571;19644.312449064215;21528.892355538123;21879.05010667363;21926.23258185956;21965.67051494261;22109.33671989843;17549.473515794547;17584.824151758832;17803.198856051768;17926.372576959744;18100;15477.613059673598;15488.5353439397;15957.521274361789;16038.117903515418;16268.51194464168;17168.828311716723;17355.392561260294;17431.738523921897;17520.299188032335;18108.547286317946;18666.440006799818;19011;19160.329388471895;19208.903955480135;19508.414747557596;17307.740383894;17362.045087519804;17607.20767565437;17623.383181588582;17707.46877593674 11:25:56 INFO - PID 3786 | |3;mootools.html;1310.3317308172832;1356.071091302458;1378.7035787305726;1382.4815694114707;1388.5903658420764;14875.256237188138;15527.534173974771;15529.456469023586;15529.611759706013;15536.300866461008;15217.54347369578;15221.771673424908;15299.84700152998;15336.46322378717;15348.923255383736;2648.920532384022;2756.5865120231924;2770.459760346733;2784.4431113777223;2795.6784969728537;2700.297922540144;2737.534619114755;2740.821846579966;2755.641766570353;2776.0422654184276;2593.15722390223;2691.434798692277;2775.264554892955;2782.0262907982246;2782.8052036357462;2697.379602691392;2715.7691596214345;2722.823016503941;2745.135282386052;2745.4509098180342;2555.961660575093;2629.2638061342855;2641.867906604662;2654.429297700984;2670.7062223155435;14649.487267945571;14682.779758303634;14751.18868462234;14873.70252594942;14948.476803311833;7525.322720955086;7807.414443916672;7823.2567906048835;7843.686252549891;7856.607169641552;4958.528939750718;5125.769340379655;5131.2559678846355;5182.766775495112;5185.585153187736;1922.5193701574606;1923.2786655942853;1980.7127966444784;1984.925752588534;2031.725717028197;26013.479730405284;26279.60580591293;26293.868530657226;26394.73605263942;26509;6303.180586523723;6408.903866442007;6543.280239173687;6579.046038324416;6585.2426970898005;16788.83211167897;16902.83097169037;17002.914985424995;17011.829881701273;17028.57428564271;7499.550026998398;7718.035245594301;7722.266384693445;7779.805504862311;7793.06483222017;7134.785956421316;7142.142942846892;7144.178419481722;7164.391026762679;7187.9640601796655;4758.119747846659;4874.268859671078;4923.286123512071;4954.950450495449;4970.552650261494;1168.1705988747915;1178.1635039122318;1190.6309044196328;1194.52219112354;1198.5505435461703;835.0980940584154;861.6854847980442;867.1631875240423;875.8642410426394;881.7707396076938;7175.067241258707;7280.854382912418;7293.489455738048;7293.671784769698;7307.525010874276;670.6613160354087;670.6881300195334;677.7458453080095;679.7756740275697;683.3508167241141;4237.8304867805555;4831.855044348676;4906.558409743069;4925.630577706686;4941.975290123526;20854.37436876866;21075.15699372008;21427;21556.56886862254;21607.135714571243;21421.67867481989;21441.48181342918;21590.568188636138;21806.127754889945;22022.559548808935;10008.64969726056;10141.999999999853;10184.338018028804;10208.132308753839;10253.128484078788;8212.589370531568;8298.941548104438;8377.287930525974;8408.369372297224;8496;18296.451106466826;18648.813511864708;18925;19032.238710451427;19236;18947.90526047361;19222.61554768925;19274.903625481784;19343;19432.611347773247;9869.605215791575;10187.796244074929;10238.846417303896;10308.226882983656;10385.324953877975;13730.65673358174;13989.230592317113;13999.930000350341;14017.158970461396;14031.789523156956;10609.787804244026;10812.56749730002;10813.189010824062;11028.393438360967;11059.557617695202;10211.285210035227;10246.077852992968;10252.179825614083;10375.584976600852;10718.464076795974;8770.07914169003;8932.821343572961;9041.90958090437;9046.592903319235;9126.133017363605;6452.903206452001;6624.768133115318;6659.101021362248;6685.431738302299;6784.05023296729;6598.8350291243105;6730.899036514554;6730.93269067303;6731.32686731323;6773.254941956479 11:25:56 INFO - PID 3786 | |4;prototype.html;501.058813837752;503.2803091579043;513.9845804625861;521.7182721330481;528.8995090932723;6142.262928448581;6147.200863887694;6151.477124444422;6262.937370626292;6316.399942005508;6045;6111.411033131384;6150.323464418911;6180.783672571461;6201.162843016192;5086.465921078289;5108.361454818148;5128.769205385748;5130.9230361544605;5143.845684629448;5057.317262169615;5120.283160357553;5144.331236939192;5161.329027226455;5197.402298735656;4726.90546189076;4824.1316563018645;4836.2987366831785;4849.733264670442;4973.5772459340815;4875.9756201219125;4893.7063776173545;4897.926531102018;4897.99591083827;4927.1870141426625;4313.460817397825;4352.89117772055;4378.868633940987;4381.233284175289;4382.123575284924;5797.420257974211;5915.3788852170765;5976.73104710289;5990.400959904018;6034.9396506035255;5608.523275521586;5624.55003599711;5651.124075768263;5657.2928383952;5718.914216286759;6421.614703117782;6426.389492998158;6474.345518337459;6560.147180866456;6578.572392794453;4574.656900732459;4810.278458231258;4832.8791780205775;4889.608831293488;4890.535399137077;6689.866202675919;6779;6789.490788190856;6874.725010999554;6893.655317234118;4946.455889852114;4958.727270000185;4976.154053810861;4987.725675087832;5001.124803159432;4931.457539670633;4934.1611925972675;4962.627802914723;4995.700257984533;5013.1227035268685;5634.478450968145;5638.43615638441;5643.915341269802;5652.604317697722;5696.8860622787315;6582.736690532325;6636.469082473391;6652.467802575782;6659.833504162338;6665;1725.8187890271593;1732.9826701733073;1756.6135450200936;1757.1477833250863;1770.2122555462695;1139.9658010259539;1188.6968822950093;1204.8914998201676;1214.6598952293373;1215.4166000319897;5568.610197286151;5615.354234263112;5615.943840561624;5676.801311954062;5692.459216374438;6471.9029214561815;6494.940662086196;6643.169603799525;6649.63427011519;6691.933080669229;5553;5582.525485333711;5588.552915766729;5622.269105016404;5642.210090587321;3451.4114414189357;3521.2429327694667;3538.1862171700654;3574.1779390739757;3582.7723286522155;6245.656488893154;6303.856688725764;6408.903866442007;6411.358864113645;6448.3229260927865;6779.2881747416795;6790.7283708652085;6791.558548694319;6798.694058767367;6833.760818371433;6298.874022519615;6317.96841015792;6342.778002769881;6400.359964003563;6454.9677251614385;6041.577089603861;6465.612063276219;6485.86497362969;6592.538522303585;6621.602703837785;6487.740490380332;6561.540692151503;6631.933680663132;6662.800115996528;6663.83340416474;6263.404976527223;6274.529410294155;6292.874142517033;6326.557141000086;6465.579737317059;4797.976010120066;4907.509249075064;4934.632849927768;4955.950440495693;4976.2286845539;6451.741850378728;6454.612723236621;6625.635590042594;6671.733130674718;6688.3646053624825;6241.469475094486;6306.747730090745;6384.265809431789;6454.322296159024;6483.967580162069;6251.187345645037;6399.872002560016;6437.388448097423;6451.3548645135115;6503.25212600557;6336.398042185985;6382.585131966407;6388.648624325707;6447.6453795041725;6456.709448074754;6534.967325163344;6548.770793022221;6564.376384243489;6580.341965803382;6582.440492558187;6224.439800417984;6305.211848518935;6329.620222786648;6347.111404403479;6360.554761166674 11:25:56 INFO - PID 3786 | |5;yui.html;835.4110352201699;874.9693760718374;883.8585826267798;889.7820034091649;891.3270480787005;18028.09859507024;18183.18175682094;18442.354517591888;18508.629827403445;18561.350352737656;16058.357665693358;16869.156542172874;17033.659326813457;17044.82955170451;17063.57341066474;975.1272611013156;994.2990191914682;996.7557948302676;998.7852611688486;1000.0399616368295;938.2400255792795;989.9554520046579;992.1517102877044;992.7468495533665;993.4883534979491;1037.818381783185;1047.5757318286069;1050.2648146297622;1051.526812934179;1056.1972900595526;1044.9529771160278;1054.219877290807;1054.4464156317918;1054.4991129213602;1056.144522936424;719.5718547464251;738.0258059361645;740.2486476226634;743.9070116235471;767.7619937819294;19337.323193688153;19646.607067858564;19705;19866;19897.104630291673;19332.4200273992;19635;20008.199672013103;20240.291589794288;20339.288124915704;16663;16698.248578813982;16752.916235418867;16787.832121678748;16799.2440340185;3517.138301116243;3538.115471132217;3542.982285088584;3552.662497062775;3557.2351944332095;137610.31194843963;139409;139933.30033349767;143075;144165;15349.309281082378;15443.459478918408;15607.531774046796;15767.369305227663;15822.446214382442;25179.49641007206;26234.08180713666;26249.212523624323;26287.60568591473;26314.473710525683;7472.850542989218;7537.4723769336715;7562.243775622504;7625.733099341496;7627.237276272328;3700.962990370062;3714.665680088805;3739.962600374016;3744.457053727249;3756.492873462102;5215.556677682363;5232.947670523322;5310.619238997889;5322.680639161663;5378.031954248273;830.6137645994642;843.472829481574;843.9578021098921;854.239726643288;859.0850743957665;584.2171490203148;599.0744300056336;602.5902386377305;626.9780557680459;637.5983130627675;11106.278091924;11162.330260184415;11313.943430282961;11584.362860042778;12167.513299468099;598.7664810723821;598.9011813050885;599.7181324777348;600.67263341479;610.5176910240949;5254.2118682197215;5335.439778823167;5352.652077614943;5468;5492.835214943558;120433;121403;122398;123691.3815430935;126070;97597.5120124409;100999.49500252452;101198.99999999853;103265.48367258266;104688;89953.55023224973;89980.10019899717;90748;91512;91820.54089729508;10040.447775372424;10206.59173633076;10245.795084098425;10254.794904102026;10397.896021039995;42044;43152.784236078616;43778;44858.55141448674;44902.32646510239;57329.14006289826;58298.708506457195;59235.407645924715;59580;59758.40241597528;13143.53997610079;13267.40296686632;13342.599722008355;13454.663633409244;13470.461181552628;14757.778633320295;14803.703925921636;14866.331015104563;14870.628234294229;14927.104373737611;13438.193708377528;13604.863951360756;13713.245771482665;13821.723565528835;13897.722045559234;13861.306934653025;14126.011179217767;14287.42850285977;14319.928400357932;14395;12937.159084659466;13063.477460901837;13073.346332683137;13167.47330106785;13349.332533373099;10250.641227557;10325.63860264887;10617.946910265398;10874.130069594255;11011.28426652265;11247;11268.661940141808;11335.829962550733;11392;11575.479103440197 11:25:56 INFO - PID 3786 | __end_tp_report 11:25:56 INFO - PID 3786 | __start_cc_report 11:25:56 INFO - PID 3786 | _x_x_mozilla_cycle_collect,374 11:25:56 INFO - PID 3786 | __end_cc_report 11:25:56 INFO - PID 3786 | __startTimestamp1505067956971__endTimestamp 11:25:56 INFO - PID 3786 | 11:25:56 INFO - PID 3786 | ------- Summary: start ------- 11:25:56 INFO - PID 3786 | Number of tests: 6 11:25:56 INFO - PID 3786 | 11:25:56 INFO - PID 3786 | [#0] dojo.html Cycles:165 Average:6128.49 Median:6384.98 stddev:741.80 (11.6%) stddev-sans-first:704.73 11:25:56 INFO - PID 3786 | Values: 3089.6 3113.9 3129.7 3129.7 3169.4 6003.4 6158.8 6166.4 6207.2 6265.7 6093.1 6100.3 6111.0 6226.7 6354.5 5774.5 5796.7 5801.4 5835.6 5864.7 5719.7 5720.1 5738.7 5775.2 5782.9 5705.9 5738.8 5782.7 5804.3 5826.8 5476.7 5565.3 5583.8 5634.3 5641.7 5608.0 5622.5 5649.5 5653.0 5660.9 6095.7 6104.9 6127.1 6178.7 6180.2 6666.4 6729.4 6772.4 6801.8 6804.2 6773.2 6784.8 6837.9 6845.9 6875.9 6024.6 6093.7 6164.6 6168.6 6254.6 6842.2 6845.3 6940.2 6945.9 6945.9 6630.7 6648.1 6664.6 6669.9 6677.6 6677.8 6690.0 6705.8 6756.6 6804.6 6432.1 6623.5 6672.0 6707.5 6722.4 6570.2 6590.9 6721.9 6730.9 6732.4 5210.2 5214.9 5284.5 5296.5 5298.3 4526.9 4585.4 4594.5 4599.8 4640.2 5711.7 5740.1 5743.3 5773.7 5807.5 6387.5 6415.4 6631.1 6747.1 6810.5 5706.4 5727.8 5744.5 5765.7 5771.4 5752.7 5771.4 5780.9 5785.7 5789.5 6317.7 6376.7 6407.8 6415.4 6482.8 6478.1 6641.9 6645.0 6677.7 6733.0 6329.8 6406.3 6469.3 6512.5 6515.6 6576.8 6587.5 6648.9 6656.0 6666.4 6658.0 6661.9 6687.2 6748.6 6758.3 6342.4 6400.4 6412.2 6499.6 6522.3 6496.9 6515.3 6519.0 6527.4 6530.1 6395.4 6435.5 6458.3 6488.1 6500.1 6498.5 6508.5 6588.4 6595.1 6622.2 6076.8 6206.9 6267.9 6385.0 6417.2 11:25:56 INFO - PID 3786 | 11:25:56 INFO - PID 3786 | [#1] ext.html Cycles:180 Average:34586.73 Median:34245.74 stddev:46640.28 (136.2%) stddev-sans-first:46701.99 11:25:56 INFO - PID 3786 | Values: 767.7 789.6 792.2 795.3 797.1 38567.0 41756.8 41988.4 42022.4 42217.2 38511.2 38689.4 38924.8 38945.2 38987.0 6925.3 7024.9 7045.1 7047.4 7063.0 6939.1 6943.9 7025.9 7031.0 7033.4 6970.1 6994.5 7004.1 7017.6 7025.2 7210.3 7880.4 7888.0 7898.9 7946.1 7672.8 7812.9 7813.2 7815.2 7818.5 37885.6 38059.2 38536.8 38556.0 38633.0 3541.2 3572.2 3574.9 3575.4 3576.2 31950.4 32208.0 32472.2 32482.0 32496.0 5157.4 5182.0 5217.8 5221.7 5267.4 177858.0 177882.0 178380.0 179615.0 180809.0 39338.0 40150.8 46536.0 46642.5 47023.0 49835.8 50170.7 50187.0 50278.0 50538.2 14959.4 15118.6 15119.7 15152.3 15159.5 12150.0 12195.7 12232.8 12234.1 12402.1 13633.8 13748.9 13783.1 13787.8 13991.2 5523.4 5569.3 5631.2 5703.1 5719.4 1006.4 1026.1 1026.5 1037.3 1045.5 22332.4 22843.8 22881.5 22884.2 23533.4 1108.9 1111.2 1128.2 1138.0 1139.2 12436.1 12451.3 12495.1 12505.7 12526.2 213470.0 215130.0 215163.0 216735.0 217802.0 51331.0 51690.7 51742.7 51786.0 51845.2 1419.0 1474.3 1477.0 1479.2 1482.7 21892.9 22055.6 22154.2 22448.0 22641.1 36501.3 36697.6 36709.3 36945.3 36952.1 135270.0 136084.3 136421.0 136569.0 136903.0 29394.7 29867.0 32948.3 33478.5 33574.5 42439.0 42716.1 42797.8 43152.8 43158.0 31142.2 31724.8 31757.4 31767.4 32336.8 31159.0 31251.2 31814.7 31848.5 31888.5 33872.8 34618.7 34747.0 34767.8 34933.6 30172.8 30670.5 30986.7 30996.8 31629.1 23007.5 23220.7 23258.4 23299.0 23659.6 11:25:56 INFO - PID 3786 | 11:25:56 INFO - PID 3786 | [#2] jquery.html Cycles:180 Average:32727.98 Median:21623.67 stddev:71556.60 (330.9%) stddev-sans-first:71716.55 11:25:56 INFO - PID 3786 | Values: 548.9 567.2 570.4 573.7 593.1 21718.5 22375.3 22419.9 22568.9 22635.1 22767.3 23832.0 24100.0 24201.5 24278.6 6568.0 6708.7 6736.2 6738.1 6740.8 6570.5 6739.3 6739.9 6755.0 6767.7 6287.0 6582.3 6584.9 6592.6 6692.5 6570.3 6604.7 6624.5 6641.6 6667.7 5870.8 6104.6 6113.1 6136.6 6160.4 27754.0 28338.6 28372.4 28397.1 28441.3 2010.7 2031.3 2033.9 2034.5 2039.5 18451.4 18931.7 19168.6 19191.0 19226.4 2393.9 2432.2 2467.7 2468.4 2471.1 112427.0 117174.0 117888.0 123809.0 124870.4 20265.6 20646.3 20940.7 20952.6 21016.5 39814.8 39985.6 40045.8 40325.4 40402.8 10442.8 10568.9 10575.3 10596.2 10775.3 8728.5 8767.6 8815.6 8840.6 8907.1 10613.2 10678.9 10850.0 10901.9 10960.7 4112.6 4148.1 4218.6 4224.0 4257.0 963.3 974.9 988.7 989.8 990.0 18522.4 18553.4 18825.2 18962.3 19008.9 1028.4 1035.2 1047.6 1053.2 1057.2 10296.6 10421.2 10500.0 10622.9 10629.1 418380.0 424244.0 424342.0 426130.0 430566.0 106615.0 109608.5 110194.4 110398.4 111199.0 1172.7 1178.8 1193.9 1206.7 1208.1 16852.7 16863.8 16880.3 16909.2 17073.7 53578.7 54324.0 55136.0 55547.4 55560.0 64314.7 64672.0 65055.3 65453.7 65667.0 18393.7 19349.8 19477.1 19572.8 19644.3 21528.9 21879.1 21926.2 21965.7 22109.3 17549.5 17584.8 17803.2 17926.4 18100.0 15477.6 15488.5 15957.5 16038.1 16268.5 17168.8 17355.4 17431.7 17520.3 18108.5 18666.4 19011.0 19160.3 19208.9 19508.4 17307.7 17362.0 17607.2 17623.4 17707.5 11:25:56 INFO - PID 3786 | 11:25:56 INFO - PID 3786 | [#3] mootools.html Cycles:180 Average:9077.03 Median:2681.07 stddev:6687.87 (249.4%) stddev-sans-first:6681.17 11:25:56 INFO - PID 3786 | Values: 1310.3 1356.1 1378.7 1382.5 1388.6 14875.3 15527.5 15529.5 15529.6 15536.3 15217.5 15221.8 15299.8 15336.5 15348.9 2648.9 2756.6 2770.5 2784.4 2795.7 2700.3 2737.5 2740.8 2755.6 2776.0 2593.2 2691.4 2775.3 2782.0 2782.8 2697.4 2715.8 2722.8 2745.1 2745.5 2556.0 2629.3 2641.9 2654.4 2670.7 14649.5 14682.8 14751.2 14873.7 14948.5 7525.3 7807.4 7823.3 7843.7 7856.6 4958.5 5125.8 5131.3 5182.8 5185.6 1922.5 1923.3 1980.7 1984.9 2031.7 26013.5 26279.6 26293.9 26394.7 26509.0 6303.2 6408.9 6543.3 6579.0 6585.2 16788.8 16902.8 17002.9 17011.8 17028.6 7499.6 7718.0 7722.3 7779.8 7793.1 7134.8 7142.1 7144.2 7164.4 7188.0 4758.1 4874.3 4923.3 4955.0 4970.6 1168.2 1178.2 1190.6 1194.5 1198.6 835.1 861.7 867.2 875.9 881.8 7175.1 7280.9 7293.5 7293.7 7307.5 670.7 670.7 677.7 679.8 683.4 4237.8 4831.9 4906.6 4925.6 4942.0 20854.4 21075.2 21427.0 21556.6 21607.1 21421.7 21441.5 21590.6 21806.1 22022.6 10008.6 10142.0 10184.3 10208.1 10253.1 8212.6 8298.9 8377.3 8408.4 8496.0 18296.5 18648.8 18925.0 19032.2 19236.0 18947.9 19222.6 19274.9 19343.0 19432.6 9869.6 10187.8 10238.8 10308.2 10385.3 13730.7 13989.2 13999.9 14017.2 14031.8 10609.8 10812.6 10813.2 11028.4 11059.6 10211.3 10246.1 10252.2 10375.6 10718.5 8770.1 8932.8 9041.9 9046.6 9126.1 6452.9 6624.8 6659.1 6685.4 6784.1 6598.8 6730.9 6730.9 6731.3 6773.3 11:25:56 INFO - PID 3786 | 11:25:56 INFO - PID 3786 | [#4] prototype.html Cycles:180 Average:5441.20 Median:6043.29 stddev:1520.97 (25.2%) stddev-sans-first:1479.35 11:25:56 INFO - PID 3786 | Values: 501.1 503.3 514.0 521.7 528.9 6142.3 6147.2 6151.5 6262.9 6316.4 6045.0 6111.4 6150.3 6180.8 6201.2 5086.5 5108.4 5128.8 5130.9 5143.8 5057.3 5120.3 5144.3 5161.3 5197.4 4726.9 4824.1 4836.3 4849.7 4973.6 4876.0 4893.7 4897.9 4898.0 4927.2 4313.5 4352.9 4378.9 4381.2 4382.1 5797.4 5915.4 5976.7 5990.4 6034.9 5608.5 5624.6 5651.1 5657.3 5718.9 6421.6 6426.4 6474.3 6560.1 6578.6 4574.7 4810.3 4832.9 4889.6 4890.5 6689.9 6779.0 6789.5 6874.7 6893.7 4946.5 4958.7 4976.2 4987.7 5001.1 4931.5 4934.2 4962.6 4995.7 5013.1 5634.5 5638.4 5643.9 5652.6 5696.9 6582.7 6636.5 6652.5 6659.8 6665.0 1725.8 1733.0 1756.6 1757.1 1770.2 1140.0 1188.7 1204.9 1214.7 1215.4 5568.6 5615.4 5615.9 5676.8 5692.5 6471.9 6494.9 6643.2 6649.6 6691.9 5553.0 5582.5 5588.6 5622.3 5642.2 3451.4 3521.2 3538.2 3574.2 3582.8 6245.7 6303.9 6408.9 6411.4 6448.3 6779.3 6790.7 6791.6 6798.7 6833.8 6298.9 6318.0 6342.8 6400.4 6455.0 6041.6 6465.6 6485.9 6592.5 6621.6 6487.7 6561.5 6631.9 6662.8 6663.8 6263.4 6274.5 6292.9 6326.6 6465.6 4798.0 4907.5 4934.6 4956.0 4976.2 6451.7 6454.6 6625.6 6671.7 6688.4 6241.5 6306.7 6384.3 6454.3 6484.0 6251.2 6399.9 6437.4 6451.4 6503.3 6336.4 6382.6 6388.6 6447.6 6456.7 6535.0 6548.8 6564.4 6580.3 6582.4 6224.4 6305.2 6329.6 6347.1 6360.6 11:25:56 INFO - PID 3786 | 11:25:56 INFO - PID 3786 | [#5] yui.html Cycles:180 Average:23273.85 Median:19334.87 stddev:34881.34 (180.4%) stddev-sans-first:34938.51 11:25:56 INFO - PID 3786 | Values: 835.4 875.0 883.9 889.8 891.3 18028.1 18183.2 18442.4 18508.6 18561.4 16058.4 16869.2 17033.7 17044.8 17063.6 975.1 994.3 996.8 998.8 1000.0 938.2 990.0 992.2 992.7 993.5 1037.8 1047.6 1050.3 1051.5 1056.2 1045.0 1054.2 1054.4 1054.5 1056.1 719.6 738.0 740.2 743.9 767.8 19337.3 19646.6 19705.0 19866.0 19897.1 19332.4 19635.0 20008.2 20240.3 20339.3 16663.0 16698.2 16752.9 16787.8 16799.2 3517.1 3538.1 3543.0 3552.7 3557.2 137610.3 139409.0 139933.3 143075.0 144165.0 15349.3 15443.5 15607.5 15767.4 15822.4 25179.5 26234.1 26249.2 26287.6 26314.5 7472.9 7537.5 7562.2 7625.7 7627.2 3701.0 3714.7 3740.0 3744.5 3756.5 5215.6 5232.9 5310.6 5322.7 5378.0 830.6 843.5 844.0 854.2 859.1 584.2 599.1 602.6 627.0 637.6 11106.3 11162.3 11313.9 11584.4 12167.5 598.8 598.9 599.7 600.7 610.5 5254.2 5335.4 5352.7 5468.0 5492.8 120433.0 121403.0 122398.0 123691.4 126070.0 97597.5 100999.5 101199.0 103265.5 104688.0 89953.6 89980.1 90748.0 91512.0 91820.5 10040.4 10206.6 10245.8 10254.8 10397.9 42044.0 43152.8 43778.0 44858.6 44902.3 57329.1 58298.7 59235.4 59580.0 59758.4 13143.5 13267.4 13342.6 13454.7 13470.5 14757.8 14803.7 14866.3 14870.6 14927.1 13438.2 13604.9 13713.2 13821.7 13897.7 13861.3 14126.0 14287.4 14319.9 14395.0 12937.2 13063.5 13073.3 13167.5 13349.3 10250.6 10325.6 10617.9 10874.1 11011.3 11247.0 11268.7 11335.8 11392.0 11575.5 11:25:56 INFO - PID 3786 | -------- Summary: end -------- 11:25:56 INFO - PID 3786 | 11:25:57 INFO - TEST-INFO | 3786: exit 0 11:25:57 INFO - TEST-OK | dromaeo_css | took 1116395ms 11:25:57 INFO - TEST-START | kraken 11:25:57 INFO - Initialising browser for kraken test... 11:25:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39350/getInfo.html -profile /tmp/tmp4gEqWS/profile 11:25:57 INFO - TEST-INFO | started process 4185 (/builds/slave/test/build/application/firefox/firefox http://localhost:39350/getInfo.html) 11:26:03 INFO - TEST-INFO | 4185: exit 0 11:26:03 INFO - Browser initialized. 11:26:03 INFO - Running cycle 1/1 for kraken test... 11:26:03 INFO - Using env: {'DISPLAY': ':0', 11:26:03 INFO - 'HOME': '/home/cltbld', 11:26:03 INFO - 'JSGC_DISABLE_POISONING': '1', 11:26:03 INFO - 'LANG': 'en_US.UTF-8', 11:26:03 INFO - 'LANGUAGE': 'en_US:en', 11:26:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:26:03 INFO - 'LOGNAME': 'cltbld', 11:26:03 INFO - 'MAIL': '/var/mail/cltbld', 11:26:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:26:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:26:03 INFO - 'MOZ_ACCELERATED': '1', 11:26:03 INFO - 'MOZ_CRASHREPORTER': '1', 11:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:26:03 INFO - 'MOZ_NO_REMOTE': '1', 11:26:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:26:03 INFO - 'MOZ_WEBRENDER': '1', 11:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:03 INFO - 'NO_EM_RESTART': '1', 11:26:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:03 INFO - 'PWD': '/builds/slave/test', 11:26:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:26:03 INFO - 'RUST_BACKTRACE': 'full', 11:26:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:26:03 INFO - 'SHELL': '/bin/bash', 11:26:03 INFO - 'SHLVL': '1', 11:26:03 INFO - 'TERM': 'linux', 11:26:03 INFO - 'TMOUT': '86400', 11:26:03 INFO - 'USER': 'cltbld', 11:26:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619', 11:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:03 INFO - '_': '/tools/buildbot/bin/python'} 11:26:03 INFO - TEST-INFO | started process 4398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4gEqWS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:04 INFO - PID 4398 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:26:04 INFO - PID 4398 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:26:05 INFO - PID 4398 | 11:26:05 INFO - PID 4398 | (/builds/slave/test/build/application/firefox/firefox:4459): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:26:05 INFO - PID 4398 | 11:26:15 INFO - PID 4398 | RSS: Main: 205668352 11:26:15 INFO - PID 4398 | 11:26:18 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39350/tests/kraken/driver.html?testName=audio-beat-detection) 11:26:19 INFO - PID 4398 | RSS: Main: 211431424 11:26:19 INFO - PID 4398 | 11:26:21 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39350/tests/kraken/driver.html?testName=audio-dft) 11:26:22 INFO - PID 4398 | RSS: Main: 213041152 11:26:22 INFO - PID 4398 | 11:26:25 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39350/tests/kraken/driver.html?testName=audio-fft) 11:26:26 INFO - PID 4398 | RSS: Main: 206753792 11:26:26 INFO - PID 4398 | 11:26:28 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39350/tests/kraken/driver.html?testName=audio-oscillator) 11:26:29 INFO - PID 4398 | RSS: Main: 206942208 11:26:29 INFO - PID 4398 | 11:26:31 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39350/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:26:31 INFO - PID 4398 | RSS: Main: 209522688 11:26:31 INFO - PID 4398 | 11:26:35 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39350/tests/kraken/driver.html?testName=imaging-darkroom) 11:26:35 INFO - PID 4398 | RSS: Main: 212037632 11:26:35 INFO - PID 4398 | 11:26:39 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39350/tests/kraken/driver.html?testName=imaging-desaturate) 11:26:40 INFO - PID 4398 | RSS: Main: 210436096 11:26:40 INFO - PID 4398 | 11:26:43 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39350/tests/kraken/driver.html?testName=json-parse-financial) 11:26:43 INFO - PID 4398 | RSS: Main: 211992576 11:26:43 INFO - PID 4398 | 11:26:45 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39350/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:26:45 INFO - PID 4398 | RSS: Main: 212074496 11:26:45 INFO - PID 4398 | 11:26:47 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39350/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:26:48 INFO - PID 4398 | RSS: Main: 211890176 11:26:48 INFO - PID 4398 | 11:26:50 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39350/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:26:51 INFO - PID 4398 | RSS: Main: 212164608 11:26:51 INFO - PID 4398 | 11:26:53 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:26:54 INFO - PID 4398 | RSS: Main: 212508672 11:26:54 INFO - PID 4398 | 11:26:57 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:26:58 INFO - PID 4398 | RSS: Main: 211980288 11:26:58 INFO - PID 4398 | 11:26:59 INFO - PID 4398 | Cycle 1(1): loaded http://localhost:39350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39350/tests/kraken/driver.html?testName=ai-astar) 11:27:00 INFO - PID 4398 | RSS: Main: 214781952 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | __start_tp_report 11:27:00 INFO - PID 4398 | _x_x_mozilla_page_load 11:27:00 INFO - PID 4398 | _x_x_mozilla_page_load_details 11:27:00 INFO - PID 4398 | |i|pagename|runs| 11:27:00 INFO - PID 4398 | |0;ai-astar;110;109;106;107;113;112;115;113;108;111 11:27:00 INFO - PID 4398 | |1;audio-beat-detection;128;120;117;119;148;119;120;120;117;119 11:27:00 INFO - PID 4398 | |2;audio-dft;162;168;165;173;176;169;168;165;165;167 11:27:00 INFO - PID 4398 | |3;audio-fft;80;80;74;74;74;75;75;81;75;76 11:27:00 INFO - PID 4398 | |4;audio-oscillator;87;80;81;79;82;80;84;81;88;85 11:27:00 INFO - PID 4398 | |5;imaging-gaussian-blur;111;116;120;115;115;116;123;129;115;115 11:27:00 INFO - PID 4398 | |6;imaging-darkroom;149;155;149;157;148;149;154;150;150;150 11:27:00 INFO - PID 4398 | |7;imaging-desaturate;104;99;96;94;100;102;95;95;95;96 11:27:00 INFO - PID 4398 | |8;json-parse-financial;61;54;52;52;53;54;52;54;57;51 11:27:00 INFO - PID 4398 | |9;json-stringify-tinderbox;42;40;38;39;45;38;44;38;48;44 11:27:00 INFO - PID 4398 | |10;stanford-crypto-aes;83;80;82;79;74;78;83;78;82;75 11:27:00 INFO - PID 4398 | |11;stanford-crypto-ccm;128;120;123;119;133;116;134;123;124;120 11:27:00 INFO - PID 4398 | |12;stanford-crypto-pbkdf2;174;171;176;170;178;175;176;175;175;170 11:27:00 INFO - PID 4398 | |13;stanford-crypto-sha256-iterative;65;65;65;65;62;67;67;63;65;65 11:27:00 INFO - PID 4398 | __end_tp_report 11:27:00 INFO - PID 4398 | __start_cc_report 11:27:00 INFO - PID 4398 | _x_x_mozilla_cycle_collect,928 11:27:00 INFO - PID 4398 | __end_cc_report 11:27:00 INFO - PID 4398 | __startTimestamp1505068020181__endTimestamp 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | ------- Summary: start ------- 11:27:00 INFO - PID 4398 | Number of tests: 14 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:2.91 (2.6%) stddev-sans-first:3.09 11:27:00 INFO - PID 4398 | Values: 110.0 109.0 106.0 107.0 113.0 112.0 115.0 113.0 108.0 111.0 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#1] audio-beat-detection Cycles:10 Average:122.70 Median:120.00 stddev:9.41 (7.8%) stddev-sans-first:9.78 11:27:00 INFO - PID 4398 | Values: 128.0 120.0 117.0 119.0 148.0 119.0 120.0 120.0 117.0 119.0 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#2] audio-dft Cycles:10 Average:167.80 Median:168.00 stddev:4.13 (2.5%) stddev-sans-first:3.81 11:27:00 INFO - PID 4398 | Values: 162.0 168.0 165.0 173.0 176.0 169.0 168.0 165.0 165.0 167.0 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#3] audio-fft Cycles:10 Average:76.40 Median:75.50 stddev:2.80 (3.7%) stddev-sans-first:2.65 11:27:00 INFO - PID 4398 | Values: 80.0 80.0 74.0 74.0 74.0 75.0 75.0 81.0 75.0 76.0 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:83.00 stddev:3.13 (3.8%) stddev-sans-first:2.91 11:27:00 INFO - PID 4398 | Values: 87.0 80.0 81.0 79.0 82.0 80.0 84.0 81.0 88.0 85.0 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:116.00 stddev:5.17 (4.5%) stddev-sans-first:4.92 11:27:00 INFO - PID 4398 | Values: 111.0 116.0 120.0 115.0 115.0 116.0 123.0 129.0 115.0 115.0 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:150.00 stddev:3.07 (2.0%) stddev-sans-first:3.16 11:27:00 INFO - PID 4398 | Values: 149.0 155.0 149.0 157.0 148.0 149.0 154.0 150.0 150.0 150.0 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:95.00 stddev:3.44 (3.6%) stddev-sans-first:2.76 11:27:00 INFO - PID 4398 | Values: 104.0 99.0 96.0 94.0 100.0 102.0 95.0 95.0 95.0 96.0 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:2.98 (5.5%) stddev-sans-first:1.79 11:27:00 INFO - PID 4398 | Values: 61.0 54.0 52.0 52.0 53.0 54.0 52.0 54.0 57.0 51.0 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#9] json-stringify-tinderbox Cycles:10 Average:41.60 Median:43.00 stddev:3.53 (8.2%) stddev-sans-first:3.75 11:27:00 INFO - PID 4398 | Values: 42.0 40.0 38.0 39.0 45.0 38.0 44.0 38.0 48.0 44.0 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:81.00 stddev:3.20 (4.0%) stddev-sans-first:3.12 11:27:00 INFO - PID 4398 | Values: 83.0 80.0 82.0 79.0 74.0 78.0 83.0 78.0 82.0 75.0 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:123.50 stddev:5.96 (4.8%) stddev-sans-first:6.15 11:27:00 INFO - PID 4398 | Values: 128.0 120.0 123.0 119.0 133.0 116.0 134.0 123.0 124.0 120.0 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:175.00 stddev:2.75 (1.6%) stddev-sans-first:2.92 11:27:00 INFO - PID 4398 | Values: 174.0 171.0 176.0 170.0 178.0 175.0 176.0 175.0 175.0 170.0 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.52 (2.3%) stddev-sans-first:1.62 11:27:00 INFO - PID 4398 | Values: 65.0 65.0 65.0 65.0 62.0 67.0 67.0 63.0 65.0 65.0 11:27:00 INFO - PID 4398 | -------- Summary: end -------- 11:27:00 INFO - PID 4398 | 11:27:00 INFO - PID 4398 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:27:01 INFO - TEST-INFO | 4398: exit 0 11:27:01 INFO - TEST-OK | kraken | took 63240ms 11:27:01 INFO - SUITE-END | took 1179s 11:27:01 INFO - Completed test suite (00:19:39) 11:27:01 INFO - javascript benchmark 11:27:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8309.220965827548, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.5829063076485, 3113.9065828025155, 3129.687031296869, 3129.718325350718, 3169.3661267746456, 6003.429674180946, 6158.784442544512, 6166.3525329840395, 6207.193064901562, 6265.718042688079, 6093.146959425684, 6100.298465676448, 6111.02223644217, 6226.657533835637, 6354.459870910967, 5774.4802967733, 5796.739146738407, 5801.448862358069, 5835.562332825034, 5864.73608687608, 5719.6854173020465, 5720.11338242573, 5738.684372359518, 5775.162601422791, 5782.9421705782825, 5705.914411283834, 5738.770449182028, 5782.653040817564, 5804.2744656917885, 5826.82519524415, 5476.698781567012, 5565.276514053147, 5583.832485025415, 5634.295713035871, 5641.717914104278, 5608.046632072557, 5622.465865742748, 5649.49154576086, 5653.010723123437, 5660.915086273709, 6095.664738439384, 6104.908426373608, 6127.142200091991, 6178.660173690445, 6180.165677633507, 6666.433353164987, 6729.394354508117, 6772.390484856337, 6801.829954251134, 6804.21751498579, 6773.153355830521, 6784.76253331131, 6837.863242735118, 6845.863082738367, 6875.931240687579, 6024.608400453956, 6093.725782339805, 6164.568480206387, 6168.629882207082, 6254.562180647356, 6842.247352791189, 6845.281245469254, 6940.201876784134, 6945.861082778316, 6945.861082778316, 6630.734770609218, 6648.135742353463, 6664.600123992576, 6669.933300667029, 6677.599344039373, 6677.799666010027, 6689.9965005249605, 6705.832354191087, 6756.560823546453, 6804.55770374924, 6432.131662225634, 6623.536352455282, 6671.966640166866, 6707.463402927851, 6722.394984451325, 6570.178727659043, 6590.901136482957, 6721.899171512431, 6730.889403248507, 6732.427743641747, 5210.21846722987, 5214.8527323988665, 5284.524392804666, 5296.549793267538, 5298.311219541512, 4526.909461810811, 4585.358049873021, 4594.517575654508, 4599.770011499411, 4640.23436133041, 5711.657300561979, 5740.052891272893, 5743.282089738783, 5773.682447465346, 5807.535397168216, 6387.520935929824, 6415.358464153641, 6631.137952066297, 6747.122874026345, 6810.455163586901, 5706.3722990471015, 5727.799527016535, 5744.454276843777, 5765.711714414262, 5771.365149833515, 5752.712364381764, 5771.422857714279, 5780.913286300709, 5785.652860828363, 5789.478946894799, 6317.684115794192, 6376.7130479128555, 6407.750488654668, 6415.422611964852, 6482.773102941469, 6478.125453063776, 6641.933580664131, 6644.966775166094, 6677.699503522256, 6732.966335168293, 6329.841753956188, 6406.327335629878, 6469.288378278292, 6512.479001679949, 6515.641639709862, 6576.76981305652, 6587.538872278895, 6648.867022659617, 6656.0, 6666.366695163952, 6658.0, 6661.866762664817, 6687.164104486939, 6748.561343512656, 6758.290379510081, 6342.365763423805, 6400.359964003563, 6412.23053233615, 6499.610023398611, 6522.34776522344, 6496.935030649822, 6515.315891831479, 6518.967405162944, 6527.412532871875, 6530.118434011348, 6395.42441180296, 6435.485161187187, 6458.321876202931, 6488.091667166506, 6500.089987401673, 6498.480121590356, 6508.479321654351, 6588.439982601532, 6595.142631458071, 6622.205335359788, 6076.756929722938, 6206.906896396648, 6267.9373206267355, 6384.978403455425, 6417.1657684500715], "value": 6071.7894542267, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.7044337929897, 789.6249281591241, 792.2117493094372, 795.2604078207269, 797.0554892452444, 38567.0, 41756.79121604395, 41988.37017444737, 42022.36966445506, 42217.15565688692, 38511.22977540448, 38689.41965870507, 38924.80537597308, 38945.22109557807, 38987.0, 6925.307469253072, 7024.894626580605, 7045.084139061941, 7047.436205103605, 7063.0, 6939.132608423947, 6943.930560694404, 7025.8594828103405, 7031.015657807885, 7033.402160816337, 6970.059042029337, 6994.545354551963, 7004.089468369105, 7017.578945263275, 7025.192102908154, 7210.315020073111, 7880.408969327266, 7887.96056019722, 7898.921010789876, 7946.086200086977, 7672.808179795494, 7812.882806757903, 7813.218678132198, 7815.179406162328, 7818.45270831042, 37885.621143788485, 38059.23881522354, 38536.80731596324, 38556.0, 38633.0, 3541.1678255609913, 3572.2319701264355, 3574.928501429983, 3575.410057340536, 3576.213233088716, 31950.360992780246, 32208.03375898727, 32472.18819529507, 32482.0, 32496.0, 5157.381114266274, 5182.015417070782, 5217.765200565984, 5221.686698798047, 5267.394249661262, 177858.0, 177882.0, 178380.0, 179615.0, 180808.9999999987, 39338.0, 40150.79924600358, 46536.0, 46642.5335746645, 47023.0, 49835.75082124566, 50170.749146254035, 50187.0, 50278.0, 50538.241926371134, 14959.40162393492, 15118.622034449227, 15119.697606047817, 15152.31814568347, 15159.469418570297, 12150.0, 12195.695107622381, 12232.755344893052, 12234.143609947218, 12402.06984476168, 13633.795493067611, 13748.862511374959, 13783.104098233583, 13787.793183102262, 13991.16053036821, 5523.392426833045, 5569.303837020372, 5631.183478395692, 5703.08750599902, 5719.399463056319, 1006.3710181136789, 1026.097034609539, 1026.5483187397522, 1037.3153718545723, 1045.5399624165343, 22332.441688957904, 22843.771562284495, 22881.542369152525, 22884.199053033062, 23533.411664708176, 1108.9279196852178, 1111.1943840715417, 1128.1877048525048, 1137.9772404551863, 1139.1797905508022, 12436.067294952914, 12451.315177665134, 12495.062870284764, 12505.74988500225, 12526.248425094524, 213470.0, 215130.0, 215163.0, 216735.0, 217802.0, 51331.0, 51690.74154629278, 51742.741286294084, 51786.0, 51845.222321665206, 1418.9645258868404, 1474.277603974045, 1476.963075923089, 1479.2012313350886, 1482.7182835261267, 21892.89053554722, 22055.558888822456, 22154.22460213885, 22448.0, 22641.094356225567, 36501.26997460089, 36697.63302367049, 36709.26581468302, 36945.26109477849, 36952.07619809526, 135270.0, 136084.31957840148, 136421.0, 136569.0, 136903.0, 29394.706052939197, 29867.0, 32948.341033179684, 33478.4978225322, 33574.49638255379, 42439.0, 42716.14567708566, 42797.786011069744, 43152.784236078616, 43158.0, 31142.22144446407, 31724.841375792974, 31757.364852702354, 31767.364652706354, 32336.83831580827, 31159.0, 31251.218719532193, 31814.681853181173, 31848.52227216547, 31888.521672174473, 33872.830635846665, 34618.65381346154, 34747.0, 34767.82616086904, 34933.58435310118, 30172.849135754182, 30670.539941900442, 30986.690133098382, 30996.845015774776, 31629.051128466184, 23007.53984920326, 23220.651690224324, 23258.418539536648, 23299.0, 23659.580425174543], "value": 16520.172214476195, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.9423610520895, 567.2229046206697, 570.3953808962502, 573.7463641942355, 593.0629605223747, 21718.457038574044, 22375.328740137782, 22419.887900560516, 22568.887155564218, 22635.094596216153, 22767.31698049057, 23832.0, 24100.0, 24201.515969680597, 24278.635820462707, 6568.0, 6708.664566771667, 6736.191657001143, 6738.056672065914, 6740.764073257437, 6570.540062195648, 6739.326067393246, 6739.8652026959435, 6755.0, 6767.661616919159, 6286.968565157191, 6582.308857569958, 6584.93415065848, 6592.604443733368, 6692.498062645297, 6570.342965703416, 6604.702788374535, 6624.53628246023, 6641.634710090967, 6667.666616669196, 5870.823875283749, 6104.633721976696, 6113.113598528233, 6136.6011209271255, 6160.414760597736, 27754.0, 28338.57492137599, 28372.43255134886, 28397.14808555726, 28441.288967775763, 2010.7184994100837, 2031.2687432524278, 2033.9491512712152, 2034.4608678700156, 2039.4697378681649, 18451.35420260298, 18931.716024259647, 19168.61662766737, 19191.0, 19226.423207303804, 2393.904243830245, 2432.2338463384153, 2467.740887206853, 2468.358226861029, 2471.1351027140536, 112426.99999999919, 117174.0, 117888.0, 123809.0, 124870.37564812209, 20265.58140930121, 20646.277380291616, 20940.685889711665, 20952.580948380946, 21016.474588135417, 39814.80092599519, 39985.600143998185, 40045.79977100154, 40325.39511907324, 40402.79798600988, 10442.791144177074, 10568.947155264328, 10575.259731818853, 10596.152307815357, 10775.299605525615, 8728.476291422536, 8767.649294028168, 8815.603297851612, 8840.602172902234, 8907.064758200426, 10613.20400969915, 10678.94660526708, 10849.96925292096, 10901.890981090088, 10960.725981850359, 4112.642827866796, 4148.087420767426, 4218.641415479658, 4224.0, 4256.9574304257185, 963.325672029582, 974.8732664753537, 988.7429268390271, 989.8465737810651, 990.0, 18522.351717689817, 18553.35063272779, 18825.246990120242, 18962.336318228794, 19008.904955475133, 1028.4395004722444, 1035.2132379391567, 1047.61238341814, 1053.1837825685002, 1057.1965306367063, 10296.588136474456, 10421.166306695446, 10500.0, 10622.946885265525, 10629.096526795154, 418380.0, 424244.0, 424342.0, 426130.0, 430566.0, 106615.0, 109608.4519577413, 110194.44902775435, 110398.44800775945, 111199.0, 1172.7244097636878, 1178.8113901775675, 1193.8746431624727, 1206.7164216409137, 1208.099965525689, 16852.662946741242, 16863.831361686225, 16880.280074606828, 16909.15454227308, 17073.658526829146, 53578.732106339216, 54324.0, 55136.0, 55547.44452555423, 55560.0, 64314.67842660757, 64672.0, 65055.34944650493, 65453.67273163794, 65667.01499477607, 18393.724094138866, 19349.8065019348, 19477.123529440927, 19572.8042719571, 19644.312449064215, 21528.892355538123, 21879.05010667363, 21926.23258185956, 21965.67051494261, 22109.33671989843, 17549.473515794547, 17584.824151758832, 17803.198856051768, 17926.372576959744, 18100.0, 15477.613059673598, 15488.5353439397, 15957.521274361789, 16038.117903515418, 16268.51194464168, 17168.828311716723, 17355.392561260294, 17431.738523921897, 17520.299188032335, 18108.547286317946, 18666.440006799818, 19011.0, 19160.329388471895, 19208.903955480135, 19508.414747557596, 17307.740383894, 17362.045087519804, 17607.20767565437, 17623.383181588582, 17707.46877593674], "value": 12335.04968244115, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.3317308172832, 1356.071091302458, 1378.7035787305726, 1382.4815694114707, 1388.5903658420764, 14875.256237188138, 15527.534173974771, 15529.456469023586, 15529.611759706013, 15536.300866461008, 15217.54347369578, 15221.771673424908, 15299.84700152998, 15336.46322378717, 15348.923255383736, 2648.920532384022, 2756.5865120231924, 2770.459760346733, 2784.4431113777223, 2795.6784969728537, 2700.297922540144, 2737.534619114755, 2740.821846579966, 2755.641766570353, 2776.0422654184276, 2593.15722390223, 2691.434798692277, 2775.264554892955, 2782.0262907982246, 2782.8052036357462, 2697.379602691392, 2715.7691596214345, 2722.823016503941, 2745.135282386052, 2745.4509098180342, 2555.961660575093, 2629.2638061342855, 2641.867906604662, 2654.429297700984, 2670.7062223155435, 14649.487267945571, 14682.779758303634, 14751.18868462234, 14873.70252594942, 14948.476803311833, 7525.322720955086, 7807.414443916672, 7823.2567906048835, 7843.686252549891, 7856.607169641552, 4958.528939750718, 5125.769340379655, 5131.2559678846355, 5182.766775495112, 5185.585153187736, 1922.5193701574606, 1923.2786655942853, 1980.7127966444784, 1984.925752588534, 2031.725717028197, 26013.479730405284, 26279.60580591293, 26293.868530657226, 26394.73605263942, 26509.0, 6303.180586523723, 6408.903866442007, 6543.280239173687, 6579.046038324416, 6585.2426970898005, 16788.83211167897, 16902.83097169037, 17002.914985424995, 17011.829881701273, 17028.57428564271, 7499.550026998398, 7718.035245594301, 7722.266384693445, 7779.805504862311, 7793.06483222017, 7134.785956421316, 7142.142942846892, 7144.178419481722, 7164.391026762679, 7187.9640601796655, 4758.119747846659, 4874.268859671078, 4923.286123512071, 4954.950450495449, 4970.552650261494, 1168.1705988747915, 1178.1635039122318, 1190.6309044196328, 1194.52219112354, 1198.5505435461703, 835.0980940584154, 861.6854847980442, 867.1631875240423, 875.8642410426394, 881.7707396076938, 7175.067241258707, 7280.854382912418, 7293.489455738048, 7293.671784769698, 7307.525010874276, 670.6613160354087, 670.6881300195334, 677.7458453080095, 679.7756740275697, 683.3508167241141, 4237.8304867805555, 4831.855044348676, 4906.558409743069, 4925.630577706686, 4941.975290123526, 20854.37436876866, 21075.15699372008, 21427.0, 21556.56886862254, 21607.135714571243, 21421.67867481989, 21441.48181342918, 21590.568188636138, 21806.127754889945, 22022.559548808935, 10008.64969726056, 10141.999999999853, 10184.338018028804, 10208.132308753839, 10253.128484078788, 8212.589370531568, 8298.941548104438, 8377.287930525974, 8408.369372297224, 8496.0, 18296.451106466826, 18648.813511864708, 18925.0, 19032.238710451427, 19236.0, 18947.90526047361, 19222.61554768925, 19274.903625481784, 19343.0, 19432.611347773247, 9869.605215791575, 10187.796244074929, 10238.846417303896, 10308.226882983656, 10385.324953877975, 13730.65673358174, 13989.230592317113, 13999.930000350341, 14017.158970461396, 14031.789523156956, 10609.787804244026, 10812.56749730002, 10813.189010824062, 11028.393438360967, 11059.557617695202, 10211.285210035227, 10246.077852992968, 10252.179825614083, 10375.584976600852, 10718.464076795974, 8770.07914169003, 8932.821343572961, 9041.90958090437, 9046.592903319235, 9126.133017363605, 6452.903206452001, 6624.768133115318, 6659.101021362248, 6685.431738302299, 6784.05023296729, 6598.8350291243105, 6730.899036514554, 6730.93269067303, 6731.32686731323, 6773.254941956479], "value": 6379.357940765791, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.058813837752, 503.2803091579043, 513.9845804625861, 521.7182721330481, 528.8995090932723, 6142.262928448581, 6147.200863887694, 6151.477124444422, 6262.937370626292, 6316.399942005508, 6045.0, 6111.411033131384, 6150.323464418911, 6180.783672571461, 6201.162843016192, 5086.465921078289, 5108.361454818148, 5128.769205385748, 5130.9230361544605, 5143.845684629448, 5057.317262169615, 5120.283160357553, 5144.331236939192, 5161.329027226455, 5197.402298735656, 4726.90546189076, 4824.1316563018645, 4836.2987366831785, 4849.733264670442, 4973.5772459340815, 4875.9756201219125, 4893.7063776173545, 4897.926531102018, 4897.99591083827, 4927.1870141426625, 4313.460817397825, 4352.89117772055, 4378.868633940987, 4381.233284175289, 4382.123575284924, 5797.420257974211, 5915.3788852170765, 5976.73104710289, 5990.400959904018, 6034.9396506035255, 5608.523275521586, 5624.55003599711, 5651.124075768263, 5657.2928383952, 5718.914216286759, 6421.614703117782, 6426.389492998158, 6474.345518337459, 6560.147180866456, 6578.572392794453, 4574.656900732459, 4810.278458231258, 4832.8791780205775, 4889.608831293488, 4890.535399137077, 6689.866202675919, 6779.0, 6789.490788190856, 6874.725010999554, 6893.655317234118, 4946.455889852114, 4958.727270000185, 4976.154053810861, 4987.725675087832, 5001.124803159432, 4931.457539670633, 4934.1611925972675, 4962.627802914723, 4995.700257984533, 5013.1227035268685, 5634.478450968145, 5638.43615638441, 5643.915341269802, 5652.604317697722, 5696.8860622787315, 6582.736690532325, 6636.469082473391, 6652.467802575782, 6659.833504162338, 6665.0, 1725.8187890271593, 1732.9826701733073, 1756.6135450200936, 1757.1477833250863, 1770.2122555462695, 1139.9658010259539, 1188.6968822950093, 1204.8914998201676, 1214.6598952293373, 1215.4166000319897, 5568.610197286151, 5615.354234263112, 5615.943840561624, 5676.801311954062, 5692.459216374438, 6471.9029214561815, 6494.940662086196, 6643.169603799525, 6649.63427011519, 6691.933080669229, 5553.0, 5582.525485333711, 5588.552915766729, 5622.269105016404, 5642.210090587321, 3451.4114414189357, 3521.2429327694667, 3538.1862171700654, 3574.1779390739757, 3582.7723286522155, 6245.656488893154, 6303.856688725764, 6408.903866442007, 6411.358864113645, 6448.3229260927865, 6779.2881747416795, 6790.7283708652085, 6791.558548694319, 6798.694058767367, 6833.760818371433, 6298.874022519615, 6317.96841015792, 6342.778002769881, 6400.359964003563, 6454.9677251614385, 6041.577089603861, 6465.612063276219, 6485.86497362969, 6592.538522303585, 6621.602703837785, 6487.740490380332, 6561.540692151503, 6631.933680663132, 6662.800115996528, 6663.83340416474, 6263.404976527223, 6274.529410294155, 6292.874142517033, 6326.557141000086, 6465.579737317059, 4797.976010120066, 4907.509249075064, 4934.632849927768, 4955.950440495693, 4976.2286845539, 6451.741850378728, 6454.612723236621, 6625.635590042594, 6671.733130674718, 6688.3646053624825, 6241.469475094486, 6306.747730090745, 6384.265809431789, 6454.322296159024, 6483.967580162069, 6251.187345645037, 6399.872002560016, 6437.388448097423, 6451.3548645135115, 6503.25212600557, 6336.398042185985, 6382.585131966407, 6388.648624325707, 6447.6453795041725, 6456.709448074754, 6534.967325163344, 6548.770793022221, 6564.376384243489, 6580.341965803382, 6582.440492558187, 6224.439800417984, 6305.211848518935, 6329.620222786648, 6347.111404403479, 6360.554761166674], "value": 4994.566619393136, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.4110352201699, 874.9693760718374, 883.8585826267798, 889.7820034091649, 891.3270480787005, 18028.09859507024, 18183.18175682094, 18442.354517591888, 18508.629827403445, 18561.350352737656, 16058.357665693358, 16869.156542172874, 17033.659326813457, 17044.82955170451, 17063.57341066474, 975.1272611013156, 994.2990191914682, 996.7557948302676, 998.7852611688486, 1000.0399616368295, 938.2400255792795, 989.9554520046579, 992.1517102877044, 992.7468495533665, 993.4883534979491, 1037.818381783185, 1047.5757318286069, 1050.2648146297622, 1051.526812934179, 1056.1972900595526, 1044.9529771160278, 1054.219877290807, 1054.4464156317918, 1054.4991129213602, 1056.144522936424, 719.5718547464251, 738.0258059361645, 740.2486476226634, 743.9070116235471, 767.7619937819294, 19337.323193688153, 19646.607067858564, 19705.0, 19866.0, 19897.104630291673, 19332.4200273992, 19635.0, 20008.199672013103, 20240.291589794288, 20339.288124915704, 16663.0, 16698.248578813982, 16752.916235418867, 16787.832121678748, 16799.2440340185, 3517.138301116243, 3538.115471132217, 3542.982285088584, 3552.662497062775, 3557.2351944332095, 137610.31194843963, 139409.0, 139933.30033349767, 143075.0, 144165.0, 15349.309281082378, 15443.459478918408, 15607.531774046796, 15767.369305227663, 15822.446214382442, 25179.49641007206, 26234.08180713666, 26249.212523624323, 26287.60568591473, 26314.473710525683, 7472.850542989218, 7537.4723769336715, 7562.243775622504, 7625.733099341496, 7627.237276272328, 3700.962990370062, 3714.665680088805, 3739.962600374016, 3744.457053727249, 3756.492873462102, 5215.556677682363, 5232.947670523322, 5310.619238997889, 5322.680639161663, 5378.031954248273, 830.6137645994642, 843.472829481574, 843.9578021098921, 854.239726643288, 859.0850743957665, 584.2171490203148, 599.0744300056336, 602.5902386377305, 626.9780557680459, 637.5983130627675, 11106.278091924, 11162.330260184415, 11313.943430282961, 11584.362860042778, 12167.513299468099, 598.7664810723821, 598.9011813050885, 599.7181324777348, 600.67263341479, 610.5176910240949, 5254.2118682197215, 5335.439778823167, 5352.652077614943, 5468.0, 5492.835214943558, 120433.0, 121403.0, 122398.0, 123691.3815430935, 126070.0, 97597.5120124409, 100999.49500252452, 101198.99999999853, 103265.48367258266, 104688.0, 89953.55023224973, 89980.10019899717, 90748.0, 91512.0, 91820.54089729508, 10040.447775372424, 10206.59173633076, 10245.795084098425, 10254.794904102026, 10397.896021039995, 42044.0, 43152.784236078616, 43778.0, 44858.55141448674, 44902.32646510239, 57329.14006289826, 58298.708506457195, 59235.407645924715, 59580.0, 59758.40241597528, 13143.53997610079, 13267.40296686632, 13342.599722008355, 13454.663633409244, 13470.461181552628, 14757.778633320295, 14803.703925921636, 14866.331015104563, 14870.628234294229, 14927.104373737611, 13438.193708377528, 13604.863951360756, 13713.245771482665, 13821.723565528835, 13897.722045559234, 13861.306934653025, 14126.011179217767, 14287.42850285977, 14319.928400357932, 14395.0, 12937.159084659466, 13063.477460901837, 13073.346332683137, 13167.47330106785, 13349.332533373099, 10250.641227557, 10325.63860264887, 10617.946910265398, 10874.130069594255, 11011.28426652265, 11247.0, 11268.661940141808, 11335.829962550733, 11392.0, 11575.479103440197], "value": 8348.114927899556, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1464.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 106.0, 107.0, 113.0, 112.0, 115.0, 113.0, 108.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 120.0, 117.0, 119.0, 148.0, 119.0, 120.0, 120.0, 117.0, 119.0], "value": 122.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 165.0, 173.0, 176.0, 169.0, 168.0, 165.0, 165.0, 167.0], "value": 167.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 74.0, 74.0, 74.0, 75.0, 75.0, 81.0, 75.0, 76.0], "value": 76.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 81.0, 79.0, 82.0, 80.0, 84.0, 81.0, 88.0, 85.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 120.0, 115.0, 115.0, 116.0, 123.0, 129.0, 115.0, 115.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 155.0, 149.0, 157.0, 148.0, 149.0, 154.0, 150.0, 150.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 99.0, 96.0, 94.0, 100.0, 102.0, 95.0, 95.0, 95.0, 96.0], "value": 97.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 54.0, 52.0, 52.0, 53.0, 54.0, 52.0, 54.0, 57.0, 51.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 40.0, 38.0, 39.0, 45.0, 38.0, 44.0, 38.0, 48.0, 44.0], "value": 41.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 82.0, 79.0, 74.0, 78.0, 83.0, 78.0, 82.0, 75.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 120.0, 123.0, 119.0, 133.0, 116.0, 134.0, 123.0, 124.0, 120.0], "value": 124.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 176.0, 170.0, 178.0, 175.0, 176.0, 175.0, 175.0, 170.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 62.0, 67.0, 67.0, 63.0, 65.0, 65.0], "value": 64.9, "unit": "score"}]}]} 11:27:01 INFO - Return code: 0 11:27:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:27:01 INFO - # TBPL SUCCESS # 11:27:01 INFO - Running post-action listener: _package_coverage_data 11:27:01 INFO - Running post-action listener: _resource_record_post_action 11:27:01 INFO - [mozharness: 2017-09-10 18:27:01.436463Z] Finished run-tests step (success) 11:27:01 INFO - Running post-run listener: _resource_record_post_run 11:27:01 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 18870272; Write bytes: 371908608; Read time: 7192; Write time: 297036 11:27:01 INFO - TinderboxPrint: CPU usage
13.2% 11:27:01 INFO - TinderboxPrint: I/O read bytes / time
18,870,272 / 7,192 11:27:01 INFO - TinderboxPrint: I/O write bytes / time
371,908,608 / 297,036 11:27:01 INFO - TinderboxPrint: CPU idle
8,272.6 (86.7%) 11:27:01 INFO - TinderboxPrint: CPU user
1,199.8 (12.6%) 11:27:01 INFO - TinderboxPrint: Swap in / out
0 / 0 11:27:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 7925760; Read time: 0; Write time: 708 11:27:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:27:01 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 17125376; Write bytes: 363569152; Read time: 7140; Write time: 296308 11:27:02 INFO - Running post-run listener: _upload_blobber_files 11:27:02 INFO - Blob upload gear active. 11:27:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:27:02 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 11:27:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:27:02 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:27:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:27:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:03 INFO - (blobuploader) - INFO - Done attempting. 11:27:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:27:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:27:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:04 INFO - (blobuploader) - INFO - Done attempting. 11:27:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:27:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:27:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:10 INFO - (blobuploader) - INFO - Done attempting. 11:27:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:27:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:27:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:11 INFO - (blobuploader) - INFO - Done attempting. 11:27:11 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:11 INFO - Return code: 0 11:27:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:27:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7374d04147a4f0e446c685c75ee8c9858c1f1da41c2f668198bbc54fae422ca5a6f4dc3699c58a0e05d629b41c4332f8aa2307e07cfa0b10046ad1f0cbc8fe1", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b4da810cec59a72306b07e95cf58e88611f14a6d84a89ca2d775e571a176406085b8da1e7f419f9191efb28a839258ca7e99226a29e4b4f38ae52b3f25e1492", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5475c9044c9b9f521d3c5cbb830d4cbd905a5be2f30307018238f5d813b3aea2a976e10e0f920a5c0eca0214fbc22ac7a6c9925f2aba8f7965f822055292645", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92bcdb49f417df8b0db1736ebe51c72cd9a3c4b3f960613f1b219e8a13345b539fb3a5154d9596692fd2885b26e13d1c38acd00960a423737a38dbc02521c61e"} 11:27:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:27:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:27:11 INFO - Contents: 11:27:11 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7374d04147a4f0e446c685c75ee8c9858c1f1da41c2f668198bbc54fae422ca5a6f4dc3699c58a0e05d629b41c4332f8aa2307e07cfa0b10046ad1f0cbc8fe1", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b4da810cec59a72306b07e95cf58e88611f14a6d84a89ca2d775e571a176406085b8da1e7f419f9191efb28a839258ca7e99226a29e4b4f38ae52b3f25e1492", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5475c9044c9b9f521d3c5cbb830d4cbd905a5be2f30307018238f5d813b3aea2a976e10e0f920a5c0eca0214fbc22ac7a6c9925f2aba8f7965f822055292645", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92bcdb49f417df8b0db1736ebe51c72cd9a3c4b3f960613f1b219e8a13345b539fb3a5154d9596692fd2885b26e13d1c38acd00960a423737a38dbc02521c61e"} 11:27:11 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:11 INFO - Copying logs to upload dir... 11:27:11 INFO - mkdir: /builds/slave/test/build/upload/logs 11:27:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.279154 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-10 11:27:11.799250) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-10 11:27:11.803991) ========= 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=d2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7374d04147a4f0e446c685c75ee8c9858c1f1da41c2f668198bbc54fae422ca5a6f4dc3699c58a0e05d629b41c4332f8aa2307e07cfa0b10046ad1f0cbc8fe1", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b4da810cec59a72306b07e95cf58e88611f14a6d84a89ca2d775e571a176406085b8da1e7f419f9191efb28a839258ca7e99226a29e4b4f38ae52b3f25e1492", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5475c9044c9b9f521d3c5cbb830d4cbd905a5be2f30307018238f5d813b3aea2a976e10e0f920a5c0eca0214fbc22ac7a6c9925f2aba8f7965f822055292645", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92bcdb49f417df8b0db1736ebe51c72cd9a3c4b3f960613f1b219e8a13345b539fb3a5154d9596692fd2885b26e13d1c38acd00960a423737a38dbc02521c61e"} build_url:https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011128 build_url: 'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7374d04147a4f0e446c685c75ee8c9858c1f1da41c2f668198bbc54fae422ca5a6f4dc3699c58a0e05d629b41c4332f8aa2307e07cfa0b10046ad1f0cbc8fe1", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b4da810cec59a72306b07e95cf58e88611f14a6d84a89ca2d775e571a176406085b8da1e7f419f9191efb28a839258ca7e99226a29e4b4f38ae52b3f25e1492", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5475c9044c9b9f521d3c5cbb830d4cbd905a5be2f30307018238f5d813b3aea2a976e10e0f920a5c0eca0214fbc22ac7a6c9925f2aba8f7965f822055292645", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92bcdb49f417df8b0db1736ebe51c72cd9a3c4b3f960613f1b219e8a13345b539fb3a5154d9596692fd2885b26e13d1c38acd00960a423737a38dbc02521c61e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-10 11:27:11.835474) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:27:11.835894) ========= 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=d2a8c569965ab8367867b893000001a1-1505055849.854095-1908652619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:27:11.915527) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-10 11:27:11.915855) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-10 11:27:11.916214) ========= ========= Total master_lag: 0.24 =========