builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-078 starttime: 1506077584.32 results: success (0) revision: 5a63d8457a2a69a2ad54a50765bff412580df2a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:04.318900) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:04.319495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:04.321801) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:04.396060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:04.396360) ========= 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=dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-22 03:53:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.7M=0s 2017-09-22 03:53:04 (41.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155136 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:04.594166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:04.594537) ========= 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=dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021207 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:04.661245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:04.661541) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5a63d8457a2a69a2ad54a50765bff412580df2a4 --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 5a63d8457a2a69a2ad54a50765bff412580df2a4 --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=dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-22 03:53:04,702 truncating revision to first 12 chars 2017-09-22 03:53:04,702 Setting DEBUG logging. 2017-09-22 03:53:04,702 attempt 1/10 2017-09-22 03:53:04,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5a63d8457a2a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-22 03:53:05,094 unpacking tar archive at: mozilla-central-5a63d8457a2a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.700121 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:05.408433) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:05.412805) ========= script_repo_revision: 5a63d8457a2a69a2ad54a50765bff412580df2a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:05.413208) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:05.413466) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 03:53:05.435673) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-22 03:53:05.435966) ========= /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=dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:53:05 INFO - MultiFileLogger online at 20170922 03:53:05 in /builds/slave/test 03:53:05 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 03:53:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:53:05 INFO - {'append_to_log': False, 03:53:05 INFO - 'base_work_dir': '/builds/slave/test', 03:53:05 INFO - 'blob_upload_branch': 'Firefox', 03:53:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:53:05 INFO - 'branch': 'Firefox', 03:53:05 INFO - 'buildbot_json_path': 'buildprops.json', 03:53:05 INFO - 'code_coverage': False, 03:53:05 INFO - 'config_files': ('talos/linux_config.py',), 03:53:05 INFO - 'default_actions': ('clobber', 03:53:05 INFO - 'read-buildbot-config', 03:53:05 INFO - 'download-and-extract', 03:53:05 INFO - 'populate-webroot', 03:53:05 INFO - 'create-virtualenv', 03:53:05 INFO - 'install', 03:53:05 INFO - 'setup-mitmproxy', 03:53:05 INFO - 'run-tests'), 03:53:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:53:05 INFO - 'disable_ccov_upload': False, 03:53:05 INFO - 'disable_stylo': False, 03:53:05 INFO - 'download_minidump_stackwalk': True, 03:53:05 INFO - 'download_symbols': 'ondemand', 03:53:05 INFO - 'enable_stylo': False, 03:53:05 INFO - 'enable_webrender': False, 03:53:05 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:53:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:53:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:53:05 INFO - 'gecko_profile': False, 03:53:05 INFO - 'gecko_profile_interval': 0, 03:53:05 INFO - 'installer_path': 'installer.exe', 03:53:05 INFO - 'log_level': 'info', 03:53:05 INFO - 'log_name': 'talos', 03:53:05 INFO - 'log_to_console': True, 03:53:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:53:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:53:05 INFO - 'opt_config_files': (), 03:53:05 INFO - 'pip_index': False, 03:53:05 INFO - 'suite': 'dromaeojs-e10s', 03:53:05 INFO - 'system_bits': '32', 03:53:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:53:05 INFO - 'title': 'talos-linux64-ix-078', 03:53:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:53:05 INFO - 'use_talos_json': True, 03:53:05 INFO - 'verify': 'False', 03:53:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:53:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:53:05 INFO - 'work_dir': 'build'} 03:53:05 INFO - [mozharness: 2017-09-22 10:53:05.603799Z] Running clobber step. 03:53:05 INFO - Running pre-action listener: _resource_record_pre_action 03:53:05 INFO - Running main action method: clobber 03:53:05 INFO - rmtree: /builds/slave/test/build 03:53:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:53:07 INFO - Running post-action listener: _resource_record_post_action 03:53:07 INFO - [mozharness: 2017-09-22 10:53:07.108522Z] Finished clobber step (success) 03:53:07 INFO - [mozharness: 2017-09-22 10:53:07.108620Z] Running read-buildbot-config step. 03:53:07 INFO - Running pre-action listener: _resource_record_pre_action 03:53:07 INFO - Running main action method: read_buildbot_config 03:53:07 INFO - Using buildbot properties: 03:53:07 INFO - { 03:53:07 INFO - "project": "", 03:53:07 INFO - "product": "firefox", 03:53:07 INFO - "who": "archaeopteryx@coole-files.de", 03:53:07 INFO - "installer_path": "public/build/target.tar.bz2", 03:53:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:53:07 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:53:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:53:07 INFO - "stage_platform": "linux64-pgo", 03:53:07 INFO - "basedir": "/builds/slave/test", 03:53:07 INFO - "buildnumber": 194, 03:53:07 INFO - "platform": "ubuntu64_hw", 03:53:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:53:07 INFO - "slavebuilddir": "test", 03:53:07 INFO - "taskId": "JZCbe369TvawD_HxfGMxoA", 03:53:07 INFO - "branch": "mozilla-central", 03:53:07 INFO - "script_repo_revision": "production", 03:53:07 INFO - "revision": "5a63d8457a2a69a2ad54a50765bff412580df2a4", 03:53:07 INFO - "slavename": "talos-linux64-ix-078", 03:53:07 INFO - "repo_path": "mozilla-central" 03:53:07 INFO - } 03:53:07 INFO - Finding installer, test and symbols from parent task. 03:53:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JZCbe369TvawD_HxfGMxoA'}, attempt #1 03:53:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JZCbe369TvawD_HxfGMxoA'}, attempt #1 03:53:07 INFO - Task dependencies: cWOTIN89SmKdG6xcx1MJ8w 03:53:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w'}, attempt #1 03:53:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.tar.bz2 03:53:08 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.test_packages.json 03:53:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.crashreporter-symbols.zip 03:53:08 INFO - Running post-action listener: _resource_record_post_action 03:53:08 INFO - [mozharness: 2017-09-22 10:53:08.444734Z] Finished read-buildbot-config step (success) 03:53:08 INFO - [mozharness: 2017-09-22 10:53:08.444951Z] Running download-and-extract step. 03:53:08 INFO - Running pre-action listener: _resource_record_pre_action 03:53:08 INFO - Running main action method: download_and_extract 03:53:08 INFO - mkdir: /builds/slave/test/build/tests 03:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:08 INFO - trying https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.test_packages.json 03:53:08 INFO - Downloading https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:53:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:53:08 INFO - Downloaded 989 bytes. 03:53:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:53:08 INFO - Using the following test package requirements: 03:53:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:53:08 INFO - u'common': [u'target.common.tests.zip'], 03:53:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:53:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:53:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:53:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:53:08 INFO - u'mozbase': [u'target.common.tests.zip'], 03:53:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:53:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:53:08 INFO - u'web-platform': [u'target.common.tests.zip', 03:53:08 INFO - u'target.web-platform.tests.tar.gz'], 03:53:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:53:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:53:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.common.tests.zip 03:53:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:53:08 INFO - Fetch https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.common.tests.zip into memory 03:53:11 INFO - Content-Length response header: 55273060 03:53:11 INFO - Bytes received: 55273060 03:53:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.talos.tests.zip 03:53:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:53:21 INFO - Fetch https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.talos.tests.zip into memory 03:53:23 INFO - Content-Length response header: 14513414 03:53:23 INFO - Bytes received: 14513414 03:53:23 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')]} 03:53:23 INFO - trying https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.tar.bz2 03:53:23 INFO - Downloading https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:53:26 INFO - Downloaded 62145791 bytes. 03:53:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.tar.bz2 03:53:26 INFO - mkdir: /builds/slave/test/properties 03:53:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:53:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:53:26 INFO - Contents: 03:53:26 INFO - build_url:https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.tar.bz2 03:53:26 INFO - Running post-action listener: _resource_record_post_action 03:53:26 INFO - Running post-action listener: find_tests_for_verification 03:53:26 INFO - Running post-action listener: set_extra_try_arguments 03:53:26 INFO - [mozharness: 2017-09-22 10:53:26.356603Z] Finished download-and-extract step (success) 03:53:26 INFO - [mozharness: 2017-09-22 10:53:26.356704Z] Running populate-webroot step. 03:53:26 INFO - Running pre-action listener: _resource_record_pre_action 03:53:26 INFO - Running main action method: populate_webroot 03:53:26 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:53:26 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['tresize', 03:53:26 INFO - 'tcanvasmark']}, 03:53:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:53:26 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['dromaeo_css', 03:53:26 INFO - 'kraken']}, 03:53:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:26 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'tests': ['damp', 'tps']}, 03:53:26 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['damp', 'tps']}, 03:53:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:53:26 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['dromaeo_dom']}, 03:53:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:53:26 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['basic_compositor_video', 03:53:26 INFO - 'glvideo']}, 03:53:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:53:26 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['ts_paint_webext', 03:53:26 INFO - 'tp5o_webext']}, 03:53:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:53:26 INFO - 'ts_paint', 03:53:26 INFO - 'tpaint', 03:53:26 INFO - 'sessionrestore', 03:53:26 INFO - 'sessionrestore_many_windows', 03:53:26 INFO - 'sessionrestore_no_auto_restore', 03:53:26 INFO - 'tabpaint']}, 03:53:26 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['a11yr', 03:53:26 INFO - 'ts_paint', 03:53:26 INFO - 'tpaint', 03:53:26 INFO - 'sessionrestore', 03:53:26 INFO - 'sessionrestore_many_windows', 03:53:26 INFO - 'sessionrestore_no_auto_restore', 03:53:26 INFO - 'tabpaint']}, 03:53:26 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:53:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:53:26 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['perf_reftest_singletons']}, 03:53:26 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['perf_reftest']}, 03:53:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:53:26 INFO - 'tsvgr_opacity', 03:53:26 INFO - 'tart', 03:53:26 INFO - 'tscrollx', 03:53:26 INFO - 'tsvg_static']}, 03:53:26 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['tsvgx', 03:53:26 INFO - 'tsvgr_opacity', 03:53:26 INFO - 'tart', 03:53:26 INFO - 'tscrollx', 03:53:26 INFO - 'tsvg_static']}, 03:53:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:53:26 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['tp5o']}, 03:53:26 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:53:26 INFO - 'talos_options': ['--mitmproxy', 03:53:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:53:26 INFO - '--firstNonBlankPaint'], 03:53:26 INFO - 'tests': ['tp6_google', 03:53:26 INFO - 'tp6_youtube', 03:53:26 INFO - 'tp6_amazon', 03:53:26 INFO - 'tp6_facebook']}, 03:53:26 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:53:26 INFO - 'talos_options': ['--disable-stylo', 03:53:26 INFO - '--mitmproxy', 03:53:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:53:26 INFO - '--firstNonBlankPaint'], 03:53:26 INFO - 'tests': ['tp6_google', 03:53:26 INFO - 'tp6_youtube', 03:53:26 INFO - 'tp6_amazon', 03:53:26 INFO - 'tp6_facebook']}, 03:53:26 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:53:26 INFO - 'talos_options': ['--stylo-threads=1', 03:53:26 INFO - '--mitmproxy', 03:53:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:53:26 INFO - '--firstNonBlankPaint'], 03:53:26 INFO - 'tests': ['tp6_google', 03:53:26 INFO - 'tp6_youtube', 03:53:26 INFO - 'tp6_amazon', 03:53:26 INFO - 'tp6_facebook']}, 03:53:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'talos_options': ['--xperf_path', 03:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:26 INFO - 'tests': ['tp5n']}, 03:53:26 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'talos_options': ['--disable-stylo', 03:53:26 INFO - '--xperf_path', 03:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:26 INFO - 'tests': ['tp5n']}}} 03:53:26 INFO - Running post-action listener: _resource_record_post_action 03:53:26 INFO - [mozharness: 2017-09-22 10:53:26.371745Z] Finished populate-webroot step (success) 03:53:26 INFO - [mozharness: 2017-09-22 10:53:26.371834Z] Running create-virtualenv step. 03:53:26 INFO - Running pre-action listener: _resource_record_pre_action 03:53:26 INFO - Running main action method: create_virtualenv 03:53:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:53:26 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:53:26 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:53:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:53:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:53:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:53:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:53:27 INFO - Installing pip...............done. 03:53:27 INFO - Return code: 0 03:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:53:27 INFO - Reading from file tmpfile_stdout 03:53:27 INFO - Output received: 03:53:27 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:53:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:53: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')]} 03:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53: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')]} 03:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2583a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587090>, '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 0x2587d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581f90>, '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': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', '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 03:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:53:27 INFO - Using env: {'DISPLAY': ':0', 03:53:27 INFO - 'HOME': '/home/cltbld', 03:53:27 INFO - 'LANG': 'en_US.UTF-8', 03:53:27 INFO - 'LANGUAGE': 'en_US:en', 03:53:27 INFO - 'LOGNAME': 'cltbld', 03:53:27 INFO - 'MAIL': '/var/mail/cltbld', 03:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:27 INFO - 'MOZ_NO_REMOTE': '1', 03:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:27 INFO - 'NO_EM_RESTART': '1', 03:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:27 INFO - 'PWD': '/builds/slave/test', 03:53:27 INFO - 'SHELL': '/bin/bash', 03:53:27 INFO - 'SHLVL': '1', 03:53:27 INFO - 'TERM': 'linux', 03:53:27 INFO - 'TMOUT': '86400', 03:53:27 INFO - 'USER': 'cltbld', 03:53:27 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', 03:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:27 INFO - '_': '/tools/buildbot/bin/python'} 03:53:28 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:53:28 INFO - Downloading/unpacking pip>=1.5 03:53:28 INFO - Running setup.py egg_info for package pip 03:53:28 INFO - warning: no files found matching 'pip/cacert.pem' 03:53:28 INFO - warning: no files found matching '*.html' under directory 'docs' 03:53:28 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:53:28 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:53:28 INFO - Installing collected packages: pip 03:53:28 INFO - Found existing installation: pip 1.1 03:53:28 INFO - Uninstalling pip: 03:53:28 INFO - Successfully uninstalled pip 03:53:28 INFO - Running setup.py install for pip 03:53:28 INFO - warning: no files found matching 'pip/cacert.pem' 03:53:28 INFO - warning: no files found matching '*.html' under directory 'docs' 03:53:28 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:53:28 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:53:28 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:53:28 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:53:28 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:53:28 INFO - Successfully installed pip 03:53:28 INFO - Cleaning up... 03:53:28 INFO - Return code: 0 03:53:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:28 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 0x22171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2583a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587090>, '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 0x2587d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581f90>, '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': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', '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 03:53:28 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 03:53:28 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 03:53:28 INFO - Using env: {'DISPLAY': ':0', 03:53:28 INFO - 'HOME': '/home/cltbld', 03:53:28 INFO - 'LANG': 'en_US.UTF-8', 03:53:28 INFO - 'LANGUAGE': 'en_US:en', 03:53:28 INFO - 'LOGNAME': 'cltbld', 03:53:28 INFO - 'MAIL': '/var/mail/cltbld', 03:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:28 INFO - 'MOZ_NO_REMOTE': '1', 03:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:28 INFO - 'NO_EM_RESTART': '1', 03:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:28 INFO - 'PWD': '/builds/slave/test', 03:53:28 INFO - 'SHELL': '/bin/bash', 03:53:28 INFO - 'SHLVL': '1', 03:53:28 INFO - 'TERM': 'linux', 03:53:28 INFO - 'TMOUT': '86400', 03:53:28 INFO - 'USER': 'cltbld', 03:53:28 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', 03:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:28 INFO - '_': '/tools/buildbot/bin/python'} 03:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:28 INFO - Downloading/unpacking psutil>=3.1.1 03:53:28 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 03:53:28 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 03:53:28 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 03:53:28 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 03:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:53:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:30 INFO - Installing collected packages: psutil 03:53:30 INFO - Running setup.py install for psutil 03:53:30 INFO - building 'psutil._psutil_linux' extension 03:53:30 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 03:53:30 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 03:53:30 INFO - building 'psutil._psutil_posix' extension 03:53:30 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 03:53:30 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 03:53:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:30 INFO - Successfully installed psutil 03:53:30 INFO - Cleaning up... 03:53:31 INFO - Return code: 0 03:53:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:53:32 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')]} 03:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:32 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')]} 03:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:32 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 0x22171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2583a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587090>, '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 0x2587d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581f90>, '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': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', '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 03:53:32 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 03:53:32 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 03:53:32 INFO - Using env: {'DISPLAY': ':0', 03:53:32 INFO - 'HOME': '/home/cltbld', 03:53:32 INFO - 'LANG': 'en_US.UTF-8', 03:53:32 INFO - 'LANGUAGE': 'en_US:en', 03:53:32 INFO - 'LOGNAME': 'cltbld', 03:53:32 INFO - 'MAIL': '/var/mail/cltbld', 03:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:32 INFO - 'MOZ_NO_REMOTE': '1', 03:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:32 INFO - 'NO_EM_RESTART': '1', 03:53:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:32 INFO - 'PWD': '/builds/slave/test', 03:53:32 INFO - 'SHELL': '/bin/bash', 03:53:32 INFO - 'SHLVL': '1', 03:53:32 INFO - 'TERM': 'linux', 03:53:32 INFO - 'TMOUT': '86400', 03:53:32 INFO - 'USER': 'cltbld', 03:53:32 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', 03:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:32 INFO - '_': '/tools/buildbot/bin/python'} 03:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:53:32 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 03:53:32 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 03:53:32 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 03:53:32 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 03:53:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:53:33 INFO - Installing collected packages: mozsystemmonitor 03:53:33 INFO - Running setup.py install for mozsystemmonitor 03:53:33 INFO - Successfully installed mozsystemmonitor 03:53:33 INFO - Cleaning up... 03:53:33 INFO - Return code: 0 03:53:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:53:33 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')]} 03:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:33 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')]} 03:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:33 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 0x22171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2583a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587090>, '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 0x2587d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581f90>, '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': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', '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 03:53:33 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 03:53:33 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 03:53:33 INFO - Using env: {'DISPLAY': ':0', 03:53:33 INFO - 'HOME': '/home/cltbld', 03:53:33 INFO - 'LANG': 'en_US.UTF-8', 03:53:33 INFO - 'LANGUAGE': 'en_US:en', 03:53:33 INFO - 'LOGNAME': 'cltbld', 03:53:33 INFO - 'MAIL': '/var/mail/cltbld', 03:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:33 INFO - 'MOZ_NO_REMOTE': '1', 03:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:33 INFO - 'NO_EM_RESTART': '1', 03:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:33 INFO - 'PWD': '/builds/slave/test', 03:53:33 INFO - 'SHELL': '/bin/bash', 03:53:33 INFO - 'SHLVL': '1', 03:53:33 INFO - 'TERM': 'linux', 03:53:33 INFO - 'TMOUT': '86400', 03:53:33 INFO - 'USER': 'cltbld', 03:53:33 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', 03:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:33 INFO - '_': '/tools/buildbot/bin/python'} 03:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:33 INFO - Downloading/unpacking jsonschema==2.5.1 03:53:33 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 03:53:33 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 03:53:33 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 03:53:33 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 03:53:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:53:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:53:34 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 03:53:34 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 03:53:34 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 03:53:34 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 03:53:34 INFO - Downloading functools32-3.2.3-2.tar.gz 03:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:53:35 INFO - warning: no files found matching '*.txt' 03:53:35 INFO - no previously-included directories found matching 'build' 03:53:35 INFO - no previously-included directories found matching 'dist' 03:53:35 INFO - no previously-included directories found matching '.git*' 03:53:35 INFO - Installing collected packages: jsonschema, functools32 03:53:35 INFO - Running setup.py install for functools32 03:53:35 INFO - warning: no files found matching '*.txt' 03:53:35 INFO - no previously-included directories found matching 'build' 03:53:35 INFO - no previously-included directories found matching 'dist' 03:53:35 INFO - no previously-included directories found matching '.git*' 03:53:35 INFO - Successfully installed jsonschema functools32 03:53:35 INFO - Cleaning up... 03:53:35 INFO - Return code: 0 03:53:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:53:35 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')]} 03:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:35 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')]} 03:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:35 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 0x22171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2583a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587090>, '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 0x2587d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581f90>, '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': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', '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 03:53:35 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 03:53:35 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 03:53:35 INFO - Using env: {'DISPLAY': ':0', 03:53:35 INFO - 'HOME': '/home/cltbld', 03:53:35 INFO - 'LANG': 'en_US.UTF-8', 03:53:35 INFO - 'LANGUAGE': 'en_US:en', 03:53:35 INFO - 'LOGNAME': 'cltbld', 03:53:35 INFO - 'MAIL': '/var/mail/cltbld', 03:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:35 INFO - 'MOZ_NO_REMOTE': '1', 03:53:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:35 INFO - 'NO_EM_RESTART': '1', 03:53:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:35 INFO - 'PWD': '/builds/slave/test', 03:53:35 INFO - 'SHELL': '/bin/bash', 03:53:35 INFO - 'SHLVL': '1', 03:53:35 INFO - 'TERM': 'linux', 03:53:35 INFO - 'TMOUT': '86400', 03:53:35 INFO - 'USER': 'cltbld', 03:53:35 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', 03:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:35 INFO - '_': '/tools/buildbot/bin/python'} 03:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:53:35 INFO - Cleaning up... 03:53:35 INFO - Return code: 0 03:53:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:53:35 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')]} 03:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:35 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')]} 03:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:35 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 0x22171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2583a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587090>, '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 0x2587d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581f90>, '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': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', '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 03:53:35 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 03:53:35 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 03:53:35 INFO - Using env: {'DISPLAY': ':0', 03:53:35 INFO - 'HOME': '/home/cltbld', 03:53:35 INFO - 'LANG': 'en_US.UTF-8', 03:53:35 INFO - 'LANGUAGE': 'en_US:en', 03:53:35 INFO - 'LOGNAME': 'cltbld', 03:53:35 INFO - 'MAIL': '/var/mail/cltbld', 03:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:35 INFO - 'MOZ_NO_REMOTE': '1', 03:53:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:35 INFO - 'NO_EM_RESTART': '1', 03:53:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:35 INFO - 'PWD': '/builds/slave/test', 03:53:35 INFO - 'SHELL': '/bin/bash', 03:53:35 INFO - 'SHLVL': '1', 03:53:35 INFO - 'TERM': 'linux', 03:53:35 INFO - 'TMOUT': '86400', 03:53:35 INFO - 'USER': 'cltbld', 03:53:35 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', 03:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:35 INFO - '_': '/tools/buildbot/bin/python'} 03:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:35 INFO - Downloading/unpacking blobuploader==1.2.4 03:53:35 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 03:53:35 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 03:53:35 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 03:53:35 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 03:53:36 INFO - Downloading blobuploader-1.2.4.tar.gz 03:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:53:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:53:37 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 03:53:37 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 03:53:37 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 03:53:37 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 03:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:53:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:53:37 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 03:53:37 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 03:53:37 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 03:53:37 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 03:53:37 INFO - Downloading docopt-0.6.1.tar.gz 03:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:53:37 INFO - Installing collected packages: blobuploader, requests, docopt 03:53:37 INFO - Running setup.py install for blobuploader 03:53:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:53:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:53:37 INFO - Running setup.py install for requests 03:53:38 INFO - Running setup.py install for docopt 03:53:38 INFO - Successfully installed blobuploader requests docopt 03:53:38 INFO - Cleaning up... 03:53:38 INFO - Return code: 0 03:53:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:38 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')]} 03:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:38 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')]} 03:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:38 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 0x22171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2583a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587090>, '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 0x2587d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581f90>, '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': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', '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 03:53:38 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 03:53:38 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 03:53:38 INFO - Using env: {'DISPLAY': ':0', 03:53:38 INFO - 'HOME': '/home/cltbld', 03:53:38 INFO - 'LANG': 'en_US.UTF-8', 03:53:38 INFO - 'LANGUAGE': 'en_US:en', 03:53:38 INFO - 'LOGNAME': 'cltbld', 03:53:38 INFO - 'MAIL': '/var/mail/cltbld', 03:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:38 INFO - 'MOZ_NO_REMOTE': '1', 03:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:38 INFO - 'NO_EM_RESTART': '1', 03:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:38 INFO - 'PWD': '/builds/slave/test', 03:53:38 INFO - 'SHELL': '/bin/bash', 03:53:38 INFO - 'SHLVL': '1', 03:53:38 INFO - 'TERM': 'linux', 03:53:38 INFO - 'TMOUT': '86400', 03:53:38 INFO - 'USER': 'cltbld', 03:53:38 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', 03:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:38 INFO - '_': '/tools/buildbot/bin/python'} 03:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:53:38 INFO - Running setup.py (path:/tmp/pip-cYZmza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:53:38 INFO - Running setup.py (path:/tmp/pip-Fyz3sD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:53:38 INFO - Running setup.py (path:/tmp/pip-KrzGUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:53:38 INFO - Running setup.py (path:/tmp/pip-5r97u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:53:38 INFO - Running setup.py (path:/tmp/pip-e6d2iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:53:38 INFO - Running setup.py (path:/tmp/pip-DyEc5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:53:38 INFO - Running setup.py (path:/tmp/pip-P830Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:53:38 INFO - Running setup.py (path:/tmp/pip-YJxoaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:53:38 INFO - Running setup.py (path:/tmp/pip-jnywgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:53:39 INFO - Running setup.py (path:/tmp/pip-j9oYc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:53:39 INFO - Running setup.py (path:/tmp/pip-v5mER8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:53:39 INFO - Running setup.py (path:/tmp/pip-ZJCGXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:53:39 INFO - Running setup.py (path:/tmp/pip-dLmTWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:53:39 INFO - Running setup.py (path:/tmp/pip-OOhaYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:39 INFO - Running setup.py (path:/tmp/pip-D6Rnyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:53:39 INFO - Running setup.py (path:/tmp/pip-Nn2rYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:53:39 INFO - Running setup.py (path:/tmp/pip-dUwYtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:53:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:53:39 INFO - Running setup.py install for manifestparser 03:53:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:53:39 INFO - Running setup.py install for mozcrash 03:53:39 INFO - Running setup.py install for mozdebug 03:53:39 INFO - Running setup.py install for mozdevice 03:53:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Running setup.py install for mozfile 03:53:40 INFO - Running setup.py install for mozhttpd 03:53:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Running setup.py install for mozinfo 03:53:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Running setup.py install for mozInstall 03:53:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Running setup.py install for mozleak 03:53:40 INFO - Running setup.py install for mozlog 03:53:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Running setup.py install for moznetwork 03:53:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Running setup.py install for mozprocess 03:53:40 INFO - Running setup.py install for mozprofile 03:53:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Running setup.py install for mozrunner 03:53:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozscreenshot 03:53:41 INFO - Running setup.py install for moztest 03:53:41 INFO - Running setup.py install for mozversion 03:53:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:53:41 INFO - Cleaning up... 03:53:41 INFO - Return code: 0 03:53:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53: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')]} 03:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53: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')]} 03:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:41 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 0x22171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2583a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587090>, '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 0x2587d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581f90>, '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': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', '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 03:53:41 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 03:53:41 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 03:53:41 INFO - Using env: {'DISPLAY': ':0', 03:53:41 INFO - 'HOME': '/home/cltbld', 03:53:41 INFO - 'LANG': 'en_US.UTF-8', 03:53:41 INFO - 'LANGUAGE': 'en_US:en', 03:53:41 INFO - 'LOGNAME': 'cltbld', 03:53:41 INFO - 'MAIL': '/var/mail/cltbld', 03:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:41 INFO - 'MOZ_NO_REMOTE': '1', 03:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:41 INFO - 'NO_EM_RESTART': '1', 03:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:41 INFO - 'PWD': '/builds/slave/test', 03:53:41 INFO - 'SHELL': '/bin/bash', 03:53:41 INFO - 'SHLVL': '1', 03:53:41 INFO - 'TERM': 'linux', 03:53:41 INFO - 'TMOUT': '86400', 03:53:41 INFO - 'USER': 'cltbld', 03:53:41 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', 03:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:41 INFO - '_': '/tools/buildbot/bin/python'} 03:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:53:41 INFO - Running setup.py (path:/tmp/pip-2MpyIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:53:41 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)) 03:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:53:41 INFO - Running setup.py (path:/tmp/pip-nhwnYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:53:41 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)) 03:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:53:41 INFO - Running setup.py (path:/tmp/pip-CIoO7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:53:41 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)) 03:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:53:41 INFO - Running setup.py (path:/tmp/pip-emF63o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:53:41 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)) 03:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:53:41 INFO - Running setup.py (path:/tmp/pip-uale9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:53:41 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)) 03:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:53:41 INFO - Running setup.py (path:/tmp/pip-PCZGjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:53:42 INFO - Running setup.py (path:/tmp/pip-7hQ29n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:53:42 INFO - Running setup.py (path:/tmp/pip-ruFseD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:53:42 INFO - Running setup.py (path:/tmp/pip-BVECt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:53:42 INFO - Running setup.py (path:/tmp/pip-cv9erw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:53:42 INFO - Running setup.py (path:/tmp/pip-jCtURz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:53:42 INFO - Running setup.py (path:/tmp/pip-PcVk_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:53:42 INFO - Running setup.py (path:/tmp/pip-MJBv7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:53:42 INFO - Running setup.py (path:/tmp/pip-aP_Eh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:42 INFO - Running setup.py (path:/tmp/pip-J5sXdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:53:42 INFO - Running setup.py (path:/tmp/pip-WU1TWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:53:42 INFO - Running setup.py (path:/tmp/pip-RC2PyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:53:42 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)) 03:53:42 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)) 03:53:42 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)) 03:53:42 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)) 03:53:42 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)) 03:53:42 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)) 03:53:42 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)) 03:53:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:53:42 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 03:53:42 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 03:53:42 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 03:53:42 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 03:53:43 INFO - Downloading blessings-1.6.tar.gz 03:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:53:44 INFO - Installing collected packages: blessings 03:53:44 INFO - Running setup.py install for blessings 03:53:44 INFO - Successfully installed blessings 03:53:44 INFO - Cleaning up... 03:53:44 INFO - Return code: 0 03:53:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:53:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:44 INFO - Reading from file tmpfile_stdout 03:53:44 INFO - Current package versions: 03:53:44 INFO - argparse == 1.2.1 03:53:44 INFO - blessings == 1.6 03:53:44 INFO - blobuploader == 1.2.4 03:53:44 INFO - docopt == 0.6.1 03:53:44 INFO - functools32 == 3.2.3-2 03:53:44 INFO - jsonschema == 2.5.1 03:53:44 INFO - manifestparser == 1.1 03:53:44 INFO - mozInstall == 1.13 03:53:44 INFO - mozcrash == 1.0 03:53:44 INFO - mozdebug == 0.1 03:53:44 INFO - mozdevice == 0.51 03:53:44 INFO - mozfile == 1.2 03:53:44 INFO - mozhttpd == 0.7 03:53:44 INFO - mozinfo == 0.10 03:53:44 INFO - mozleak == 0.1 03:53:44 INFO - mozlog == 3.5 03:53:44 INFO - moznetwork == 0.27 03:53:44 INFO - mozprocess == 0.25 03:53:44 INFO - mozprofile == 0.28 03:53:44 INFO - mozrunner == 6.13 03:53:44 INFO - mozscreenshot == 0.1 03:53:44 INFO - mozsystemmonitor == 0.3 03:53:44 INFO - moztest == 0.8 03:53:44 INFO - mozversion == 1.4 03:53:44 INFO - psutil == 3.1.1 03:53:44 INFO - requests == 1.2.3 03:53:44 INFO - wsgiref == 0.1.2 03:53:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53: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')]} 03:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53: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')]} 03:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:44 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 0x22171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2583a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587090>, '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 0x2587d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581f90>, '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': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', '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 03:53:44 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 03:53:44 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 03:53:44 INFO - Using env: {'DISPLAY': ':0', 03:53:44 INFO - 'HOME': '/home/cltbld', 03:53:44 INFO - 'LANG': 'en_US.UTF-8', 03:53:44 INFO - 'LANGUAGE': 'en_US:en', 03:53:44 INFO - 'LOGNAME': 'cltbld', 03:53:44 INFO - 'MAIL': '/var/mail/cltbld', 03:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:44 INFO - 'MOZ_NO_REMOTE': '1', 03:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:44 INFO - 'NO_EM_RESTART': '1', 03:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:44 INFO - 'PWD': '/builds/slave/test', 03:53:44 INFO - 'SHELL': '/bin/bash', 03:53:44 INFO - 'SHLVL': '1', 03:53:44 INFO - 'TERM': 'linux', 03:53:44 INFO - 'TMOUT': '86400', 03:53:44 INFO - 'USER': 'cltbld', 03:53:44 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', 03:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:44 INFO - '_': '/tools/buildbot/bin/python'} 03:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:44 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)) 03:53:44 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)) 03:53:44 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)) 03:53:44 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)) 03:53:44 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)) 03:53:44 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)) 03:53:44 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)) 03:53:44 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)) 03:53:44 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)) 03:53:44 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:53:44 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 03:53:44 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 03:53:44 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 03:53:44 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 03:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:53:45 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)) 03:53:45 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)) 03:53:45 INFO - Installing collected packages: simplejson 03:53:45 INFO - Running setup.py install for simplejson 03:53:45 INFO - building 'simplejson._speedups' extension 03:53:45 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 03:53:46 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 03:53:46 INFO - Successfully installed simplejson 03:53:46 INFO - Cleaning up... 03:53:46 INFO - Return code: 0 03:53:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:53: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')]} 03:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53: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')]} 03:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2583a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587090>, '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 0x2587d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581f90>, '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': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', '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 03:53: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', 'jsonschema'] in /builds/slave/test/build 03:53: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 jsonschema 03:53:46 INFO - Using env: {'DISPLAY': ':0', 03:53:46 INFO - 'HOME': '/home/cltbld', 03:53:46 INFO - 'LANG': 'en_US.UTF-8', 03:53:46 INFO - 'LANGUAGE': 'en_US:en', 03:53:46 INFO - 'LOGNAME': 'cltbld', 03:53:46 INFO - 'MAIL': '/var/mail/cltbld', 03:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:46 INFO - 'MOZ_NO_REMOTE': '1', 03:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:46 INFO - 'NO_EM_RESTART': '1', 03:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:46 INFO - 'PWD': '/builds/slave/test', 03:53:46 INFO - 'SHELL': '/bin/bash', 03:53:46 INFO - 'SHLVL': '1', 03:53:46 INFO - 'TERM': 'linux', 03:53:46 INFO - 'TMOUT': '86400', 03:53:46 INFO - 'USER': 'cltbld', 03:53:46 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', 03:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:46 INFO - '_': '/tools/buildbot/bin/python'} 03:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:53:47 INFO - Cleaning up... 03:53:47 INFO - Return code: 0 03:53:47 INFO - Running post-action listener: _resource_record_post_action 03:53:47 INFO - Running post-action listener: _start_resource_monitoring 03:53:47 INFO - Starting resource monitoring. 03:53:47 INFO - [mozharness: 2017-09-22 10:53:47.106437Z] Finished create-virtualenv step (success) 03:53:47 INFO - [mozharness: 2017-09-22 10:53:47.106952Z] Running install step. 03:53:47 INFO - Running pre-action listener: _resource_record_pre_action 03:53:47 INFO - Running main action method: install 03:53:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:47 INFO - Reading from file tmpfile_stdout 03:53:47 INFO - Detecting whether we're running mozinstall >=1.0... 03:53:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:53:47 INFO - Reading from file tmpfile_stdout 03:53:47 INFO - Output received: 03:53:47 INFO - Usage: mozinstall [options] installer 03:53:47 INFO - Options: 03:53:47 INFO - -h, --help show this help message and exit 03:53:47 INFO - -d DEST, --destination=DEST 03:53:47 INFO - Directory to install application into. [default: 03:53:47 INFO - "/builds/slave/test"] 03:53:47 INFO - --app=APP Application being installed. [default: firefox] 03:53:47 INFO - mkdir: /builds/slave/test/build/application 03:53:47 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'] 03:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:54:05 INFO - Reading from file tmpfile_stdout 03:54:05 INFO - Output received: 03:54:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:54:05 INFO - Running post-action listener: _resource_record_post_action 03:54:05 INFO - [mozharness: 2017-09-22 10:54:05.084086Z] Finished install step (success) 03:54:05 INFO - [mozharness: 2017-09-22 10:54:05.084230Z] Running setup-mitmproxy step. 03:54:05 INFO - Running pre-action listener: _resource_record_pre_action 03:54:05 INFO - Running main action method: setup_mitmproxy 03:54:05 INFO - Skipping: mitmproxy is not required 03:54:05 INFO - Running post-action listener: _resource_record_post_action 03:54:05 INFO - [mozharness: 2017-09-22 10:54:05.084758Z] Finished setup-mitmproxy step (success) 03:54:05 INFO - [mozharness: 2017-09-22 10:54:05.084860Z] Running run-tests step. 03:54:05 INFO - Running pre-action listener: _resource_record_pre_action 03:54:05 INFO - Running pre-action listener: _set_gcov_prefix 03:54:05 INFO - Running main action method: run_tests 03:54:05 WARNING - Try message not found. 03:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:54:05 INFO - Python 2.7.3 03:54:05 INFO - Return code: 0 03:54:05 INFO - grabbing minidump binary from tooltool 03:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:05 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 0x2587090>, '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 0x2587d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:54:05 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 03:54:05 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 03:54:05 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 03:54:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:54:05 INFO - Return code: 0 03:54:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:54:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:54:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:54:05 INFO - ENV: RUST_BACKTRACE is now full 03:54:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:54:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:54:05 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/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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 03:54:05 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/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-078 --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 03:54:05 INFO - Using env: {'DISPLAY': ':0', 03:54:05 INFO - 'HOME': '/home/cltbld', 03:54:05 INFO - 'LANG': 'en_US.UTF-8', 03:54:05 INFO - 'LANGUAGE': 'en_US:en', 03:54:05 INFO - 'LOGNAME': 'cltbld', 03:54:05 INFO - 'MAIL': '/var/mail/cltbld', 03:54:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:54:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:05 INFO - 'MOZ_NO_REMOTE': '1', 03:54:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:05 INFO - 'NO_EM_RESTART': '1', 03:54:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:05 INFO - 'PWD': '/builds/slave/test', 03:54:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:54:05 INFO - 'RUST_BACKTRACE': 'full', 03:54:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:54:05 INFO - 'SHELL': '/bin/bash', 03:54:05 INFO - 'SHLVL': '1', 03:54:05 INFO - 'TERM': 'linux', 03:54:05 INFO - 'TMOUT': '86400', 03:54:05 INFO - 'USER': 'cltbld', 03:54:05 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', 03:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:05 INFO - '_': '/tools/buildbot/bin/python'} 03:54:05 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/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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 03:54:05 INFO - mozversion application_buildid: 20170922092649 03:54:05 INFO - mozversion application_changeset: 5a63d8457a2a69a2ad54a50765bff412580df2a4 03:54:05 INFO - mozversion application_display_name: Nightly 03:54:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:54:05 INFO - mozversion application_name: Firefox 03:54:05 INFO - mozversion application_remotingname: firefox 03:54:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:54:05 INFO - mozversion application_vendor: Mozilla 03:54:05 INFO - mozversion application_version: 58.0a1 03:54:05 INFO - mozversion platform_buildid: 20170922092649 03:54:05 INFO - mozversion platform_changeset: 5a63d8457a2a69a2ad54a50765bff412580df2a4 03:54:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:54:05 INFO - mozversion platform_version: 58.0a1 03:54:05 INFO - using testdate: 1506077645 03:54:05 INFO - actual date: 1506077645 03:54:05 INFO - starting webserver on 'localhost:45426' 03:54:05 INFO - SUITE-START | Running 2 tests 03:54:05 INFO - TEST-START | dromaeo_css 03:54:05 INFO - Initialising browser for dromaeo_css test... 03:54:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45426/getInfo.html -profile /tmp/tmp9Vb_6a/profile 03:54:05 INFO - TEST-INFO | started process 12440 (/builds/slave/test/build/application/firefox/firefox http://localhost:45426/getInfo.html) 03:54:10 INFO - TEST-INFO | 12440: exit 0 03:54:10 INFO - Browser initialized. 03:54:10 INFO - Running cycle 1/1 for dromaeo_css test... 03:54:10 INFO - Using env: {'DISPLAY': ':0', 03:54:10 INFO - 'HOME': '/home/cltbld', 03:54:10 INFO - 'JSGC_DISABLE_POISONING': '1', 03:54:10 INFO - 'LANG': 'en_US.UTF-8', 03:54:10 INFO - 'LANGUAGE': 'en_US:en', 03:54:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:54:10 INFO - 'LOGNAME': 'cltbld', 03:54:10 INFO - 'MAIL': '/var/mail/cltbld', 03:54:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:54:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:54:10 INFO - 'MOZ_CRASHREPORTER': '1', 03:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:54:10 INFO - 'MOZ_NO_REMOTE': '1', 03:54:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:10 INFO - 'NO_EM_RESTART': '1', 03:54:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:10 INFO - 'PWD': '/builds/slave/test', 03:54:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:54:10 INFO - 'RUST_BACKTRACE': 'full', 03:54:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:54:10 INFO - 'SHELL': '/bin/bash', 03:54:10 INFO - 'SHLVL': '1', 03:54:10 INFO - 'TERM': 'linux', 03:54:10 INFO - 'TMOUT': '86400', 03:54:10 INFO - 'USER': 'cltbld', 03:54:10 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', 03:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:10 INFO - '_': '/tools/buildbot/bin/python'} 03:54:10 INFO - TEST-INFO | started process 12681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Vb_6a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:11 INFO - PID 12681 | 03:54:11 INFO - PID 12681 | (/builds/slave/test/build/application/firefox/firefox:12730): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:54:11 INFO - PID 12681 | 03:54:21 INFO - PID 12681 | RSS: Main: 147456000 03:54:21 INFO - PID 12681 | 03:57:19 INFO - PID 12681 | Cycle 1(1): loaded http://localhost:45426/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45426/tests/dromaeo/cssquery-ext.html) 03:57:20 INFO - PID 12681 | RSS: Main: 148840448 03:57:20 INFO - PID 12681 | 04:00:22 INFO - PID 12681 | Cycle 1(1): loaded http://localhost:45426/tests/dromaeo/cssquery-ext.html (next: http://localhost:45426/tests/dromaeo/cssquery-jquery.html) 04:00:23 INFO - PID 12681 | RSS: Main: 147931136 04:00:23 INFO - PID 12681 | 04:03:24 INFO - PID 12681 | Cycle 1(1): loaded http://localhost:45426/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45426/tests/dromaeo/cssquery-mootools.html) 04:03:25 INFO - PID 12681 | RSS: Main: 151035904 04:03:25 INFO - PID 12681 | 04:06:26 INFO - PID 12681 | Cycle 1(1): loaded http://localhost:45426/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45426/tests/dromaeo/cssquery-prototype.html) 04:06:27 INFO - PID 12681 | RSS: Main: 149712896 04:06:27 INFO - PID 12681 | 04:09:30 INFO - PID 12681 | Cycle 1(1): loaded http://localhost:45426/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45426/tests/dromaeo/cssquery-yui.html) 04:09:31 INFO - PID 12681 | RSS: Main: 150609920 04:09:31 INFO - PID 12681 | 04:12:32 INFO - PID 12681 | Cycle 1(1): loaded http://localhost:45426/tests/dromaeo/cssquery-yui.html (next: http://localhost:45426/tests/dromaeo/cssquery-dojo.html) 04:12:32 INFO - PID 12681 | RSS: Main: 153272320 04:12:32 INFO - PID 12681 | 04:12:32 INFO - PID 12681 | __start_tp_report 04:12:32 INFO - PID 12681 | _x_x_mozilla_page_load 04:12:32 INFO - PID 12681 | _x_x_mozilla_page_load_details 04:12:32 INFO - PID 12681 | |i|pagename|runs| 04:12:32 INFO - PID 12681 | |0;dojo.html;3872.341701910676;3873.8450461981524;3874.961250387495;3883.7669739815615;3891.1633998690277;6188.75244990201;6256.84357891053;6296.0555916612475;6298.275698294698;6388.872222555552;6212.627242365461;6215.720292586833;6216.937830621704;6234.875302493947;6334.208223972004;5618.662880227179;5638.971805140968;5648.491635752782;5668.178114173453;5678.772849086032;5638.069718496443;5639.971800141014;5737.856553586173;5737.942620573783;5762.4525670061275;5651.180578816069;5674.602777805555;5697.401772813857;5717.656940583557;5773.855653608652;5454.372747134051;5678.772849086032;5695.601307908448;5760.4527569881;5784.421557844203;5472.890542189134;5565.220869078333;5592.664440133605;5683.658980461186;5712.285964254468;6178.907316390258;6265.310815810257;6304.495640348761;6322.430981211667;6361.427471527539;6630.834229144261;6733.49498787588;6751.594904305757;6802.795916122524;6856.348646878539;6762.560433571802;6809.931900680979;6813.318668133147;6822.965885170592;6827.2490026097585;6302.9054564181115;6323.9051414228825;6334.144890439824;6384;6405.967970160119;6995.090638217;6996.650167491605;7086.787396378117;7087.2558381370245;7088;6648.368405001517;6648.5346025777735;6680.23177334603;6789.898151527731;6806.319368063253;6698.363655452724;6757.358050985247;6806.319368063253;6820.942753873158;6911.9308806912295;6724.327567243335;6725.39471447572;6741.393274605309;6742.056112144303;6777;6704.396604305636;6789.932100679029;6793.082933803972;6798.150231221098;6800.319968003259;4946.604271658259;4972.105021096165;5006.574441172541;5018.874528136826;5023.874403139951;4500.83505745699;4515.909681806345;4545.931811022837;4556.794944227518;4606.262997920317;6190.009598464224;6204.627722336584;6207.6275423473835;6209;6218.81343559694;6721.26066132725;6730.158730158731;6803.965980170166;6804.76183333581;6822.965885170543;6168.444839964424;6177.783777567854;6238.65687387189;6251.874962500725;6264.310925798159;5398.46015398457;5423.864403389947;5475.123980163235;5488;5509.035918714209;7059.6117213552725;7093.467989900778;7135.82160445993;7139.535930164523;7150.10623672041;6628.370304821035;6734.4275736560985;6814.454843612598;6824.18109826824;6826.112605361371;6878.55289406187;6980.267071957372;6999.440044796303;7005.859882802213;7103.9289607103265;6645.202575690948;6657.633830139195;6662.56693314933;6680;6684.532082754355;6744.156980377453;6765.86468270622;6815.69329380189;6869.725210991504;6912.654367281515;6538.705758240986;6551.344865513411;6616.2060552732055;6636.402723754885;6637.734490620321;6542.411182993363;6555.541112122296;6627.536072474881;6646.136002319668;6652.534322597372;6379.457746091634;6386.521010924293;6473.611583305017;6475.158229430144;6487.902681459687;6515.837104072436;6646.534742567974;6656.400923916871;6673.332666733288;6719.764808231688;6381.489480841615;6384.648844313608;6427.742890284337;6489;6493.512986525935 04:12:32 INFO - PID 12681 | |1;ext.html;928.6053427293401;948.677449667113;950.5864948747295;959.0888655777013;966.463612694954;44935.32597011043;46016.30975535361;46050.30924536135;46077;46094.53905460944;42249;42510;42621.573784262146;42733.78633106838;42832.357514637224;7695.538267703956;7859.410544209179;8571.571421428904;8679.69621063263;8739.825203495926;8519.488830670149;8637.870431943526;8644.265237454823;8645.178708022759;8656.350773691998;8649.567521623894;8673.306135509145;8675.869861952076;8708.782280443007;8720.38957272988;8576.828463430727;8649.394542382035;8675.783105422383;8686.695965641173;8690.261327787146;8616.052234254226;8675.349348798865;8675.739727808175;8678.218960293541;8678.826423471559;40501.39247911254;40875.7956210217;41134;41157.58842411597;41320.79339603313;3724.16206353571;3727.403615421547;3733.3466643337306;3740.663340299359;3767.6044015378266;33192.33615327704;33197.50203746946;33321.33357332864;33470.665293346996;33536.83231583826;5420.891582168335;5435.293411856473;5460.31746031746;5516.062269414209;5537.944620553783;217066.99999999843;217428;217931;217954;218600;49452.258216126786;50322.24516632254;53855.19217211745;53911.460885391425;54848.72575637176;58960.70519647374;59010.704946474994;59056.704716476146;59154;59291.407085928586;15506.612334691497;15585.298661560257;15586.454474093352;15606.45377411808;15635.749140068767;12273.202241854251;12285.385730713608;12311.876881231252;12321.507139714311;12415.503379864886;15585.298661560257;15779.68440631181;15848.76226856598;15923.920380398024;15940.36238550445;6006.969965150146;6032.125341825498;6089.421504957022;6143.815685529441;6178.876422471525;1091.5415525479318;1101.6419663609358;1103.442761405485;1106.8229083346625;1113.9610113645983;25152.874235628704;25603;25781.61327580088;25914.093006744675;26036.73963260381;1192.2325451572988;1194.486370860521;1202.2786328203183;1209.9274043557414;1215.440897187286;13477.865221347662;13497.595072147851;13655.522056727967;13674.658133546542;13906;265129;265447;265885;265923;266246;57511.42488575145;57517;57859.42140578625;57923.710381447825;57948;1514.1142431677592;1553.9456119035779;1572.2217502336189;1582.8021497312836;1585.7462805950993;25225.621615675413;25327.240182794547;25345.493090137727;25424.618630720182;25545.48909021772;37205;38814.223715526095;38957.610423896534;39137.80431097826;39386;224029;228406;231460;232485;233398;35897;38961.805190973864;39454.802725986185;39547.80226098851;39728.80135599303;48497.75751121363;49776.75111624419;50306;50331.24503132529;50638.2404263929;37108.62891371052;37149;37303.25393492169;37708;37846.62153378431;36502.26995460129;36564.63435365719;36895;37132;37150.44274335941;42803.78598107114;42818.57181428146;43457.34813977856;43662.34506482342;43722.781386092865;34946.82526587351;34985;35266;35488;36034.819825900704;26401.867990659925;26657.600135998364;26840.865795670896;26972.32569185786;27124.050658226868 04:12:32 INFO - PID 12681 | |2;jquery.html;601.1943995046637;605.9515238780898;610.9022556390978;619.5229673151671;626.8840264551059;23226.18708345208;23837.88081059592;23839.404014899636;23866.40333991651;23891.402714932112;24610.75389246107;26351.736482635217;26584.734152658515;26609.334766630844;26662.066827661034;6525.988471786881;6675.198976122872;6686.063951046857;6697;6698.732050717966;6511.413972742453;6605.405513503783;6845.657717114149;6850.349216824418;6855.2801955794675;6775.796726098225;6787.321267873198;6789.15135608049;6822.829429264259;6831.897521537181;6592.80221593353;6832.6925288362145;6832.93167068328;6837.3162683731725;6842.555233909805;6301.6534090625;6325.082862984841;6361.681915904186;6379.330170332141;6387.361263873622;28764.856175719196;29115.854420727974;29320.8533957331;29456.55815162774;29519.852400738073;2218.3455880515285;2266.8073213776847;2275.112706044644;2275.385645875621;2276;19278.421647350602;20348.69476957847;20573.8971305144;20588.176472941064;20637.690434643493;2274.8521346112616;2418.6734790803366;2422.780115256528;2483.1681386735286;2491.6511688363644;155734;159491.2025439877;159518;159771;160109;16019.919900400424;16047.117408542643;16471.83528164727;16474;16527.173641317888;25248.621270680953;25270;25272.24183274468;25305.114320998677;25387.492250155265;9847.212223022141;10011.349262297927;10141.49292535385;10156.949215253877;10243.539040743035;9228.953855230815;9273.953630231807;9298.95350523243;9317.813643727088;9340.906590934004;9717.319787614799;9758.658446954323;9803.558839852223;9940;9947.154491868128;2829.2643912582466;2857.5999360089604;2888.6678032026584;2933.6919623439658;2975.285931376454;1027.3476342522404;1031.9329243599143;1044.9529771160317;1048.8688913885765;1051.379685985257;20311.18755249803;20469.795302047085;20592.27927022547;20877.79122208789;20964.05661745225;1069.2087854987253;1089.9182561307935;1100.3452945497415;1119.2948442481186;1121.2039451989017;11221.158413119048;11264.718382040515;11297.54809807615;11415.714607134889;11549.787272336453;584557;590940;604915;608072;614732;121022;122027;123858.38070809588;124231;126347.36826315994;1250.3935591238424;1264.0835394339215;1277.7125146842072;1284.9229046257256;1290.9806352904714;18161.27354905842;18411.907940460213;18510.426613737982;18718.438446846616;18782.71825922585;60013.699931500065;61243;62537;62771.686141569;63018.684906575174;73723;78063.60968195123;78474.6076269615;78603.60698196472;78671.60664196643;14971.550853474413;15141.470048548688;15154.242287885781;15325.310361034004;15417.537473875802;22744.31767046991;22908.885455572614;22962.31113066611;23061.65407518922;23203.303900883002;18726.344577939708;19155.521111971753;19210.8078919209;19257.903710481358;19303.32438364707;16627.42039506245;16840.915795420944;17125.57186070358;17182.31270749156;17424.91287543554;19257.22971081141;19403.51491212731;19442;19533.70699439481;19544.511387215432;14888.404463821325;14960.476383326532;14976.925115374353;15015.849841501882;15054.32255548481;18671;18779;19007.42977710671;19015.42953711391;19054.618907621494 04:12:32 INFO - PID 12681 | |3;mootools.html;1419.51026895721;1448.8273771537977;1467.5964109869792;1470.8676219140282;1479.2751551739648;16619.16904154792;17247.396341128064;17267.481975540755;17292.221850016747;17307.22117504712;16750.916245418786;16962.236699348527;17075.573110672238;17103.144842757843;17118.657626847456;2839.4463079699467;2937.2656835791054;2938.456385568666;2938.5592161175887;2938.8236705797613;2871.382652729663;2879.784016198783;2917.620709307787;2919.474494590973;2920.4013177298602;2898.9565156522667;2935.222166125978;2971.3463038131576;2973.435047340998;2973.836438995854;2650.4301575161335;2732.508148533263;2733.45330933814;2812.226637674635;2816.7183281671873;2794.315392728774;2831.6460442444695;2848.9145325640266;2849.088291746642;2851.2871782054485;16711.66576668472;16718.832811671848;16853.41013064549;16880.07159606221;16894.49316520506;8119.944407227082;8141.1451797561585;8453.746387608382;8521.701740439055;8745.081766414562;5796.391378905197;5809.908432964129;5949.702514874239;5982.670953097578;6039;2072.3784412717923;2087.2068613926613;2119.057019626267;2134.7224860768156;2159.730033745782;31815.522767158513;32729.018129456155;32748.6725132748;32755.18112047194;32806.50790238148;7337.3029562191505;7454.552726836408;7468.5145465544565;7534.811629709191;7552.66013029415;19953.20187192496;20447.38657840267;20574.897125514275;20623.79376206219;20682.172713091608;8450.788730281793;8680.392372533988;8680.95659521711;8699.565021748887;8704;7821.765347039598;7936.206379362133;7978.361731061501;8031.638576264082;8100.311473524698;5563.276774019351;5774.162746401748;5779.595428319977;5795.304563452412;5839.562032847469;1663.96672066558;1706.3942300483398;1710.9572260693333;1730.956726081858;1738.1048759888668;972.6595691507915;973.4986481961795;975.7072878136672;1000.6447711062614;1002.2082554781641;8733.475991440533;8784.253338466175;8820.206181443573;8859.468431894107;8886.289096872235;782.9295363417206;786.8268980824209;795.7823535263198;799.400449662753;817.7383237364105;5686.2607860977805;5931.762729490858;6087.604305720114;6118.755249790048;6384.585001974857;23601.7639823603;24587.87706061458;24724.752752472246;25409.983600656138;25536.616950745753;24009.399765005666;24901.87549062243;25227;25373.746262537137;25598;12280.324582147889;12731.87268127307;12743.171693840057;12922.676933076747;12981.286029268482;9642.71071867845;9695.418274903528;9748.902510975084;9821.656242031495;9979.750506237402;21168.153273868873;21454.57090858143;21719.782802171776;22024.44938876541;22213.777862221817;22232.44418889476;22253.22113726012;22285.777142229017;22514.099436022374;22998.08007679741;12326.198797078161;12328.753424931272;12440.751184976069;12454.25274483534;12509.061820363691;15681.451149209723;15861.286242118902;15871.365145394517;15872.44446444369;15886.52340429789;12901;12910.289934053717;12911.677208069874;12982.805257921327;13018.80471792905;12195.146339756131;12773.680657983625;12805.935970320088;12848.807267890803;12896.548620798227;10225.488725563544;10251.948740256252;10294.588216471257;10310.845337319795;10355.741106472398;8401.53791541471;8419.70531031411;8534.658613655385;8590.398672092893;8628.5254311011;8232.300254478436;8319.334453243848;8368.24685778283;8510.234078932677;8516.957415212884 04:12:32 INFO - PID 12681 | |4;prototype.html;525.9605529585282;567.1606023085831;574.3481148896003;577.5091172503372;586.9618474799139;6368.172137622114;6381.361863813617;6393.424591786738;6419.293877673464;6434.646094464802;6218.657973811439;6229.4704950079185;6257.311695713479;6319.715612797424;6361.395667411589;4902.86725274505;5053.36832895888;5080.720560369178;5113;5155.407128180251;5025.949740502603;5052.343195384613;5055.216441451563;5080.7967681292885;5082.79668813247;4964.578010869081;4969.155243608595;4981.651284410093;5040.5967522598285;5042.949570504303;4936.950630493703;4998.850034498971;5007.298978143044;5030.415419142958;5036.597072234249;4548.545145485458;4600.838970636011;4632;4637.376918078679;4641.257398816207;6025.367336429699;6041.305249896231;6093.6039157454625;6123.571350005502;6196;5848.561357898175;5872.677002764846;5878.323992740847;5901.704914754288;5903.852403689943;6566.409023187888;6595.868082638368;6597.373249541286;6624.238212605564;6626.536142470029;4893.877653058702;5105.489451054902;5114.43741188469;5115.641905066647;5122.359705036871;6830.146231721035;6852.828679283008;6916.896246556305;6926.2034865990045;7058.505904586681;5165.431802501722;5176.327077479904;5194.35070616173;5199.870003249949;5252.579793616502;5283.313169287968;5288.8413347599635;5325.121354976385;5336.4129945705945;5371.87810814726;5861.912071318934;5877.559183061202;5895.115732640138;5909.788493358851;5931.703414829241;6650.86698266032;6718.328167183243;6721.630310332881;6796.388325050769;6798.688445928408;1796.91015449227;1808.5569035586366;1819.6087841114224;1823.1431227323137;1843.4930394141718;1255.6798016505732;1303.882650561454;1309.541660418865;1316.822228999092;1318.7032917593465;6104;6120.419554560632;6127.2317524721975;6177.752889884354;6234.906476402857;6586.242582103024;6590.836398528637;6814.488913331421;6832.521723479309;6834.1457317835275;6028.517718582503;6229.501639868799;6233.563650544418;6264.37356264379;6331.430171284606;3560.4481305397703;3561.5726112866623;3571.9285614288087;3580.7135429165605;3610.079429745451;7028.4025857801635;7036.155661320674;7096.396806271525;7104.573725576379;7163.6060016699585;6928.896066559006;6970.756023539152;6986.345188828314;7060.611666358297;7100.893486597705;7055.647217639097;7186.820329491805;7219.530730502501;7224.241454647186;7255.492115551966;6778.3221677831825;6855.725770969305;6875;6938.653067346713;6962.895556566555;6824.931750682628;6847.383735463832;6852.246252912275;6904.344087311697;6912.896306555305;7285.453590980804;7296.379807716404;7306.926930730625;7312.488125831141;7323.780286591411;5729.656220626775;5761.884762304814;5770.961226979184;5782;5808.332041815076;6564.409203171737;6850.623215723183;6867.450603951572;6906;7017.649117544204;6467.547271690936;6613.66931653425;6614.5856762280455;6641.833954151185;6710.16122984627;6575.178102737158;6600.438962688226;6656.966715166393;6674.966625166843;6681.46548276127;6469.450096741642;6544.738210471718;6573.211214654272;6610.438112760469;6623.635700036351;6632.568883022588;6638.900416493853;6672;6717.790797656468;6775.830604234737;6395.392437718409;6457.7094030767785;6526.934730652632;6574.783665021986;6578.638174900427 04:12:32 INFO - PID 12681 | |5;yui.html;953.2564599612305;984.1978787288359;995.1690338567296;1004.6031817432109;1016.0296916444794;19366.709499357505;19574.70637940432;19595.21619135233;19646.803531964695;19659.410217693458;17568;17660.646787064285;17699.91150044248;17710.822891771077;17715.55711107223;986.4968865878418;999.8900120986722;999.9950000250025;1001.539291925715;1001.9899801001969;1095.5015467962057;1098.763765790355;1099.384344766933;1100.1913593508764;1102.0081926266344;1056.5932116135266;1085.2240647936724;1122.0182340452104;1124.550179928027;1136.6135513925265;1086.3807629651103;1109.6892869996414;1110.7722916802036;1110.8000559899215;1111.2887751838748;803.7347675267148;813.3615112136944;817.5094943034192;818.811673315135;818.9467684600481;17235.65528689419;17236.741448878278;17248.827511724972;17327.480175594752;17556.91221543897;21300.89349553258;21592.676109858363;21813.345599632037;21891.233806816686;22052.77947220523;18488.63022739551;18675.813241867545;18758.718619220723;18777.436676899713;18883.905580472147;3983.521977362735;4006;4007.1785284016705;4009.3585026395635;4020.43713880057;119559;157759;158201.20899395546;160906.1954690219;161372.19313903357;18350.26598936054;18579.72130418045;18589.81410185908;18613.534661633297;18718.53203669919;34769.478457823156;34779.65220347764;35099;35338.646613533536;35344.646553534134;9358.344915855962;9393.5303234838;9411.952940235255;9421.434713917188;9423.952880235554;4234.491860976641;4280.507741609755;4296.656267498593;4301.78491075445;4312.029793296546;5583.497485226349;5686.800961966312;5748.626339287933;5768.077107662753;5776.5089967352405;1098.3849044535086;1105.0772604874858;1130.0959232613875;1133.2294040052843;1133.886611338876;682.6757290287073;696.6621188723465;698.8043347862607;710.1761956130863;710.8045287545863;13275.560154415738;13470.326483675777;13481.932590336986;13972.441102355791;14022.228777417136;720.3804727934078;723.2875617516742;723.4574069447914;734.1117248129823;744.1033554566734;6197.318294987548;6266.561340706198;6293.874122517615;6332.873342533124;6390.648514331757;137697;139910.30044849915;140914.29542852426;147784;149010;104448;129591.35204324107;131939;132553;135361.32319338538;108486;109246.90753092527;110844;111090.44454777674;112036;13582.524611638546;13621;13638.454461821417;13684.863151368758;13727.931360343533;51595;52081;52305.7384713074;52500.474995249555;53404.73297633487;66393.66803165953;66409.33590664032;66931.66534167493;67151.32848671451;68513;19995.400137995883;20467.590648186655;20592.27927022607;20640.380788576367;20774.376768696962;22245.555088897807;22378;22468.213612523483;22577.661335079658;22637.094516219167;20222.19111235534;20227.79772202259;20344.0845161971;20364;20419;19133.234670613576;19305.51736206606;19584.412467625993;19585.51036224049;19850.305239316556;20793.272235471686;20973.161073557498;21028.158873644883;21033.36899893006;21174.576508470054;15082.849171508144;15211.543653690407;15226.162561058805;15461.304241308942;15473.922630386776;15418.500002497023;15587.22063896778;15624.92187539055;15825.841741582437;15941.920290398473 04:12:32 INFO - PID 12681 | __end_tp_report 04:12:32 INFO - PID 12681 | __start_cc_report 04:12:32 INFO - PID 12681 | _x_x_mozilla_cycle_collect,285 04:12:32 INFO - PID 12681 | __end_cc_report 04:12:32 INFO - PID 12681 | __startTimestamp1506078752843__endTimestamp 04:12:32 INFO - PID 12681 | 04:12:32 INFO - PID 12681 | ------- Summary: start ------- 04:12:32 INFO - PID 12681 | Number of tests: 6 04:12:32 INFO - PID 12681 | 04:12:32 INFO - PID 12681 | [#0] dojo.html Cycles:165 Average:6251.80 Median:6487.90 stddev:732.62 (11.3%) stddev-sans-first:710.69 04:12:32 INFO - PID 12681 | Values: 3872.3 3873.8 3875.0 3883.8 3891.2 6188.8 6256.8 6296.1 6298.3 6388.9 6212.6 6215.7 6216.9 6234.9 6334.2 5618.7 5639.0 5648.5 5668.2 5678.8 5638.1 5640.0 5737.9 5737.9 5762.5 5651.2 5674.6 5697.4 5717.7 5773.9 5454.4 5678.8 5695.6 5760.5 5784.4 5472.9 5565.2 5592.7 5683.7 5712.3 6178.9 6265.3 6304.5 6322.4 6361.4 6630.8 6733.5 6751.6 6802.8 6856.3 6762.6 6809.9 6813.3 6823.0 6827.2 6302.9 6323.9 6334.1 6384.0 6406.0 6995.1 6996.7 7086.8 7087.3 7088.0 6648.4 6648.5 6680.2 6789.9 6806.3 6698.4 6757.4 6806.3 6820.9 6911.9 6724.3 6725.4 6741.4 6742.1 6777.0 6704.4 6789.9 6793.1 6798.2 6800.3 4946.6 4972.1 5006.6 5018.9 5023.9 4500.8 4515.9 4545.9 4556.8 4606.3 6190.0 6204.6 6207.6 6209.0 6218.8 6721.3 6730.2 6804.0 6804.8 6823.0 6168.4 6177.8 6238.7 6251.9 6264.3 5398.5 5423.9 5475.1 5488.0 5509.0 7059.6 7093.5 7135.8 7139.5 7150.1 6628.4 6734.4 6814.5 6824.2 6826.1 6878.6 6980.3 6999.4 7005.9 7103.9 6645.2 6657.6 6662.6 6680.0 6684.5 6744.2 6765.9 6815.7 6869.7 6912.7 6538.7 6551.3 6616.2 6636.4 6637.7 6542.4 6555.5 6627.5 6646.1 6652.5 6379.5 6386.5 6473.6 6475.2 6487.9 6515.8 6646.5 6656.4 6673.3 6719.8 6381.5 6384.6 6427.7 6489.0 6493.5 04:12:32 INFO - PID 12681 | 04:12:32 INFO - PID 12681 | [#1] ext.html Cycles:180 Average:42336.03 Median:37777.31 stddev:61949.13 (164.0%) stddev-sans-first:62044.89 04:12:32 INFO - PID 12681 | Values: 928.6 948.7 950.6 959.1 966.5 44935.3 46016.3 46050.3 46077.0 46094.5 42249.0 42510.0 42621.6 42733.8 42832.4 7695.5 7859.4 8571.6 8679.7 8739.8 8519.5 8637.9 8644.3 8645.2 8656.4 8649.6 8673.3 8675.9 8708.8 8720.4 8576.8 8649.4 8675.8 8686.7 8690.3 8616.1 8675.3 8675.7 8678.2 8678.8 40501.4 40875.8 41134.0 41157.6 41320.8 3724.2 3727.4 3733.3 3740.7 3767.6 33192.3 33197.5 33321.3 33470.7 33536.8 5420.9 5435.3 5460.3 5516.1 5537.9 217067.0 217428.0 217931.0 217954.0 218600.0 49452.3 50322.2 53855.2 53911.5 54848.7 58960.7 59010.7 59056.7 59154.0 59291.4 15506.6 15585.3 15586.5 15606.5 15635.7 12273.2 12285.4 12311.9 12321.5 12415.5 15585.3 15779.7 15848.8 15923.9 15940.4 6007.0 6032.1 6089.4 6143.8 6178.9 1091.5 1101.6 1103.4 1106.8 1114.0 25152.9 25603.0 25781.6 25914.1 26036.7 1192.2 1194.5 1202.3 1209.9 1215.4 13477.9 13497.6 13655.5 13674.7 13906.0 265129.0 265447.0 265885.0 265923.0 266246.0 57511.4 57517.0 57859.4 57923.7 57948.0 1514.1 1553.9 1572.2 1582.8 1585.7 25225.6 25327.2 25345.5 25424.6 25545.5 37205.0 38814.2 38957.6 39137.8 39386.0 224029.0 228406.0 231460.0 232485.0 233398.0 35897.0 38961.8 39454.8 39547.8 39728.8 48497.8 49776.8 50306.0 50331.2 50638.2 37108.6 37149.0 37303.3 37708.0 37846.6 36502.3 36564.6 36895.0 37132.0 37150.4 42803.8 42818.6 43457.3 43662.3 43722.8 34946.8 34985.0 35266.0 35488.0 36034.8 26401.9 26657.6 26840.9 26972.3 27124.1 04:12:32 INFO - PID 12681 | 04:12:32 INFO - PID 12681 | [#2] jquery.html Cycles:180 Average:39328.65 Median:12592.44 stddev:100668.13 (799.4%) stddev-sans-first:100908.53 04:12:32 INFO - PID 12681 | Values: 601.2 606.0 610.9 619.5 626.9 23226.2 23837.9 23839.4 23866.4 23891.4 24610.8 26351.7 26584.7 26609.3 26662.1 6526.0 6675.2 6686.1 6697.0 6698.7 6511.4 6605.4 6845.7 6850.3 6855.3 6775.8 6787.3 6789.2 6822.8 6831.9 6592.8 6832.7 6832.9 6837.3 6842.6 6301.7 6325.1 6361.7 6379.3 6387.4 28764.9 29115.9 29320.9 29456.6 29519.9 2218.3 2266.8 2275.1 2275.4 2276.0 19278.4 20348.7 20573.9 20588.2 20637.7 2274.9 2418.7 2422.8 2483.2 2491.7 155734.0 159491.2 159518.0 159771.0 160109.0 16019.9 16047.1 16471.8 16474.0 16527.2 25248.6 25270.0 25272.2 25305.1 25387.5 9847.2 10011.3 10141.5 10156.9 10243.5 9229.0 9274.0 9299.0 9317.8 9340.9 9717.3 9758.7 9803.6 9940.0 9947.2 2829.3 2857.6 2888.7 2933.7 2975.3 1027.3 1031.9 1045.0 1048.9 1051.4 20311.2 20469.8 20592.3 20877.8 20964.1 1069.2 1089.9 1100.3 1119.3 1121.2 11221.2 11264.7 11297.5 11415.7 11549.8 584557.0 590940.0 604915.0 608072.0 614732.0 121022.0 122027.0 123858.4 124231.0 126347.4 1250.4 1264.1 1277.7 1284.9 1291.0 18161.3 18411.9 18510.4 18718.4 18782.7 60013.7 61243.0 62537.0 62771.7 63018.7 73723.0 78063.6 78474.6 78603.6 78671.6 14971.6 15141.5 15154.2 15325.3 15417.5 22744.3 22908.9 22962.3 23061.7 23203.3 18726.3 19155.5 19210.8 19257.9 19303.3 16627.4 16840.9 17125.6 17182.3 17424.9 19257.2 19403.5 19442.0 19533.7 19544.5 14888.4 14960.5 14976.9 15015.8 15054.3 18671.0 18779.0 19007.4 19015.4 19054.6 04:12:32 INFO - PID 12681 | 04:12:32 INFO - PID 12681 | [#3] mootools.html Cycles:180 Average:10610.48 Median:2803.27 stddev:7925.66 (282.7%) stddev-sans-first:7917.81 04:12:32 INFO - PID 12681 | Values: 1419.5 1448.8 1467.6 1470.9 1479.3 16619.2 17247.4 17267.5 17292.2 17307.2 16750.9 16962.2 17075.6 17103.1 17118.7 2839.4 2937.3 2938.5 2938.6 2938.8 2871.4 2879.8 2917.6 2919.5 2920.4 2899.0 2935.2 2971.3 2973.4 2973.8 2650.4 2732.5 2733.5 2812.2 2816.7 2794.3 2831.6 2848.9 2849.1 2851.3 16711.7 16718.8 16853.4 16880.1 16894.5 8119.9 8141.1 8453.7 8521.7 8745.1 5796.4 5809.9 5949.7 5982.7 6039.0 2072.4 2087.2 2119.1 2134.7 2159.7 31815.5 32729.0 32748.7 32755.2 32806.5 7337.3 7454.6 7468.5 7534.8 7552.7 19953.2 20447.4 20574.9 20623.8 20682.2 8450.8 8680.4 8681.0 8699.6 8704.0 7821.8 7936.2 7978.4 8031.6 8100.3 5563.3 5774.2 5779.6 5795.3 5839.6 1664.0 1706.4 1711.0 1731.0 1738.1 972.7 973.5 975.7 1000.6 1002.2 8733.5 8784.3 8820.2 8859.5 8886.3 782.9 786.8 795.8 799.4 817.7 5686.3 5931.8 6087.6 6118.8 6384.6 23601.8 24587.9 24724.8 25410.0 25536.6 24009.4 24901.9 25227.0 25373.7 25598.0 12280.3 12731.9 12743.2 12922.7 12981.3 9642.7 9695.4 9748.9 9821.7 9979.8 21168.2 21454.6 21719.8 22024.4 22213.8 22232.4 22253.2 22285.8 22514.1 22998.1 12326.2 12328.8 12440.8 12454.3 12509.1 15681.5 15861.3 15871.4 15872.4 15886.5 12901.0 12910.3 12911.7 12982.8 13018.8 12195.1 12773.7 12805.9 12848.8 12896.5 10225.5 10251.9 10294.6 10310.8 10355.7 8401.5 8419.7 8534.7 8590.4 8628.5 8232.3 8319.3 8368.2 8510.2 8517.0 04:12:32 INFO - PID 12681 | 04:12:32 INFO - PID 12681 | [#4] prototype.html Cycles:180 Average:5706.94 Median:6260.84 stddev:1600.55 (25.6%) stddev-sans-first:1557.08 04:12:32 INFO - PID 12681 | Values: 526.0 567.2 574.3 577.5 587.0 6368.2 6381.4 6393.4 6419.3 6434.6 6218.7 6229.5 6257.3 6319.7 6361.4 4902.9 5053.4 5080.7 5113.0 5155.4 5025.9 5052.3 5055.2 5080.8 5082.8 4964.6 4969.2 4981.7 5040.6 5042.9 4937.0 4998.9 5007.3 5030.4 5036.6 4548.5 4600.8 4632.0 4637.4 4641.3 6025.4 6041.3 6093.6 6123.6 6196.0 5848.6 5872.7 5878.3 5901.7 5903.9 6566.4 6595.9 6597.4 6624.2 6626.5 4893.9 5105.5 5114.4 5115.6 5122.4 6830.1 6852.8 6916.9 6926.2 7058.5 5165.4 5176.3 5194.4 5199.9 5252.6 5283.3 5288.8 5325.1 5336.4 5371.9 5861.9 5877.6 5895.1 5909.8 5931.7 6650.9 6718.3 6721.6 6796.4 6798.7 1796.9 1808.6 1819.6 1823.1 1843.5 1255.7 1303.9 1309.5 1316.8 1318.7 6104.0 6120.4 6127.2 6177.8 6234.9 6586.2 6590.8 6814.5 6832.5 6834.1 6028.5 6229.5 6233.6 6264.4 6331.4 3560.4 3561.6 3571.9 3580.7 3610.1 7028.4 7036.2 7096.4 7104.6 7163.6 6928.9 6970.8 6986.3 7060.6 7100.9 7055.6 7186.8 7219.5 7224.2 7255.5 6778.3 6855.7 6875.0 6938.7 6962.9 6824.9 6847.4 6852.2 6904.3 6912.9 7285.5 7296.4 7306.9 7312.5 7323.8 5729.7 5761.9 5771.0 5782.0 5808.3 6564.4 6850.6 6867.5 6906.0 7017.6 6467.5 6613.7 6614.6 6641.8 6710.2 6575.2 6600.4 6657.0 6675.0 6681.5 6469.5 6544.7 6573.2 6610.4 6623.6 6632.6 6638.9 6672.0 6717.8 6775.8 6395.4 6457.7 6526.9 6574.8 6578.6 04:12:32 INFO - PID 12681 | 04:12:32 INFO - PID 12681 | [#5] yui.html Cycles:180 Average:27784.34 Median:19621.01 stddev:40303.70 (205.4%) stddev-sans-first:40366.41 04:12:32 INFO - PID 12681 | Values: 953.3 984.2 995.2 1004.6 1016.0 19366.7 19574.7 19595.2 19646.8 19659.4 17568.0 17660.6 17699.9 17710.8 17715.6 986.5 999.9 1000.0 1001.5 1002.0 1095.5 1098.8 1099.4 1100.2 1102.0 1056.6 1085.2 1122.0 1124.6 1136.6 1086.4 1109.7 1110.8 1110.8 1111.3 803.7 813.4 817.5 818.8 818.9 17235.7 17236.7 17248.8 17327.5 17556.9 21300.9 21592.7 21813.3 21891.2 22052.8 18488.6 18675.8 18758.7 18777.4 18883.9 3983.5 4006.0 4007.2 4009.4 4020.4 119559.0 157759.0 158201.2 160906.2 161372.2 18350.3 18579.7 18589.8 18613.5 18718.5 34769.5 34779.7 35099.0 35338.6 35344.6 9358.3 9393.5 9412.0 9421.4 9424.0 4234.5 4280.5 4296.7 4301.8 4312.0 5583.5 5686.8 5748.6 5768.1 5776.5 1098.4 1105.1 1130.1 1133.2 1133.9 682.7 696.7 698.8 710.2 710.8 13275.6 13470.3 13481.9 13972.4 14022.2 720.4 723.3 723.5 734.1 744.1 6197.3 6266.6 6293.9 6332.9 6390.6 137697.0 139910.3 140914.3 147784.0 149010.0 104448.0 129591.4 131939.0 132553.0 135361.3 108486.0 109246.9 110844.0 111090.4 112036.0 13582.5 13621.0 13638.5 13684.9 13727.9 51595.0 52081.0 52305.7 52500.5 53404.7 66393.7 66409.3 66931.7 67151.3 68513.0 19995.4 20467.6 20592.3 20640.4 20774.4 22245.6 22378.0 22468.2 22577.7 22637.1 20222.2 20227.8 20344.1 20364.0 20419.0 19133.2 19305.5 19584.4 19585.5 19850.3 20793.3 20973.2 21028.2 21033.4 21174.6 15082.8 15211.5 15226.2 15461.3 15473.9 15418.5 15587.2 15624.9 15825.8 15941.9 04:12:32 INFO - PID 12681 | -------- Summary: end -------- 04:12:32 INFO - PID 12681 | 04:12:33 INFO - TEST-INFO | 12681: exit 0 04:12:33 INFO - TEST-OK | dromaeo_css | took 1108037ms 04:12:33 INFO - TEST-START | kraken 04:12:33 INFO - Initialising browser for kraken test... 04:12:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45426/getInfo.html -profile /tmp/tmpfOsahw/profile 04:12:33 INFO - TEST-INFO | started process 13048 (/builds/slave/test/build/application/firefox/firefox http://localhost:45426/getInfo.html) 04:12:38 INFO - TEST-INFO | 13048: exit 0 04:12:38 INFO - Browser initialized. 04:12:38 INFO - Running cycle 1/1 for kraken test... 04:12:38 INFO - Using env: {'DISPLAY': ':0', 04:12:38 INFO - 'HOME': '/home/cltbld', 04:12:38 INFO - 'JSGC_DISABLE_POISONING': '1', 04:12:38 INFO - 'LANG': 'en_US.UTF-8', 04:12:38 INFO - 'LANGUAGE': 'en_US:en', 04:12:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:12:38 INFO - 'LOGNAME': 'cltbld', 04:12:38 INFO - 'MAIL': '/var/mail/cltbld', 04:12:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:12:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:12:38 INFO - 'MOZ_CRASHREPORTER': '1', 04:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:12:38 INFO - 'MOZ_NO_REMOTE': '1', 04:12:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:38 INFO - 'NO_EM_RESTART': '1', 04:12:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:38 INFO - 'PWD': '/builds/slave/test', 04:12:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:12:38 INFO - 'RUST_BACKTRACE': 'full', 04:12:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:12:38 INFO - 'SHELL': '/bin/bash', 04:12:38 INFO - 'SHLVL': '1', 04:12:38 INFO - 'TERM': 'linux', 04:12:38 INFO - 'TMOUT': '86400', 04:12:38 INFO - 'USER': 'cltbld', 04:12:38 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643', 04:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:38 INFO - '_': '/tools/buildbot/bin/python'} 04:12:38 INFO - TEST-INFO | started process 13290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfOsahw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:39 INFO - PID 13290 | 04:12:39 INFO - PID 13290 | (/builds/slave/test/build/application/firefox/firefox:13340): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:12:39 INFO - PID 13290 | 04:12:49 INFO - PID 13290 | RSS: Main: 147353600 04:12:49 INFO - PID 13290 | 04:12:52 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45426/tests/kraken/driver.html?testName=audio-beat-detection) 04:12:53 INFO - PID 13290 | RSS: Main: 153530368 04:12:53 INFO - PID 13290 | 04:12:55 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45426/tests/kraken/driver.html?testName=audio-dft) 04:12:56 INFO - PID 13290 | RSS: Main: 153534464 04:12:56 INFO - PID 13290 | 04:12:59 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45426/tests/kraken/driver.html?testName=audio-fft) 04:12:59 INFO - PID 13290 | RSS: Main: 150585344 04:12:59 INFO - PID 13290 | 04:13:01 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45426/tests/kraken/driver.html?testName=audio-oscillator) 04:13:02 INFO - PID 13290 | RSS: Main: 150904832 04:13:02 INFO - PID 13290 | 04:13:04 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45426/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:13:05 INFO - PID 13290 | RSS: Main: 150851584 04:13:05 INFO - PID 13290 | 04:13:08 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45426/tests/kraken/driver.html?testName=imaging-darkroom) 04:13:08 INFO - PID 13290 | RSS: Main: 150974464 04:13:08 INFO - PID 13290 | 04:13:12 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45426/tests/kraken/driver.html?testName=imaging-desaturate) 04:13:13 INFO - PID 13290 | RSS: Main: 151957504 04:13:13 INFO - PID 13290 | 04:13:15 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45426/tests/kraken/driver.html?testName=json-parse-financial) 04:13:16 INFO - PID 13290 | RSS: Main: 153419776 04:13:16 INFO - PID 13290 | 04:13:18 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45426/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:13:18 INFO - PID 13290 | RSS: Main: 153493504 04:13:18 INFO - PID 13290 | 04:13:20 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45426/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:13:20 INFO - PID 13290 | RSS: Main: 153907200 04:13:20 INFO - PID 13290 | 04:13:22 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45426/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:13:23 INFO - PID 13290 | RSS: Main: 150761472 04:13:23 INFO - PID 13290 | 04:13:25 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:13:26 INFO - PID 13290 | RSS: Main: 150839296 04:13:26 INFO - PID 13290 | 04:13:29 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:13:29 INFO - PID 13290 | RSS: Main: 151068672 04:13:29 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:45426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45426/tests/kraken/driver.html?testName=ai-astar) 04:13:31 INFO - PID 13290 | RSS: Main: 153071616 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | __start_tp_report 04:13:31 INFO - PID 13290 | _x_x_mozilla_page_load 04:13:31 INFO - PID 13290 | _x_x_mozilla_page_load_details 04:13:31 INFO - PID 13290 | |i|pagename|runs| 04:13:31 INFO - PID 13290 | |0;ai-astar;106;105;104;105;106;109;106;108;105;105 04:13:31 INFO - PID 13290 | |1;audio-beat-detection;113;111;112;112;115;118;112;112;141;115 04:13:31 INFO - PID 13290 | |2;audio-dft;163;161;164;163;161;162;162;161;169;166 04:13:31 INFO - PID 13290 | |3;audio-fft;73;73;76;72;73;73;73;75;73;73 04:13:31 INFO - PID 13290 | |4;audio-oscillator;81;80;79;77;78;78;78;78;81;81 04:13:31 INFO - PID 13290 | |5;imaging-gaussian-blur;111;113;113;113;114;113;113;113;114;113 04:13:31 INFO - PID 13290 | |6;imaging-darkroom;151;150;150;150;150;150;150;150;151;151 04:13:31 INFO - PID 13290 | |7;imaging-desaturate;100;94;94;94;94;94;95;93;95;95 04:13:31 INFO - PID 13290 | |8;json-parse-financial;45;45;45;47;50;49;50;50;48;45 04:13:31 INFO - PID 13290 | |9;json-stringify-tinderbox;36;36;36;36;42;36;36;36;36;37 04:13:31 INFO - PID 13290 | |10;stanford-crypto-aes;70;70;71;71;71;73;70;71;72;71 04:13:31 INFO - PID 13290 | |11;stanford-crypto-ccm;108;104;103;111;107;104;101;108;105;109 04:13:31 INFO - PID 13290 | |12;stanford-crypto-pbkdf2;151;152;156;159;156;156;150;147;160;151 04:13:31 INFO - PID 13290 | |13;stanford-crypto-sha256-iterative;59;59;58;57;59;58;59;66;61;61 04:13:31 INFO - PID 13290 | __end_tp_report 04:13:31 INFO - PID 13290 | __start_cc_report 04:13:31 INFO - PID 13290 | _x_x_mozilla_cycle_collect,719 04:13:31 INFO - PID 13290 | __end_cc_report 04:13:31 INFO - PID 13290 | __startTimestamp1506078811768__endTimestamp 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | ------- Summary: start ------- 04:13:31 INFO - PID 13290 | Number of tests: 14 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#0] ai-astar Cycles:10 Average:105.90 Median:106.00 stddev:1.52 (1.4%) stddev-sans-first:1.62 04:13:31 INFO - PID 13290 | Values: 106.0 105.0 104.0 105.0 106.0 109.0 106.0 108.0 105.0 105.0 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#1] audio-beat-detection Cycles:10 Average:116.10 Median:114.00 stddev:9.00 (7.9%) stddev-sans-first:9.48 04:13:31 INFO - PID 13290 | Values: 113.0 111.0 112.0 112.0 115.0 118.0 112.0 112.0 141.0 115.0 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.57 (1.6%) stddev-sans-first:2.73 04:13:31 INFO - PID 13290 | Values: 163.0 161.0 164.0 163.0 161.0 162.0 162.0 161.0 169.0 166.0 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.00 stddev:1.17 (1.6%) stddev-sans-first:1.24 04:13:31 INFO - PID 13290 | Values: 73.0 73.0 76.0 72.0 73.0 73.0 73.0 75.0 73.0 73.0 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:79.50 stddev:1.52 (1.9%) stddev-sans-first:1.45 04:13:31 INFO - PID 13290 | Values: 81.0 80.0 79.0 77.0 78.0 78.0 78.0 78.0 81.0 81.0 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.82 (0.7%) stddev-sans-first:0.44 04:13:31 INFO - PID 13290 | Values: 111.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 114.0 113.0 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 04:13:31 INFO - PID 13290 | Values: 151.0 150.0 150.0 150.0 150.0 150.0 150.0 150.0 151.0 151.0 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:1.93 (2.1%) stddev-sans-first:0.67 04:13:31 INFO - PID 13290 | Values: 100.0 94.0 94.0 94.0 94.0 94.0 95.0 93.0 95.0 95.0 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#8] json-parse-financial Cycles:10 Average:47.40 Median:48.50 stddev:2.27 (4.7%) stddev-sans-first:2.24 04:13:31 INFO - PID 13290 | Values: 45.0 45.0 45.0 47.0 50.0 49.0 50.0 50.0 48.0 45.0 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#9] json-stringify-tinderbox Cycles:10 Average:36.70 Median:36.00 stddev:1.89 (5.2%) stddev-sans-first:1.99 04:13:31 INFO - PID 13290 | Values: 36.0 36.0 36.0 36.0 42.0 36.0 36.0 36.0 36.0 37.0 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#10] stanford-crypto-aes Cycles:10 Average:71.00 Median:71.00 stddev:0.94 (1.3%) stddev-sans-first:0.93 04:13:31 INFO - PID 13290 | Values: 70.0 70.0 71.0 71.0 71.0 73.0 70.0 71.0 72.0 71.0 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#11] stanford-crypto-ccm Cycles:10 Average:106.00 Median:107.50 stddev:3.09 (2.9%) stddev-sans-first:3.19 04:13:31 INFO - PID 13290 | Values: 108.0 104.0 103.0 111.0 107.0 104.0 101.0 108.0 105.0 109.0 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:156.00 stddev:4.21 (2.7%) stddev-sans-first:4.34 04:13:31 INFO - PID 13290 | Values: 151.0 152.0 156.0 159.0 156.0 156.0 150.0 147.0 160.0 151.0 04:13:31 INFO - PID 13290 | 04:13:31 INFO - PID 13290 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.70 Median:59.00 stddev:2.54 (4.3%) stddev-sans-first:2.68 04:13:31 INFO - PID 13290 | Values: 59.0 59.0 58.0 57.0 59.0 58.0 59.0 66.0 61.0 61.0 04:13:31 INFO - PID 13290 | -------- Summary: end -------- 04:13:31 INFO - PID 13290 | 04:13:32 INFO - PID 13290 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:13:32 INFO - TEST-INFO | 13290: exit 0 04:13:32 INFO - TEST-OK | kraken | took 58929ms 04:13:32 INFO - SUITE-END | took 1166s 04:13:32 INFO - Completed test suite (00:19:26) 04:13:32 INFO - javascript benchmark 04:13:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9110.188237957524, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3872.341701910676, 3873.8450461981524, 3874.961250387495, 3883.7669739815615, 3891.1633998690277, 6188.75244990201, 6256.84357891053, 6296.0555916612475, 6298.275698294698, 6388.872222555552, 6212.627242365461, 6215.720292586833, 6216.937830621704, 6234.875302493947, 6334.208223972004, 5618.662880227179, 5638.971805140968, 5648.491635752782, 5668.178114173453, 5678.772849086032, 5638.069718496443, 5639.971800141014, 5737.856553586173, 5737.942620573783, 5762.4525670061275, 5651.180578816069, 5674.602777805555, 5697.401772813857, 5717.656940583557, 5773.855653608652, 5454.372747134051, 5678.772849086032, 5695.601307908448, 5760.4527569881, 5784.421557844203, 5472.890542189134, 5565.220869078333, 5592.664440133605, 5683.658980461186, 5712.285964254468, 6178.907316390258, 6265.310815810257, 6304.495640348761, 6322.430981211667, 6361.427471527539, 6630.834229144261, 6733.49498787588, 6751.594904305757, 6802.795916122524, 6856.348646878539, 6762.560433571802, 6809.931900680979, 6813.318668133147, 6822.965885170592, 6827.2490026097585, 6302.9054564181115, 6323.9051414228825, 6334.144890439824, 6384.0, 6405.967970160119, 6995.090638217, 6996.650167491605, 7086.787396378117, 7087.2558381370245, 7088.0, 6648.368405001517, 6648.5346025777735, 6680.23177334603, 6789.898151527731, 6806.319368063253, 6698.363655452724, 6757.358050985247, 6806.319368063253, 6820.942753873158, 6911.9308806912295, 6724.327567243335, 6725.39471447572, 6741.393274605309, 6742.056112144303, 6777.0, 6704.396604305636, 6789.932100679029, 6793.082933803972, 6798.150231221098, 6800.319968003259, 4946.604271658259, 4972.105021096165, 5006.574441172541, 5018.874528136826, 5023.874403139951, 4500.83505745699, 4515.909681806345, 4545.931811022837, 4556.794944227518, 4606.262997920317, 6190.009598464224, 6204.627722336584, 6207.6275423473835, 6209.0, 6218.81343559694, 6721.26066132725, 6730.158730158731, 6803.965980170166, 6804.76183333581, 6822.965885170543, 6168.444839964424, 6177.783777567854, 6238.65687387189, 6251.874962500725, 6264.310925798159, 5398.46015398457, 5423.864403389947, 5475.123980163235, 5488.0, 5509.035918714209, 7059.6117213552725, 7093.467989900778, 7135.82160445993, 7139.535930164523, 7150.10623672041, 6628.370304821035, 6734.4275736560985, 6814.454843612598, 6824.18109826824, 6826.112605361371, 6878.55289406187, 6980.267071957372, 6999.440044796303, 7005.859882802213, 7103.9289607103265, 6645.202575690948, 6657.633830139195, 6662.56693314933, 6680.0, 6684.532082754355, 6744.156980377453, 6765.86468270622, 6815.69329380189, 6869.725210991504, 6912.654367281515, 6538.705758240986, 6551.344865513411, 6616.2060552732055, 6636.402723754885, 6637.734490620321, 6542.411182993363, 6555.541112122296, 6627.536072474881, 6646.136002319668, 6652.534322597372, 6379.457746091634, 6386.521010924293, 6473.611583305017, 6475.158229430144, 6487.902681459687, 6515.837104072436, 6646.534742567974, 6656.400923916871, 6673.332666733288, 6719.764808231688, 6381.489480841615, 6384.648844313608, 6427.742890284337, 6489.0, 6493.512986525935], "value": 6202.774768646893, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [928.6053427293401, 948.677449667113, 950.5864948747295, 959.0888655777013, 966.463612694954, 44935.32597011043, 46016.30975535361, 46050.30924536135, 46077.0, 46094.53905460944, 42249.0, 42510.0, 42621.573784262146, 42733.78633106838, 42832.357514637224, 7695.538267703956, 7859.410544209179, 8571.571421428904, 8679.69621063263, 8739.825203495926, 8519.488830670149, 8637.870431943526, 8644.265237454823, 8645.178708022759, 8656.350773691998, 8649.567521623894, 8673.306135509145, 8675.869861952076, 8708.782280443007, 8720.38957272988, 8576.828463430727, 8649.394542382035, 8675.783105422383, 8686.695965641173, 8690.261327787146, 8616.052234254226, 8675.349348798865, 8675.739727808175, 8678.218960293541, 8678.826423471559, 40501.39247911254, 40875.7956210217, 41134.0, 41157.58842411597, 41320.79339603313, 3724.16206353571, 3727.403615421547, 3733.3466643337306, 3740.663340299359, 3767.6044015378266, 33192.33615327704, 33197.50203746946, 33321.33357332864, 33470.665293346996, 33536.83231583826, 5420.891582168335, 5435.293411856473, 5460.31746031746, 5516.062269414209, 5537.944620553783, 217066.99999999843, 217428.0, 217931.0, 217954.0, 218600.0, 49452.258216126786, 50322.24516632254, 53855.19217211745, 53911.460885391425, 54848.72575637176, 58960.70519647374, 59010.704946474994, 59056.704716476146, 59154.0, 59291.407085928586, 15506.612334691497, 15585.298661560257, 15586.454474093352, 15606.45377411808, 15635.749140068767, 12273.202241854251, 12285.385730713608, 12311.876881231252, 12321.507139714311, 12415.503379864886, 15585.298661560257, 15779.68440631181, 15848.76226856598, 15923.920380398024, 15940.36238550445, 6006.969965150146, 6032.125341825498, 6089.421504957022, 6143.815685529441, 6178.876422471525, 1091.5415525479318, 1101.6419663609358, 1103.442761405485, 1106.8229083346625, 1113.9610113645983, 25152.874235628704, 25603.0, 25781.61327580088, 25914.093006744675, 26036.73963260381, 1192.2325451572988, 1194.486370860521, 1202.2786328203183, 1209.9274043557414, 1215.440897187286, 13477.865221347662, 13497.595072147851, 13655.522056727967, 13674.658133546542, 13906.0, 265129.0, 265447.0, 265885.0, 265923.0, 266246.0, 57511.42488575145, 57517.0, 57859.42140578625, 57923.710381447825, 57948.0, 1514.1142431677592, 1553.9456119035779, 1572.2217502336189, 1582.8021497312836, 1585.7462805950993, 25225.621615675413, 25327.240182794547, 25345.493090137727, 25424.618630720182, 25545.48909021772, 37205.0, 38814.223715526095, 38957.610423896534, 39137.80431097826, 39386.0, 224029.0, 228406.0, 231460.0, 232485.0, 233398.0, 35897.0, 38961.805190973864, 39454.802725986185, 39547.80226098851, 39728.80135599303, 48497.75751121363, 49776.75111624419, 50306.0, 50331.24503132529, 50638.2404263929, 37108.62891371052, 37149.0, 37303.25393492169, 37708.0, 37846.62153378431, 36502.26995460129, 36564.63435365719, 36895.0, 37132.0, 37150.44274335941, 42803.78598107114, 42818.57181428146, 43457.34813977856, 43662.34506482342, 43722.781386092865, 34946.82526587351, 34985.0, 35266.0, 35488.0, 36034.819825900704, 26401.867990659925, 26657.600135998364, 26840.865795670896, 26972.32569185786, 27124.050658226868], "value": 18863.121893808806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.1943995046637, 605.9515238780898, 610.9022556390978, 619.5229673151671, 626.8840264551059, 23226.18708345208, 23837.88081059592, 23839.404014899636, 23866.40333991651, 23891.402714932112, 24610.75389246107, 26351.736482635217, 26584.734152658515, 26609.334766630844, 26662.066827661034, 6525.988471786881, 6675.198976122872, 6686.063951046857, 6697.0, 6698.732050717966, 6511.413972742453, 6605.405513503783, 6845.657717114149, 6850.349216824418, 6855.2801955794675, 6775.796726098225, 6787.321267873198, 6789.15135608049, 6822.829429264259, 6831.897521537181, 6592.80221593353, 6832.6925288362145, 6832.93167068328, 6837.3162683731725, 6842.555233909805, 6301.6534090625, 6325.082862984841, 6361.681915904186, 6379.330170332141, 6387.361263873622, 28764.856175719196, 29115.854420727974, 29320.8533957331, 29456.55815162774, 29519.852400738073, 2218.3455880515285, 2266.8073213776847, 2275.112706044644, 2275.385645875621, 2276.0, 19278.421647350602, 20348.69476957847, 20573.8971305144, 20588.176472941064, 20637.690434643493, 2274.8521346112616, 2418.6734790803366, 2422.780115256528, 2483.1681386735286, 2491.6511688363644, 155734.0, 159491.2025439877, 159518.0, 159771.0, 160109.0, 16019.919900400424, 16047.117408542643, 16471.83528164727, 16474.0, 16527.173641317888, 25248.621270680953, 25270.0, 25272.24183274468, 25305.114320998677, 25387.492250155265, 9847.212223022141, 10011.349262297927, 10141.49292535385, 10156.949215253877, 10243.539040743035, 9228.953855230815, 9273.953630231807, 9298.95350523243, 9317.813643727088, 9340.906590934004, 9717.319787614799, 9758.658446954323, 9803.558839852223, 9940.0, 9947.154491868128, 2829.2643912582466, 2857.5999360089604, 2888.6678032026584, 2933.6919623439658, 2975.285931376454, 1027.3476342522404, 1031.9329243599143, 1044.9529771160317, 1048.8688913885765, 1051.379685985257, 20311.18755249803, 20469.795302047085, 20592.27927022547, 20877.79122208789, 20964.05661745225, 1069.2087854987253, 1089.9182561307935, 1100.3452945497415, 1119.2948442481186, 1121.2039451989017, 11221.158413119048, 11264.718382040515, 11297.54809807615, 11415.714607134889, 11549.787272336453, 584557.0, 590940.0, 604915.0, 608072.0, 614732.0, 121022.0, 122027.0, 123858.38070809588, 124231.0, 126347.36826315994, 1250.3935591238424, 1264.0835394339215, 1277.7125146842072, 1284.9229046257256, 1290.9806352904714, 18161.27354905842, 18411.907940460213, 18510.426613737982, 18718.438446846616, 18782.71825922585, 60013.699931500065, 61243.0, 62537.0, 62771.686141569, 63018.684906575174, 73723.0, 78063.60968195123, 78474.6076269615, 78603.60698196472, 78671.60664196643, 14971.550853474413, 15141.470048548688, 15154.242287885781, 15325.310361034004, 15417.537473875802, 22744.31767046991, 22908.885455572614, 22962.31113066611, 23061.65407518922, 23203.303900883002, 18726.344577939708, 19155.521111971753, 19210.8078919209, 19257.903710481358, 19303.32438364707, 16627.42039506245, 16840.915795420944, 17125.57186070358, 17182.31270749156, 17424.91287543554, 19257.22971081141, 19403.51491212731, 19442.0, 19533.70699439481, 19544.511387215432, 14888.404463821325, 14960.476383326532, 14976.925115374353, 15015.849841501882, 15054.32255548481, 18671.0, 18779.0, 19007.42977710671, 19015.42953711391, 19054.618907621494], "value": 12593.084665486775, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.51026895721, 1448.8273771537977, 1467.5964109869792, 1470.8676219140282, 1479.2751551739648, 16619.16904154792, 17247.396341128064, 17267.481975540755, 17292.221850016747, 17307.22117504712, 16750.916245418786, 16962.236699348527, 17075.573110672238, 17103.144842757843, 17118.657626847456, 2839.4463079699467, 2937.2656835791054, 2938.456385568666, 2938.5592161175887, 2938.8236705797613, 2871.382652729663, 2879.784016198783, 2917.620709307787, 2919.474494590973, 2920.4013177298602, 2898.9565156522667, 2935.222166125978, 2971.3463038131576, 2973.435047340998, 2973.836438995854, 2650.4301575161335, 2732.508148533263, 2733.45330933814, 2812.226637674635, 2816.7183281671873, 2794.315392728774, 2831.6460442444695, 2848.9145325640266, 2849.088291746642, 2851.2871782054485, 16711.66576668472, 16718.832811671848, 16853.41013064549, 16880.07159606221, 16894.49316520506, 8119.944407227082, 8141.1451797561585, 8453.746387608382, 8521.701740439055, 8745.081766414562, 5796.391378905197, 5809.908432964129, 5949.702514874239, 5982.670953097578, 6039.0, 2072.3784412717923, 2087.2068613926613, 2119.057019626267, 2134.7224860768156, 2159.730033745782, 31815.522767158513, 32729.018129456155, 32748.6725132748, 32755.18112047194, 32806.50790238148, 7337.3029562191505, 7454.552726836408, 7468.5145465544565, 7534.811629709191, 7552.66013029415, 19953.20187192496, 20447.38657840267, 20574.897125514275, 20623.79376206219, 20682.172713091608, 8450.788730281793, 8680.392372533988, 8680.95659521711, 8699.565021748887, 8704.0, 7821.765347039598, 7936.206379362133, 7978.361731061501, 8031.638576264082, 8100.311473524698, 5563.276774019351, 5774.162746401748, 5779.595428319977, 5795.304563452412, 5839.562032847469, 1663.96672066558, 1706.3942300483398, 1710.9572260693333, 1730.956726081858, 1738.1048759888668, 972.6595691507915, 973.4986481961795, 975.7072878136672, 1000.6447711062614, 1002.2082554781641, 8733.475991440533, 8784.253338466175, 8820.206181443573, 8859.468431894107, 8886.289096872235, 782.9295363417206, 786.8268980824209, 795.7823535263198, 799.400449662753, 817.7383237364105, 5686.2607860977805, 5931.762729490858, 6087.604305720114, 6118.755249790048, 6384.585001974857, 23601.7639823603, 24587.87706061458, 24724.752752472246, 25409.983600656138, 25536.616950745753, 24009.399765005666, 24901.87549062243, 25227.0, 25373.746262537137, 25598.0, 12280.324582147889, 12731.87268127307, 12743.171693840057, 12922.676933076747, 12981.286029268482, 9642.71071867845, 9695.418274903528, 9748.902510975084, 9821.656242031495, 9979.750506237402, 21168.153273868873, 21454.57090858143, 21719.782802171776, 22024.44938876541, 22213.777862221817, 22232.44418889476, 22253.22113726012, 22285.777142229017, 22514.099436022374, 22998.08007679741, 12326.198797078161, 12328.753424931272, 12440.751184976069, 12454.25274483534, 12509.061820363691, 15681.451149209723, 15861.286242118902, 15871.365145394517, 15872.44446444369, 15886.52340429789, 12901.0, 12910.289934053717, 12911.677208069874, 12982.805257921327, 13018.80471792905, 12195.146339756131, 12773.680657983625, 12805.935970320088, 12848.807267890803, 12896.548620798227, 10225.488725563544, 10251.948740256252, 10294.588216471257, 10310.845337319795, 10355.741106472398, 8401.53791541471, 8419.70531031411, 8534.658613655385, 8590.398672092893, 8628.5254311011, 8232.300254478436, 8319.334453243848, 8368.24685778283, 8510.234078932677, 8516.957415212884], "value": 7387.710537292018, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.9605529585282, 567.1606023085831, 574.3481148896003, 577.5091172503372, 586.9618474799139, 6368.172137622114, 6381.361863813617, 6393.424591786738, 6419.293877673464, 6434.646094464802, 6218.657973811439, 6229.4704950079185, 6257.311695713479, 6319.715612797424, 6361.395667411589, 4902.86725274505, 5053.36832895888, 5080.720560369178, 5113.0, 5155.407128180251, 5025.949740502603, 5052.343195384613, 5055.216441451563, 5080.7967681292885, 5082.79668813247, 4964.578010869081, 4969.155243608595, 4981.651284410093, 5040.5967522598285, 5042.949570504303, 4936.950630493703, 4998.850034498971, 5007.298978143044, 5030.415419142958, 5036.597072234249, 4548.545145485458, 4600.838970636011, 4632.0, 4637.376918078679, 4641.257398816207, 6025.367336429699, 6041.305249896231, 6093.6039157454625, 6123.571350005502, 6196.0, 5848.561357898175, 5872.677002764846, 5878.323992740847, 5901.704914754288, 5903.852403689943, 6566.409023187888, 6595.868082638368, 6597.373249541286, 6624.238212605564, 6626.536142470029, 4893.877653058702, 5105.489451054902, 5114.43741188469, 5115.641905066647, 5122.359705036871, 6830.146231721035, 6852.828679283008, 6916.896246556305, 6926.2034865990045, 7058.505904586681, 5165.431802501722, 5176.327077479904, 5194.35070616173, 5199.870003249949, 5252.579793616502, 5283.313169287968, 5288.8413347599635, 5325.121354976385, 5336.4129945705945, 5371.87810814726, 5861.912071318934, 5877.559183061202, 5895.115732640138, 5909.788493358851, 5931.703414829241, 6650.86698266032, 6718.328167183243, 6721.630310332881, 6796.388325050769, 6798.688445928408, 1796.91015449227, 1808.5569035586366, 1819.6087841114224, 1823.1431227323137, 1843.4930394141718, 1255.6798016505732, 1303.882650561454, 1309.541660418865, 1316.822228999092, 1318.7032917593465, 6104.0, 6120.419554560632, 6127.2317524721975, 6177.752889884354, 6234.906476402857, 6586.242582103024, 6590.836398528637, 6814.488913331421, 6832.521723479309, 6834.1457317835275, 6028.517718582503, 6229.501639868799, 6233.563650544418, 6264.37356264379, 6331.430171284606, 3560.4481305397703, 3561.5726112866623, 3571.9285614288087, 3580.7135429165605, 3610.079429745451, 7028.4025857801635, 7036.155661320674, 7096.396806271525, 7104.573725576379, 7163.6060016699585, 6928.896066559006, 6970.756023539152, 6986.345188828314, 7060.611666358297, 7100.893486597705, 7055.647217639097, 7186.820329491805, 7219.530730502501, 7224.241454647186, 7255.492115551966, 6778.3221677831825, 6855.725770969305, 6875.0, 6938.653067346713, 6962.895556566555, 6824.931750682628, 6847.383735463832, 6852.246252912275, 6904.344087311697, 6912.896306555305, 7285.453590980804, 7296.379807716404, 7306.926930730625, 7312.488125831141, 7323.780286591411, 5729.656220626775, 5761.884762304814, 5770.961226979184, 5782.0, 5808.332041815076, 6564.409203171737, 6850.623215723183, 6867.450603951572, 6906.0, 7017.649117544204, 6467.547271690936, 6613.66931653425, 6614.5856762280455, 6641.833954151185, 6710.16122984627, 6575.178102737158, 6600.438962688226, 6656.966715166393, 6674.966625166843, 6681.46548276127, 6469.450096741642, 6544.738210471718, 6573.211214654272, 6610.438112760469, 6623.635700036351, 6632.568883022588, 6638.900416493853, 6672.0, 6717.790797656468, 6775.830604234737, 6395.392437718409, 6457.7094030767785, 6526.934730652632, 6574.783665021986, 6578.638174900427], "value": 5245.238726039178, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [953.2564599612305, 984.1978787288359, 995.1690338567296, 1004.6031817432109, 1016.0296916444794, 19366.709499357505, 19574.70637940432, 19595.21619135233, 19646.803531964695, 19659.410217693458, 17568.0, 17660.646787064285, 17699.91150044248, 17710.822891771077, 17715.55711107223, 986.4968865878418, 999.8900120986722, 999.9950000250025, 1001.539291925715, 1001.9899801001969, 1095.5015467962057, 1098.763765790355, 1099.384344766933, 1100.1913593508764, 1102.0081926266344, 1056.5932116135266, 1085.2240647936724, 1122.0182340452104, 1124.550179928027, 1136.6135513925265, 1086.3807629651103, 1109.6892869996414, 1110.7722916802036, 1110.8000559899215, 1111.2887751838748, 803.7347675267148, 813.3615112136944, 817.5094943034192, 818.811673315135, 818.9467684600481, 17235.65528689419, 17236.741448878278, 17248.827511724972, 17327.480175594752, 17556.91221543897, 21300.89349553258, 21592.676109858363, 21813.345599632037, 21891.233806816686, 22052.77947220523, 18488.63022739551, 18675.813241867545, 18758.718619220723, 18777.436676899713, 18883.905580472147, 3983.521977362735, 4006.0, 4007.1785284016705, 4009.3585026395635, 4020.43713880057, 119559.0, 157759.0, 158201.20899395546, 160906.1954690219, 161372.19313903357, 18350.26598936054, 18579.72130418045, 18589.81410185908, 18613.534661633297, 18718.53203669919, 34769.478457823156, 34779.65220347764, 35099.0, 35338.646613533536, 35344.646553534134, 9358.344915855962, 9393.5303234838, 9411.952940235255, 9421.434713917188, 9423.952880235554, 4234.491860976641, 4280.507741609755, 4296.656267498593, 4301.78491075445, 4312.029793296546, 5583.497485226349, 5686.800961966312, 5748.626339287933, 5768.077107662753, 5776.5089967352405, 1098.3849044535086, 1105.0772604874858, 1130.0959232613875, 1133.2294040052843, 1133.886611338876, 682.6757290287073, 696.6621188723465, 698.8043347862607, 710.1761956130863, 710.8045287545863, 13275.560154415738, 13470.326483675777, 13481.932590336986, 13972.441102355791, 14022.228777417136, 720.3804727934078, 723.2875617516742, 723.4574069447914, 734.1117248129823, 744.1033554566734, 6197.318294987548, 6266.561340706198, 6293.874122517615, 6332.873342533124, 6390.648514331757, 137697.0, 139910.30044849915, 140914.29542852426, 147784.0, 149010.0, 104448.0, 129591.35204324107, 131939.0, 132553.0, 135361.32319338538, 108486.0, 109246.90753092527, 110844.0, 111090.44454777674, 112036.0, 13582.524611638546, 13621.0, 13638.454461821417, 13684.863151368758, 13727.931360343533, 51595.0, 52081.0, 52305.7384713074, 52500.474995249555, 53404.73297633487, 66393.66803165953, 66409.33590664032, 66931.66534167493, 67151.32848671451, 68513.0, 19995.400137995883, 20467.590648186655, 20592.27927022607, 20640.380788576367, 20774.376768696962, 22245.555088897807, 22378.0, 22468.213612523483, 22577.661335079658, 22637.094516219167, 20222.19111235534, 20227.79772202259, 20344.0845161971, 20364.0, 20419.0, 19133.234670613576, 19305.51736206606, 19584.412467625993, 19585.51036224049, 19850.305239316556, 20793.272235471686, 20973.161073557498, 21028.158873644883, 21033.36899893006, 21174.576508470054, 15082.849171508144, 15211.543653690407, 15226.162561058805, 15461.304241308942, 15473.922630386776, 15418.500002497023, 15587.22063896778, 15624.92187539055, 15825.841741582437, 15941.920290398473], "value": 10012.229940051582, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1370.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 104.0, 105.0, 106.0, 109.0, 106.0, 108.0, 105.0, 105.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 112.0, 112.0, 115.0, 118.0, 112.0, 112.0, 141.0, 115.0], "value": 116.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 163.0, 161.0, 162.0, 162.0, 161.0, 169.0, 166.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 76.0, 72.0, 73.0, 73.0, 73.0, 75.0, 73.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 77.0, 78.0, 78.0, 78.0, 78.0, 81.0, 81.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 151.0, 151.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 93.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 45.0, 47.0, 50.0, 49.0, 50.0, 50.0, 48.0, 45.0], "value": 47.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 36.0, 36.0, 42.0, 36.0, 36.0, 36.0, 36.0, 37.0], "value": 36.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 71.0, 71.0, 73.0, 70.0, 71.0, 72.0, 71.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 104.0, 103.0, 111.0, 107.0, 104.0, 101.0, 108.0, 105.0, 109.0], "value": 106.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 156.0, 159.0, 156.0, 156.0, 150.0, 147.0, 160.0, 151.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 57.0, 59.0, 58.0, 59.0, 66.0, 61.0, 61.0], "value": 59.7, "unit": "score"}]}]} 04:13:32 INFO - Return code: 0 04:13:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:13:32 INFO - # TBPL SUCCESS # 04:13:32 INFO - Running post-action listener: _package_coverage_data 04:13:32 INFO - Running post-action listener: _resource_record_post_action 04:13:32 INFO - [mozharness: 2017-09-22 11:13:32.556032Z] Finished run-tests step (success) 04:13:32 INFO - Running post-run listener: _resource_record_post_run 04:13:32 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 384827392; Read time: 28; Write time: 227280 04:13:32 INFO - TinderboxPrint: CPU usage
13.0% 04:13:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 04:13:32 INFO - TinderboxPrint: I/O write bytes / time
384,827,392 / 227,280 04:13:32 INFO - TinderboxPrint: CPU idle
8,213.9 (86.9%) 04:13:32 INFO - TinderboxPrint: CPU user
1,185.6 (12.5%) 04:13:32 INFO - TinderboxPrint: Swap in / out
0 / 0 04:13:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 75112448; Read time: 0; Write time: 44096 04:13:32 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:13:32 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309714944; Read time: 28; Write time: 183184 04:13:33 INFO - Running post-run listener: _upload_blobber_files 04:13:33 INFO - Blob upload gear active. 04:13:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:13:33 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 04:13:33 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'] 04:13:33 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 04:13:33 INFO - (blobuploader) - INFO - Open directory for files ... 04:13:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:13:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:13:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:40 INFO - (blobuploader) - INFO - Done attempting. 04:13:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:13:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:13:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:41 INFO - (blobuploader) - INFO - Done attempting. 04:13:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:13:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:13:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:42 INFO - (blobuploader) - INFO - Done attempting. 04:13:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:13:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:13:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:43 INFO - (blobuploader) - INFO - Done attempting. 04:13:43 INFO - (blobuploader) - INFO - Iteration through files over. 04:13:43 INFO - Return code: 0 04:13:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:13:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:13:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d089e272c69c7eac65e81edc336a364c3f6ca391d669632422312cde83fdc9ed343b455139977ef45010c194aa6fbff43429b845f361439b39cc158d9d437b09", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fbedd516e75c4a05eaebd576e6949a790f1c0ffe4d7f7e159c395f113e8d5405b366792cbd7d0f75e34818bf5540d85ea23860d35f5809a7df67cc4510cdbd3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abeac947bf5803b921f0ff6a58229f2e038e95109905d1950dbce29e622e590434e46ad56ace04514ac18fbcd26215c7cc55bd1b1030f8284c3c0cd0f38c12cb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9efb08b3ba47abb89af45b22b71016b5db9f1ad26e0a1bb3b6ffb7cf5ac43bd3d94a2dea1be187176fa680570a40c7aec4faaba749f6a85fac1854ed871366b7"} 04:13:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:13:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:13:43 INFO - Contents: 04:13:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d089e272c69c7eac65e81edc336a364c3f6ca391d669632422312cde83fdc9ed343b455139977ef45010c194aa6fbff43429b845f361439b39cc158d9d437b09", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fbedd516e75c4a05eaebd576e6949a790f1c0ffe4d7f7e159c395f113e8d5405b366792cbd7d0f75e34818bf5540d85ea23860d35f5809a7df67cc4510cdbd3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abeac947bf5803b921f0ff6a58229f2e038e95109905d1950dbce29e622e590434e46ad56ace04514ac18fbcd26215c7cc55bd1b1030f8284c3c0cd0f38c12cb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9efb08b3ba47abb89af45b22b71016b5db9f1ad26e0a1bb3b6ffb7cf5ac43bd3d94a2dea1be187176fa680570a40c7aec4faaba749f6a85fac1854ed871366b7"} 04:13:43 INFO - Running post-run listener: copy_logs_to_upload_dir 04:13:43 INFO - Copying logs to upload dir... 04:13:43 INFO - mkdir: /builds/slave/test/build/upload/logs 04:13:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.118602 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-22 04:13:43.625977) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 04:13:43.630234) ========= 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=dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d089e272c69c7eac65e81edc336a364c3f6ca391d669632422312cde83fdc9ed343b455139977ef45010c194aa6fbff43429b845f361439b39cc158d9d437b09", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fbedd516e75c4a05eaebd576e6949a790f1c0ffe4d7f7e159c395f113e8d5405b366792cbd7d0f75e34818bf5540d85ea23860d35f5809a7df67cc4510cdbd3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abeac947bf5803b921f0ff6a58229f2e038e95109905d1950dbce29e622e590434e46ad56ace04514ac18fbcd26215c7cc55bd1b1030f8284c3c0cd0f38c12cb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9efb08b3ba47abb89af45b22b71016b5db9f1ad26e0a1bb3b6ffb7cf5ac43bd3d94a2dea1be187176fa680570a40c7aec4faaba749f6a85fac1854ed871366b7"} build_url:https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/cWOTIN89SmKdG6xcx1MJ8w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d089e272c69c7eac65e81edc336a364c3f6ca391d669632422312cde83fdc9ed343b455139977ef45010c194aa6fbff43429b845f361439b39cc158d9d437b09", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fbedd516e75c4a05eaebd576e6949a790f1c0ffe4d7f7e159c395f113e8d5405b366792cbd7d0f75e34818bf5540d85ea23860d35f5809a7df67cc4510cdbd3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abeac947bf5803b921f0ff6a58229f2e038e95109905d1950dbce29e622e590434e46ad56ace04514ac18fbcd26215c7cc55bd1b1030f8284c3c0cd0f38c12cb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9efb08b3ba47abb89af45b22b71016b5db9f1ad26e0a1bb3b6ffb7cf5ac43bd3d94a2dea1be187176fa680570a40c7aec4faaba749f6a85fac1854ed871366b7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 04:13:43.661048) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 04:13:43.661350) ========= 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=dac658600622fd96716c9acf000001b3-1506076569.613623-1135743643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 04:13:43.741766) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 04:13:43.742088) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 04:13:43.742400) ========= ========= Total master_lag: 0.30 =========