builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1505297785.61 results: success (0) revision: 124f2094635bbf1901c1d14fc2c0a80bf7f847bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 03:16:25.605506) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 03:16:25.605904) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 03:16:25.606190) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 03:16:25.725609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:16:25.725861) ========= 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=745a4373a2a16df560f216e000000264-1505297761.910715-425634638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 03:16:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2017-09-13 03:16:25 (230 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102250 ========= master_lag: 0.62 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:16:26.443711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:16:26.444039) ========= 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=745a4373a2a16df560f216e000000264-1505297761.910715-425634638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020729 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:16:26.550985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-13 03:16:26.551326) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 124f2094635bbf1901c1d14fc2c0a80bf7f847bb --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 124f2094635bbf1901c1d14fc2c0a80bf7f847bb --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=745a4373a2a16df560f216e000000264-1505297761.910715-425634638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 03:16:26,513 truncating revision to first 12 chars 2017-09-13 03:16:26,513 Setting DEBUG logging. 2017-09-13 03:16:26,513 attempt 1/10 2017-09-13 03:16:26,513 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/124f2094635b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 03:16:26,887 attempt 1/10 2017-09-13 03:16:27,503 current task status: no status available at this point. state: STARTED 2017-09-13 03:16:27,503 sleeping for 10.00s (attempt 1/10) 2017-09-13 03:16:37,513 attempt 2/10 2017-09-13 03:16:37,835 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-13 03:16:38,021 unpacking tar archive at: mozilla-central-124f2094635b/testing/mozharness/ program finished with exit code 0 elapsedTime=11.782341 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-13 03:16:38.371001) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 03:16:38.371305) ========= script_repo_revision: 124f2094635bbf1901c1d14fc2c0a80bf7f847bb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 03:16:38.371694) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 03:16:38.371952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 03:16:38.391874) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-13 03:16:38.392220) ========= /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=745a4373a2a16df560f216e000000264-1505297761.910715-425634638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:16:38 INFO - MultiFileLogger online at 20170913 03:16:38 in /builds/slave/test 03:16:38 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:16:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:16:38 INFO - {'append_to_log': False, 03:16:38 INFO - 'base_work_dir': '/builds/slave/test', 03:16:38 INFO - 'blob_upload_branch': 'Firefox', 03:16:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:16:38 INFO - 'branch': 'Firefox', 03:16:38 INFO - 'buildbot_json_path': 'buildprops.json', 03:16:38 INFO - 'code_coverage': False, 03:16:38 INFO - 'config_files': ('talos/linux_config.py',), 03:16:38 INFO - 'default_actions': ('clobber', 03:16:38 INFO - 'read-buildbot-config', 03:16:38 INFO - 'download-and-extract', 03:16:38 INFO - 'populate-webroot', 03:16:38 INFO - 'create-virtualenv', 03:16:38 INFO - 'install', 03:16:38 INFO - 'setup-mitmproxy', 03:16:38 INFO - 'run-tests'), 03:16:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:16:38 INFO - 'disable_ccov_upload': False, 03:16:38 INFO - 'disable_stylo': False, 03:16:38 INFO - 'download_minidump_stackwalk': True, 03:16:38 INFO - 'download_symbols': 'ondemand', 03:16:38 INFO - 'enable_stylo': False, 03:16:38 INFO - 'enable_webrender': False, 03:16:38 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:16:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:16:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:16:38 INFO - 'gecko_profile': False, 03:16:38 INFO - 'gecko_profile_interval': 0, 03:16:38 INFO - 'installer_path': 'installer.exe', 03:16:38 INFO - 'log_level': 'info', 03:16:38 INFO - 'log_name': 'talos', 03:16:38 INFO - 'log_to_console': True, 03:16:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:16:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:16:38 INFO - 'opt_config_files': (), 03:16:38 INFO - 'pip_index': False, 03:16:38 INFO - 'suite': 'dromaeojs-e10s', 03:16:38 INFO - 'system_bits': '32', 03:16:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:16:38 INFO - 'title': 'talos-linux64-ix-032', 03:16:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:16:38 INFO - 'use_talos_json': True, 03:16:38 INFO - 'verify': 'False', 03:16:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:16:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:16:38 INFO - 'work_dir': 'build'} 03:16:38 INFO - [mozharness: 2017-09-13 10:16:38.480479Z] Running clobber step. 03:16:38 INFO - Running pre-action listener: _resource_record_pre_action 03:16:38 INFO - Running main action method: clobber 03:16:38 INFO - rmtree: /builds/slave/test/build 03:16:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:16:39 INFO - Running post-action listener: _resource_record_post_action 03:16:39 INFO - [mozharness: 2017-09-13 10:16:39.509768Z] Finished clobber step (success) 03:16:39 INFO - [mozharness: 2017-09-13 10:16:39.509867Z] Running read-buildbot-config step. 03:16:39 INFO - Running pre-action listener: _resource_record_pre_action 03:16:39 INFO - Running main action method: read_buildbot_config 03:16:39 INFO - Using buildbot properties: 03:16:39 INFO - { 03:16:39 INFO - "project": "", 03:16:39 INFO - "product": "firefox", 03:16:39 INFO - "who": "archaeopteryx@coole-files.de", 03:16:39 INFO - "installer_path": "public/build/target.tar.bz2", 03:16:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:16:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:16:39 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:16:39 INFO - "stage_platform": "linux64-qr", 03:16:39 INFO - "basedir": "/builds/slave/test", 03:16:39 INFO - "buildnumber": 46, 03:16:39 INFO - "platform": "ubuntu64_hw_qr", 03:16:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:16:39 INFO - "slavebuilddir": "test", 03:16:39 INFO - "taskId": "KuoKAcFlSyOsluJVvO1JBA", 03:16:39 INFO - "branch": "mozilla-central", 03:16:39 INFO - "script_repo_revision": "production", 03:16:39 INFO - "revision": "124f2094635bbf1901c1d14fc2c0a80bf7f847bb", 03:16:39 INFO - "slavename": "talos-linux64-ix-032", 03:16:39 INFO - "repo_path": "mozilla-central" 03:16:39 INFO - } 03:16:39 INFO - Finding installer, test and symbols from parent task. 03:16:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KuoKAcFlSyOsluJVvO1JBA'}, attempt #1 03:16:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KuoKAcFlSyOsluJVvO1JBA'}, attempt #1 03:16:40 INFO - Task dependencies: PtRvbvlCQYK7a280i3EPGQ 03:16:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ'}, attempt #1 03:16:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.tar.bz2 03:16:40 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.test_packages.json 03:16:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.crashreporter-symbols.zip 03:16:40 INFO - Running post-action listener: _resource_record_post_action 03:16:40 INFO - [mozharness: 2017-09-13 10:16:40.935927Z] Finished read-buildbot-config step (success) 03:16:40 INFO - [mozharness: 2017-09-13 10:16:40.936144Z] Running download-and-extract step. 03:16:40 INFO - Running pre-action listener: _resource_record_pre_action 03:16:40 INFO - Running main action method: download_and_extract 03:16:40 INFO - mkdir: /builds/slave/test/build/tests 03:16:40 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:16:40 INFO - trying https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.test_packages.json 03:16:40 INFO - Downloading https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:16:41 INFO - Downloaded 989 bytes. 03:16:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:16:41 INFO - Using the following test package requirements: 03:16:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:16:41 INFO - u'common': [u'target.common.tests.zip'], 03:16:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:16:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:16:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:16:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:16:41 INFO - u'mozbase': [u'target.common.tests.zip'], 03:16:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:16:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:16:41 INFO - u'web-platform': [u'target.common.tests.zip', 03:16:41 INFO - u'target.web-platform.tests.tar.gz'], 03:16:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:16:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:16:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.common.tests.zip 03:16:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:16:41 INFO - Fetch https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.common.tests.zip into memory 03:16:42 INFO - Content-Length response header: 55043887 03:16:42 INFO - Bytes received: 55043887 03:16:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.talos.tests.zip 03:16:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:16:53 INFO - Fetch https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.talos.tests.zip into memory 03:16:54 INFO - Content-Length response header: 14499231 03:16:54 INFO - Bytes received: 14499231 03:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:54 INFO - trying https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.tar.bz2 03:16:54 INFO - Downloading https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:16:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:16:55 INFO - Downloaded 62966811 bytes. 03:16:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.tar.bz2 03:16:56 INFO - mkdir: /builds/slave/test/properties 03:16:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:16:56 INFO - Writing to file /builds/slave/test/properties/build_url 03:16:56 INFO - Contents: 03:16:56 INFO - build_url:https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.tar.bz2 03:16:56 INFO - Running post-action listener: _resource_record_post_action 03:16:56 INFO - Running post-action listener: find_tests_for_verification 03:16:56 INFO - Running post-action listener: set_extra_try_arguments 03:16:56 INFO - [mozharness: 2017-09-13 10:16:56.242391Z] Finished download-and-extract step (success) 03:16:56 INFO - [mozharness: 2017-09-13 10:16:56.242623Z] Running populate-webroot step. 03:16:56 INFO - Running pre-action listener: _resource_record_pre_action 03:16:56 INFO - Running main action method: populate_webroot 03:16:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:16:56 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:16:56 INFO - 'tests': ['tresize', 03:16:56 INFO - 'tcanvasmark']}, 03:16:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:16:56 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:16:56 INFO - 'tests': ['dromaeo_css', 03:16:56 INFO - 'kraken']}, 03:16:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:16:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:56 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:16:56 INFO - 'talos_options': ['--disable-stylo'], 03:16:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:16:56 INFO - 'tests': ['damp', 'tps']}, 03:16:56 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:16:56 INFO - 'talos_options': ['--disable-stylo'], 03:16:56 INFO - 'tests': ['damp', 'tps']}, 03:16:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:16:56 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:16:56 INFO - 'tests': ['dromaeo_dom']}, 03:16:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:16:56 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:16:56 INFO - 'tests': ['basic_compositor_video', 03:16:56 INFO - 'glvideo']}, 03:16:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:16:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:16:56 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:16:56 INFO - 'talos_options': ['--disable-stylo'], 03:16:56 INFO - 'tests': ['ts_paint_webext', 03:16:56 INFO - 'tp5o_webext']}, 03:16:56 INFO - 'other-e10s': {'tests': ['a11yr', 03:16:56 INFO - 'ts_paint', 03:16:56 INFO - 'tpaint', 03:16:56 INFO - 'sessionrestore', 03:16:56 INFO - 'sessionrestore_many_windows', 03:16:56 INFO - 'sessionrestore_no_auto_restore', 03:16:56 INFO - 'tabpaint']}, 03:16:56 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:16:56 INFO - 'tests': ['a11yr', 03:16:56 INFO - 'ts_paint', 03:16:56 INFO - 'tpaint', 03:16:56 INFO - 'sessionrestore', 03:16:56 INFO - 'sessionrestore_many_windows', 03:16:56 INFO - 'sessionrestore_no_auto_restore', 03:16:56 INFO - 'tabpaint']}, 03:16:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:16:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:16:56 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:16:56 INFO - 'tests': ['bloom_basic_singleton']}, 03:16:56 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:16:56 INFO - 'tests': ['bloom_basic']}, 03:16:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:16:56 INFO - 'tsvgr_opacity', 03:16:56 INFO - 'tart', 03:16:56 INFO - 'tscrollx', 03:16:56 INFO - 'tsvg_static']}, 03:16:56 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:16:56 INFO - 'tests': ['tsvgx', 03:16:56 INFO - 'tsvgr_opacity', 03:16:56 INFO - 'tart', 03:16:56 INFO - 'tscrollx', 03:16:56 INFO - 'tsvg_static']}, 03:16:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:16:56 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:16:56 INFO - 'talos_options': ['--disable-stylo'], 03:16:56 INFO - 'tests': ['tp5o']}, 03:16:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:16:56 INFO - 'talos_options': ['--mitmproxy', 03:16:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:16:56 INFO - '--firstNonBlankPaint'], 03:16:56 INFO - 'tests': ['tp6_google', 03:16:56 INFO - 'tp6_youtube', 03:16:56 INFO - 'tp6_amazon', 03:16:56 INFO - 'tp6_facebook']}, 03:16:56 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:16:56 INFO - 'talos_options': ['--disable-stylo', 03:16:56 INFO - '--mitmproxy', 03:16:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:16:56 INFO - '--firstNonBlankPaint'], 03:16:56 INFO - 'tests': ['tp6_google', 03:16:56 INFO - 'tp6_youtube', 03:16:56 INFO - 'tp6_amazon', 03:16:56 INFO - 'tp6_facebook']}, 03:16:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:16:56 INFO - 'talos_options': ['--stylo-threads=1', 03:16:56 INFO - '--mitmproxy', 03:16:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:16:56 INFO - '--firstNonBlankPaint'], 03:16:56 INFO - 'tests': ['tp6_google', 03:16:56 INFO - 'tp6_youtube', 03:16:56 INFO - 'tp6_amazon', 03:16:56 INFO - 'tp6_facebook']}, 03:16:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:16:56 INFO - 'talos_options': ['--xperf_path', 03:16:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:56 INFO - 'tests': ['tp5n']}, 03:16:56 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:16:56 INFO - 'talos_options': ['--disable-stylo', 03:16:56 INFO - '--xperf_path', 03:16:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:56 INFO - 'tests': ['tp5n']}}} 03:16:56 INFO - Running post-action listener: _resource_record_post_action 03:16:56 INFO - [mozharness: 2017-09-13 10:16:56.262469Z] Finished populate-webroot step (success) 03:16:56 INFO - [mozharness: 2017-09-13 10:16:56.262558Z] Running create-virtualenv step. 03:16:56 INFO - Running pre-action listener: _resource_record_pre_action 03:16:56 INFO - Running main action method: create_virtualenv 03:16:56 INFO - Creating virtualenv /builds/slave/test/build/venv 03:16:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:16:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:16:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:16:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:16:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:16:56 INFO - Installing distribute.............................................................................................................................................................................................done. 03:16:57 INFO - Installing pip...............done. 03:16:57 INFO - Return code: 0 03:16:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:16:57 INFO - Reading from file tmpfile_stdout 03:16:57 INFO - Output received: 03:16:57 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:16:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:57 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 0x17321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2090>, '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 0x1aa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf90>, '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': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', '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:16:57 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:16:57 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:16:57 INFO - Using env: {'DISPLAY': ':0', 03:16:57 INFO - 'HOME': '/home/cltbld', 03:16:57 INFO - 'LANG': 'en_US.UTF-8', 03:16:57 INFO - 'LANGUAGE': 'en_US:en', 03:16:57 INFO - 'LOGNAME': 'cltbld', 03:16:57 INFO - 'MAIL': '/var/mail/cltbld', 03:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:57 INFO - 'MOZ_NO_REMOTE': '1', 03:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:57 INFO - 'NO_EM_RESTART': '1', 03:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:57 INFO - 'PWD': '/builds/slave/test', 03:16:57 INFO - 'SHELL': '/bin/bash', 03:16:57 INFO - 'SHLVL': '1', 03:16:57 INFO - 'TERM': 'linux', 03:16:57 INFO - 'TMOUT': '86400', 03:16:57 INFO - 'USER': 'cltbld', 03:16:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', 03:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:57 INFO - '_': '/tools/buildbot/bin/python'} 03:16:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:16:58 INFO - Downloading/unpacking pip>=1.5 03:16:58 INFO - Running setup.py egg_info for package pip 03:16:58 INFO - warning: no files found matching 'pip/cacert.pem' 03:16:58 INFO - warning: no files found matching '*.html' under directory 'docs' 03:16:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:16:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:16:58 INFO - Installing collected packages: pip 03:16:58 INFO - Found existing installation: pip 1.1 03:16:58 INFO - Uninstalling pip: 03:16:58 INFO - Successfully uninstalled pip 03:16:58 INFO - Running setup.py install for pip 03:16:58 INFO - warning: no files found matching 'pip/cacert.pem' 03:16:58 INFO - warning: no files found matching '*.html' under directory 'docs' 03:16:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:16:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:16:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:16:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:16:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:16:58 INFO - Successfully installed pip 03:16:58 INFO - Cleaning up... 03:16:58 INFO - Return code: 0 03:16:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:58 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 0x17321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2090>, '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 0x1aa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf90>, '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': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', '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:16:58 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:16:58 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:16:58 INFO - Using env: {'DISPLAY': ':0', 03:16:58 INFO - 'HOME': '/home/cltbld', 03:16:58 INFO - 'LANG': 'en_US.UTF-8', 03:16:58 INFO - 'LANGUAGE': 'en_US:en', 03:16:58 INFO - 'LOGNAME': 'cltbld', 03:16:58 INFO - 'MAIL': '/var/mail/cltbld', 03:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:58 INFO - 'MOZ_NO_REMOTE': '1', 03:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:58 INFO - 'NO_EM_RESTART': '1', 03:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:58 INFO - 'PWD': '/builds/slave/test', 03:16:58 INFO - 'SHELL': '/bin/bash', 03:16:58 INFO - 'SHLVL': '1', 03:16:58 INFO - 'TERM': 'linux', 03:16:58 INFO - 'TMOUT': '86400', 03:16:58 INFO - 'USER': 'cltbld', 03:16:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', 03:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:58 INFO - '_': '/tools/buildbot/bin/python'} 03:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:58 INFO - Downloading/unpacking psutil>=3.1.1 03:16:58 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:16:58 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:16:58 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:16:58 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:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:16:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:59 INFO - Installing collected packages: psutil 03:16:59 INFO - Running setup.py install for psutil 03:16:59 INFO - building 'psutil._psutil_linux' extension 03:17:00 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:17:00 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:17:00 INFO - building 'psutil._psutil_posix' extension 03:17:00 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:17:00 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:17:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:00 INFO - Successfully installed psutil 03:17:00 INFO - Cleaning up... 03:17:00 INFO - Return code: 0 03:17:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:00 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 0x17321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2090>, '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 0x1aa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf90>, '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': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', '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:17:00 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:17:00 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:17:00 INFO - Using env: {'DISPLAY': ':0', 03:17:00 INFO - 'HOME': '/home/cltbld', 03:17:00 INFO - 'LANG': 'en_US.UTF-8', 03:17:00 INFO - 'LANGUAGE': 'en_US:en', 03:17:00 INFO - 'LOGNAME': 'cltbld', 03:17:00 INFO - 'MAIL': '/var/mail/cltbld', 03:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:00 INFO - 'MOZ_NO_REMOTE': '1', 03:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:00 INFO - 'NO_EM_RESTART': '1', 03:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:00 INFO - 'PWD': '/builds/slave/test', 03:17:00 INFO - 'SHELL': '/bin/bash', 03:17:00 INFO - 'SHLVL': '1', 03:17:00 INFO - 'TERM': 'linux', 03:17:00 INFO - 'TMOUT': '86400', 03:17:00 INFO - 'USER': 'cltbld', 03:17:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', 03:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:00 INFO - '_': '/tools/buildbot/bin/python'} 03:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:17:01 INFO - Installing collected packages: mozsystemmonitor 03:17:01 INFO - Running setup.py install for mozsystemmonitor 03:17:01 INFO - Successfully installed mozsystemmonitor 03:17:01 INFO - Cleaning up... 03:17:02 INFO - Return code: 0 03:17:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:02 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 0x17321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2090>, '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 0x1aa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf90>, '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': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', '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:17:02 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:17:02 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:17:02 INFO - Using env: {'DISPLAY': ':0', 03:17:02 INFO - 'HOME': '/home/cltbld', 03:17:02 INFO - 'LANG': 'en_US.UTF-8', 03:17:02 INFO - 'LANGUAGE': 'en_US:en', 03:17:02 INFO - 'LOGNAME': 'cltbld', 03:17:02 INFO - 'MAIL': '/var/mail/cltbld', 03:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:02 INFO - 'MOZ_NO_REMOTE': '1', 03:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:02 INFO - 'NO_EM_RESTART': '1', 03:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:02 INFO - 'PWD': '/builds/slave/test', 03:17:02 INFO - 'SHELL': '/bin/bash', 03:17:02 INFO - 'SHLVL': '1', 03:17:02 INFO - 'TERM': 'linux', 03:17:02 INFO - 'TMOUT': '86400', 03:17:02 INFO - 'USER': 'cltbld', 03:17:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', 03:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:02 INFO - '_': '/tools/buildbot/bin/python'} 03:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:03 INFO - Downloading/unpacking jsonschema==2.5.1 03:17:03 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:17:03 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:17:03 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:17:03 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:17:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:17:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:04 INFO - Downloading functools32-3.2.3-2.tar.gz 03:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:17:04 INFO - warning: no files found matching '*.txt' 03:17:04 INFO - no previously-included directories found matching 'build' 03:17:04 INFO - no previously-included directories found matching 'dist' 03:17:04 INFO - no previously-included directories found matching '.git*' 03:17:04 INFO - Installing collected packages: jsonschema, functools32 03:17:06 INFO - Running setup.py install for functools32 03:17:06 INFO - warning: no files found matching '*.txt' 03:17:06 INFO - no previously-included directories found matching 'build' 03:17:06 INFO - no previously-included directories found matching 'dist' 03:17:06 INFO - no previously-included directories found matching '.git*' 03:17:06 INFO - Successfully installed jsonschema functools32 03:17:06 INFO - Cleaning up... 03:17:06 INFO - Return code: 0 03:17:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2090>, '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 0x1aa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf90>, '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': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', '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:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:17:06 INFO - Using env: {'DISPLAY': ':0', 03:17:06 INFO - 'HOME': '/home/cltbld', 03:17:06 INFO - 'LANG': 'en_US.UTF-8', 03:17:06 INFO - 'LANGUAGE': 'en_US:en', 03:17:06 INFO - 'LOGNAME': 'cltbld', 03:17:06 INFO - 'MAIL': '/var/mail/cltbld', 03:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:06 INFO - 'MOZ_NO_REMOTE': '1', 03:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:06 INFO - 'NO_EM_RESTART': '1', 03:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:06 INFO - 'PWD': '/builds/slave/test', 03:17:06 INFO - 'SHELL': '/bin/bash', 03:17:06 INFO - 'SHLVL': '1', 03:17:06 INFO - 'TERM': 'linux', 03:17:06 INFO - 'TMOUT': '86400', 03:17:06 INFO - 'USER': 'cltbld', 03:17:06 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', 03:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:06 INFO - '_': '/tools/buildbot/bin/python'} 03:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:17:06 INFO - Cleaning up... 03:17:06 INFO - Return code: 0 03:17:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2090>, '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 0x1aa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf90>, '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': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', '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:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:17:06 INFO - Using env: {'DISPLAY': ':0', 03:17:06 INFO - 'HOME': '/home/cltbld', 03:17:06 INFO - 'LANG': 'en_US.UTF-8', 03:17:06 INFO - 'LANGUAGE': 'en_US:en', 03:17:06 INFO - 'LOGNAME': 'cltbld', 03:17:06 INFO - 'MAIL': '/var/mail/cltbld', 03:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:06 INFO - 'MOZ_NO_REMOTE': '1', 03:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:06 INFO - 'NO_EM_RESTART': '1', 03:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:06 INFO - 'PWD': '/builds/slave/test', 03:17:06 INFO - 'SHELL': '/bin/bash', 03:17:06 INFO - 'SHLVL': '1', 03:17:06 INFO - 'TERM': 'linux', 03:17:06 INFO - 'TMOUT': '86400', 03:17:06 INFO - 'USER': 'cltbld', 03:17:06 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', 03:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:06 INFO - '_': '/tools/buildbot/bin/python'} 03:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:07 INFO - Downloading/unpacking blobuploader==1.2.4 03:17:07 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:17:07 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:17:07 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:17:07 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:17:08 INFO - Downloading blobuploader-1.2.4.tar.gz 03:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:17:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:17:08 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:17:08 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:17:08 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:17:08 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:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:17:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:17:08 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:17:08 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:17:08 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:17:08 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:17:08 INFO - Downloading docopt-0.6.1.tar.gz 03:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:17:08 INFO - Installing collected packages: blobuploader, requests, docopt 03:17:08 INFO - Running setup.py install for blobuploader 03:17:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:17:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:17:08 INFO - Running setup.py install for requests 03:17:09 INFO - Running setup.py install for docopt 03:17:09 INFO - Successfully installed blobuploader requests docopt 03:17:09 INFO - Cleaning up... 03:17:09 INFO - Return code: 0 03:17:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:09 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 0x17321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2090>, '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 0x1aa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf90>, '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': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', '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:17:09 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:17:09 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:17:09 INFO - Using env: {'DISPLAY': ':0', 03:17:09 INFO - 'HOME': '/home/cltbld', 03:17:09 INFO - 'LANG': 'en_US.UTF-8', 03:17:09 INFO - 'LANGUAGE': 'en_US:en', 03:17:09 INFO - 'LOGNAME': 'cltbld', 03:17:09 INFO - 'MAIL': '/var/mail/cltbld', 03:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:09 INFO - 'MOZ_NO_REMOTE': '1', 03:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:09 INFO - 'NO_EM_RESTART': '1', 03:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:09 INFO - 'PWD': '/builds/slave/test', 03:17:09 INFO - 'SHELL': '/bin/bash', 03:17:09 INFO - 'SHLVL': '1', 03:17:09 INFO - 'TERM': 'linux', 03:17:09 INFO - 'TMOUT': '86400', 03:17:09 INFO - 'USER': 'cltbld', 03:17:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', 03:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:09 INFO - '_': '/tools/buildbot/bin/python'} 03:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:09 INFO - Running setup.py (path:/tmp/pip-OcGd1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:09 INFO - Running setup.py (path:/tmp/pip-RmjXCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:09 INFO - Running setup.py (path:/tmp/pip-8JANMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:09 INFO - Running setup.py (path:/tmp/pip-FzNC2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:09 INFO - Running setup.py (path:/tmp/pip-iHFESS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:09 INFO - Running setup.py (path:/tmp/pip-FPrCg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:10 INFO - Running setup.py (path:/tmp/pip-Nb3kQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:10 INFO - Running setup.py (path:/tmp/pip-f6acO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:10 INFO - Running setup.py (path:/tmp/pip-3YRYo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:10 INFO - Running setup.py (path:/tmp/pip-WDDfvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:10 INFO - Running setup.py (path:/tmp/pip-qGnzlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:10 INFO - Running setup.py (path:/tmp/pip-ui0U4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:10 INFO - Running setup.py (path:/tmp/pip-yoPET3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:10 INFO - Running setup.py (path:/tmp/pip-7Pf67N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:10 INFO - Running setup.py (path:/tmp/pip-j2DX3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:10 INFO - Running setup.py (path:/tmp/pip-9to2Fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:10 INFO - Running setup.py (path:/tmp/pip-AYnJDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:17:10 INFO - Running setup.py install for manifestparser 03:17:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:17:10 INFO - Running setup.py install for mozcrash 03:17:11 INFO - Running setup.py install for mozdebug 03:17:11 INFO - Running setup.py install for mozdevice 03:17:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:17:11 INFO - Running setup.py install for mozfile 03:17:11 INFO - Running setup.py install for mozhttpd 03:17:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:17:11 INFO - Running setup.py install for mozinfo 03:17:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:17:11 INFO - Running setup.py install for mozInstall 03:17:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:17:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:17:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:17:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:17:11 INFO - Running setup.py install for mozleak 03:17:11 INFO - Running setup.py install for mozlog 03:17:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:17:11 INFO - Running setup.py install for moznetwork 03:17:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:17:11 INFO - Running setup.py install for mozprocess 03:17:12 INFO - Running setup.py install for mozprofile 03:17:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:17:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:17:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:17:12 INFO - Running setup.py install for mozrunner 03:17:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:17:12 INFO - Running setup.py install for mozscreenshot 03:17:12 INFO - Running setup.py install for moztest 03:17:12 INFO - Running setup.py install for mozversion 03:17:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:17:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:17:12 INFO - Cleaning up... 03:17:12 INFO - Return code: 0 03:17:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:12 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 0x17321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2090>, '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 0x1aa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf90>, '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': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', '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:17:12 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:17:12 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:17:12 INFO - Using env: {'DISPLAY': ':0', 03:17:12 INFO - 'HOME': '/home/cltbld', 03:17:12 INFO - 'LANG': 'en_US.UTF-8', 03:17:12 INFO - 'LANGUAGE': 'en_US:en', 03:17:12 INFO - 'LOGNAME': 'cltbld', 03:17:12 INFO - 'MAIL': '/var/mail/cltbld', 03:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:12 INFO - 'MOZ_NO_REMOTE': '1', 03:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:12 INFO - 'NO_EM_RESTART': '1', 03:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:12 INFO - 'PWD': '/builds/slave/test', 03:17:12 INFO - 'SHELL': '/bin/bash', 03:17:12 INFO - 'SHLVL': '1', 03:17:12 INFO - 'TERM': 'linux', 03:17:12 INFO - 'TMOUT': '86400', 03:17:12 INFO - 'USER': 'cltbld', 03:17:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', 03:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:12 INFO - '_': '/tools/buildbot/bin/python'} 03:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:12 INFO - Running setup.py (path:/tmp/pip-kSp8v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:12 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:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:12 INFO - Running setup.py (path:/tmp/pip-i32ndX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:12 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:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:12 INFO - Running setup.py (path:/tmp/pip-Y_PlcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:13 INFO - Running setup.py (path:/tmp/pip-xxToU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:13 INFO - Running setup.py (path:/tmp/pip-jtKTy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:13 INFO - Running setup.py (path:/tmp/pip-7BGoe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:13 INFO - Running setup.py (path:/tmp/pip-HXh1AF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:13 INFO - Running setup.py (path:/tmp/pip-KV7mI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:13 INFO - Running setup.py (path:/tmp/pip-HZ2NNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:13 INFO - Running setup.py (path:/tmp/pip-AaLBai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:13 INFO - Running setup.py (path:/tmp/pip-y3l4Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:13 INFO - Running setup.py (path:/tmp/pip-8ROYz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:13 INFO - Running setup.py (path:/tmp/pip-0O_j8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:13 INFO - Running setup.py (path:/tmp/pip-v2vjIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:13 INFO - Running setup.py (path:/tmp/pip-F6QUGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:13 INFO - Running setup.py (path:/tmp/pip-h2IitK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:13 INFO - Running setup.py (path:/tmp/pip-iFt5O7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:14 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:17:14 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:17:14 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:17:14 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:17:14 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:17:14 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:17:14 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:17:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:15 INFO - Downloading blessings-1.6.tar.gz 03:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:17:15 INFO - Installing collected packages: blessings 03:17:15 INFO - Running setup.py install for blessings 03:17:15 INFO - Successfully installed blessings 03:17:15 INFO - Cleaning up... 03:17:15 INFO - Return code: 0 03:17:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:15 INFO - Reading from file tmpfile_stdout 03:17:15 INFO - Current package versions: 03:17:15 INFO - argparse == 1.2.1 03:17:15 INFO - blessings == 1.6 03:17:15 INFO - blobuploader == 1.2.4 03:17:15 INFO - docopt == 0.6.1 03:17:15 INFO - functools32 == 3.2.3-2 03:17:15 INFO - jsonschema == 2.5.1 03:17:15 INFO - manifestparser == 1.1 03:17:15 INFO - mozInstall == 1.13 03:17:15 INFO - mozcrash == 1.0 03:17:15 INFO - mozdebug == 0.1 03:17:15 INFO - mozdevice == 0.51 03:17:15 INFO - mozfile == 1.2 03:17:15 INFO - mozhttpd == 0.7 03:17:15 INFO - mozinfo == 0.10 03:17:15 INFO - mozleak == 0.1 03:17:15 INFO - mozlog == 3.5 03:17:15 INFO - moznetwork == 0.27 03:17:15 INFO - mozprocess == 0.25 03:17:15 INFO - mozprofile == 0.28 03:17:15 INFO - mozrunner == 6.13 03:17:15 INFO - mozscreenshot == 0.1 03:17:15 INFO - mozsystemmonitor == 0.3 03:17:15 INFO - moztest == 0.8 03:17:15 INFO - mozversion == 1.4 03:17:15 INFO - psutil == 3.1.1 03:17:15 INFO - requests == 1.2.3 03:17:15 INFO - wsgiref == 0.1.2 03:17:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:15 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 0x17321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2090>, '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 0x1aa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf90>, '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': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', '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:17:15 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:17:15 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:17:15 INFO - Using env: {'DISPLAY': ':0', 03:17:15 INFO - 'HOME': '/home/cltbld', 03:17:15 INFO - 'LANG': 'en_US.UTF-8', 03:17:15 INFO - 'LANGUAGE': 'en_US:en', 03:17:15 INFO - 'LOGNAME': 'cltbld', 03:17:15 INFO - 'MAIL': '/var/mail/cltbld', 03:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:15 INFO - 'MOZ_NO_REMOTE': '1', 03:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:15 INFO - 'NO_EM_RESTART': '1', 03:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:15 INFO - 'PWD': '/builds/slave/test', 03:17:15 INFO - 'SHELL': '/bin/bash', 03:17:15 INFO - 'SHLVL': '1', 03:17:15 INFO - 'TERM': 'linux', 03:17:15 INFO - 'TMOUT': '86400', 03:17:15 INFO - 'USER': 'cltbld', 03:17:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', 03:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:15 INFO - '_': '/tools/buildbot/bin/python'} 03:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:15 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:17:15 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:17:15 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:17:15 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:17:15 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:17:15 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:17:15 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:17:15 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:17:15 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:17:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:17:16 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:17:16 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:17:17 INFO - Installing collected packages: simplejson 03:17:17 INFO - Running setup.py install for simplejson 03:17:17 INFO - building 'simplejson._speedups' extension 03:17:17 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:17:17 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:17:18 INFO - Successfully installed simplejson 03:17:18 INFO - Cleaning up... 03:17:18 INFO - Return code: 0 03:17:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:18 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 0x17321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2090>, '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 0x1aa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf90>, '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': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', '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:17:18 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:17:18 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:17:18 INFO - Using env: {'DISPLAY': ':0', 03:17:18 INFO - 'HOME': '/home/cltbld', 03:17:18 INFO - 'LANG': 'en_US.UTF-8', 03:17:18 INFO - 'LANGUAGE': 'en_US:en', 03:17:18 INFO - 'LOGNAME': 'cltbld', 03:17:18 INFO - 'MAIL': '/var/mail/cltbld', 03:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:18 INFO - 'MOZ_NO_REMOTE': '1', 03:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:18 INFO - 'NO_EM_RESTART': '1', 03:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:18 INFO - 'PWD': '/builds/slave/test', 03:17:18 INFO - 'SHELL': '/bin/bash', 03:17:18 INFO - 'SHLVL': '1', 03:17:18 INFO - 'TERM': 'linux', 03:17:18 INFO - 'TMOUT': '86400', 03:17:18 INFO - 'USER': 'cltbld', 03:17:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', 03:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:18 INFO - '_': '/tools/buildbot/bin/python'} 03:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:17:18 INFO - Cleaning up... 03:17:18 INFO - Return code: 0 03:17:18 INFO - Running post-action listener: _resource_record_post_action 03:17:18 INFO - Running post-action listener: _start_resource_monitoring 03:17:18 INFO - Starting resource monitoring. 03:17:18 INFO - [mozharness: 2017-09-13 10:17:18.308128Z] Finished create-virtualenv step (success) 03:17:18 INFO - [mozharness: 2017-09-13 10:17:18.308643Z] Running install step. 03:17:18 INFO - Running pre-action listener: _resource_record_pre_action 03:17:18 INFO - Running main action method: install 03:17:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:18 INFO - Reading from file tmpfile_stdout 03:17:18 INFO - Detecting whether we're running mozinstall >=1.0... 03:17:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:17:18 INFO - Reading from file tmpfile_stdout 03:17:18 INFO - Output received: 03:17:18 INFO - Usage: mozinstall [options] installer 03:17:18 INFO - Options: 03:17:18 INFO - -h, --help show this help message and exit 03:17:18 INFO - -d DEST, --destination=DEST 03:17:18 INFO - Directory to install application into. [default: 03:17:18 INFO - "/builds/slave/test"] 03:17:18 INFO - --app=APP Application being installed. [default: firefox] 03:17:18 INFO - mkdir: /builds/slave/test/build/application 03:17:18 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:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:17:35 INFO - Reading from file tmpfile_stdout 03:17:35 INFO - Output received: 03:17:35 INFO - /builds/slave/test/build/application/firefox/firefox 03:17:35 INFO - Running post-action listener: _resource_record_post_action 03:17:35 INFO - [mozharness: 2017-09-13 10:17:35.499225Z] Finished install step (success) 03:17:35 INFO - [mozharness: 2017-09-13 10:17:35.499478Z] Running setup-mitmproxy step. 03:17:35 INFO - Running pre-action listener: _resource_record_pre_action 03:17:35 INFO - Running main action method: setup_mitmproxy 03:17:35 INFO - Skipping: mitmproxy is not required 03:17:35 INFO - Running post-action listener: _resource_record_post_action 03:17:35 INFO - [mozharness: 2017-09-13 10:17:35.500614Z] Finished setup-mitmproxy step (success) 03:17:35 INFO - [mozharness: 2017-09-13 10:17:35.500833Z] Running run-tests step. 03:17:35 INFO - Running pre-action listener: _resource_record_pre_action 03:17:35 INFO - Running pre-action listener: _set_gcov_prefix 03:17:35 INFO - Running main action method: run_tests 03:17:35 WARNING - Try message not found. 03:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:17:35 INFO - Python 2.7.3 03:17:35 INFO - Return code: 0 03:17:35 INFO - grabbing minidump binary from tooltool 03:17: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:17:35 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 0x1aa2090>, '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 0x1aa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:17:35 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:17:35 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:17:35 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:17:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:17:35 INFO - Return code: 0 03:17:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:17:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:17:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:17:35 INFO - ENV: RUST_BACKTRACE is now full 03:17:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:17:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:17:35 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/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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:17:35 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/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --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:17:35 INFO - Using env: {'DISPLAY': ':0', 03:17:35 INFO - 'HOME': '/home/cltbld', 03:17:35 INFO - 'LANG': 'en_US.UTF-8', 03:17:35 INFO - 'LANGUAGE': 'en_US:en', 03:17:35 INFO - 'LOGNAME': 'cltbld', 03:17:35 INFO - 'MAIL': '/var/mail/cltbld', 03:17:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:17:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:17:35 INFO - 'MOZ_ACCELERATED': '1', 03:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:35 INFO - 'MOZ_NO_REMOTE': '1', 03:17:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:17:35 INFO - 'MOZ_WEBRENDER': '1', 03:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:35 INFO - 'NO_EM_RESTART': '1', 03:17:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:35 INFO - 'PWD': '/builds/slave/test', 03:17:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:17:35 INFO - 'RUST_BACKTRACE': 'full', 03:17:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:17:35 INFO - 'SHELL': '/bin/bash', 03:17:35 INFO - 'SHLVL': '1', 03:17:35 INFO - 'TERM': 'linux', 03:17:35 INFO - 'TMOUT': '86400', 03:17:35 INFO - 'USER': 'cltbld', 03:17:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', 03:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:35 INFO - '_': '/tools/buildbot/bin/python'} 03:17:35 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/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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:17:35 INFO - mozversion application_buildid: 20170913092615 03:17:35 INFO - mozversion application_changeset: 124f2094635bbf1901c1d14fc2c0a80bf7f847bb 03:17:35 INFO - mozversion application_display_name: Nightly 03:17:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:17:35 INFO - mozversion application_name: Firefox 03:17:35 INFO - mozversion application_remotingname: firefox 03:17:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:17:35 INFO - mozversion application_vendor: Mozilla 03:17:35 INFO - mozversion application_version: 57.0a1 03:17:35 INFO - mozversion platform_buildid: 20170913092615 03:17:35 INFO - mozversion platform_changeset: 124f2094635bbf1901c1d14fc2c0a80bf7f847bb 03:17:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:17:35 INFO - mozversion platform_version: 57.0a1 03:17:35 INFO - using testdate: 1505297855 03:17:35 INFO - actual date: 1505297855 03:17:35 INFO - starting webserver on 'localhost:60714' 03:17:35 INFO - SUITE-START | Running 2 tests 03:17:35 INFO - TEST-START | dromaeo_css 03:17:35 INFO - Initialising browser for dromaeo_css test... 03:17:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60714/getInfo.html -profile /tmp/tmpi45waf/profile 03:17:35 INFO - TEST-INFO | started process 15534 (/builds/slave/test/build/application/firefox/firefox http://localhost:60714/getInfo.html) 03:17:43 INFO - TEST-INFO | 15534: exit 0 03:17:43 INFO - Browser initialized. 03:17:43 INFO - Running cycle 1/1 for dromaeo_css test... 03:17:43 INFO - Using env: {'DISPLAY': ':0', 03:17:43 INFO - 'HOME': '/home/cltbld', 03:17:43 INFO - 'JSGC_DISABLE_POISONING': '1', 03:17:43 INFO - 'LANG': 'en_US.UTF-8', 03:17:43 INFO - 'LANGUAGE': 'en_US:en', 03:17:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:17:43 INFO - 'LOGNAME': 'cltbld', 03:17:43 INFO - 'MAIL': '/var/mail/cltbld', 03:17:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:17:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:17:43 INFO - 'MOZ_ACCELERATED': '1', 03:17:43 INFO - 'MOZ_CRASHREPORTER': '1', 03:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:17:43 INFO - 'MOZ_NO_REMOTE': '1', 03:17:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:17:43 INFO - 'MOZ_WEBRENDER': '1', 03:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:43 INFO - 'NO_EM_RESTART': '1', 03:17:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:43 INFO - 'PWD': '/builds/slave/test', 03:17:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:17:43 INFO - 'RUST_BACKTRACE': 'full', 03:17:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:17:43 INFO - 'SHELL': '/bin/bash', 03:17:43 INFO - 'SHLVL': '1', 03:17:43 INFO - 'TERM': 'linux', 03:17:43 INFO - 'TMOUT': '86400', 03:17:43 INFO - 'USER': 'cltbld', 03:17:43 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', 03:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:43 INFO - '_': '/tools/buildbot/bin/python'} 03:17:43 INFO - TEST-INFO | started process 15743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi45waf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:44 INFO - PID 15743 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:17:44 INFO - PID 15743 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:17:44 INFO - PID 15743 | 03:17:44 INFO - PID 15743 | (/builds/slave/test/build/application/firefox/firefox:15804): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:17:44 INFO - PID 15743 | 03:17:54 INFO - PID 15743 | RSS: Main: 212848640 03:17:54 INFO - PID 15743 | 03:20:52 INFO - PID 15743 | Cycle 1(1): loaded http://localhost:60714/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60714/tests/dromaeo/cssquery-ext.html) 03:20:53 INFO - PID 15743 | RSS: Main: 218062848 03:20:53 INFO - PID 15743 | 03:23:56 INFO - PID 15743 | Cycle 1(1): loaded http://localhost:60714/tests/dromaeo/cssquery-ext.html (next: http://localhost:60714/tests/dromaeo/cssquery-jquery.html) 03:23:56 INFO - PID 15743 | RSS: Main: 218177536 03:23:56 INFO - PID 15743 | 03:26:58 INFO - PID 15743 | Cycle 1(1): loaded http://localhost:60714/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60714/tests/dromaeo/cssquery-mootools.html) 03:26:59 INFO - PID 15743 | RSS: Main: 219734016 03:26:59 INFO - PID 15743 | 03:30:01 INFO - PID 15743 | Cycle 1(1): loaded http://localhost:60714/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60714/tests/dromaeo/cssquery-prototype.html) 03:30:02 INFO - PID 15743 | RSS: Main: 217972736 03:30:02 INFO - PID 15743 | 03:33:05 INFO - PID 15743 | Cycle 1(1): loaded http://localhost:60714/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60714/tests/dromaeo/cssquery-yui.html) 03:33:06 INFO - PID 15743 | RSS: Main: 220241920 03:33:06 INFO - PID 15743 | 03:36:08 INFO - PID 15743 | Cycle 1(1): loaded http://localhost:60714/tests/dromaeo/cssquery-yui.html (next: http://localhost:60714/tests/dromaeo/cssquery-dojo.html) 03:36:08 INFO - PID 15743 | RSS: Main: 223318016 03:36:08 INFO - PID 15743 | 03:36:08 INFO - PID 15743 | __start_tp_report 03:36:08 INFO - PID 15743 | _x_x_mozilla_page_load 03:36:08 INFO - PID 15743 | _x_x_mozilla_page_load_details 03:36:08 INFO - PID 15743 | |i|pagename|runs| 03:36:08 INFO - PID 15743 | |0;dojo.html;3130.436521426144;3133.8746450141994;3151.5902932618756;3164.920876978076;3172.3813856298016;6206.348333424993;6280;6315.652639104847;6359.71381287842;6396.872062558752;6195.814125576228;6242.531810114248;6269.68651567421;6271.1533942917695;6296.559240853142;5750.079987202049;5770.163326317682;5792.884142317151;5828.446297601742;5890.322612899528;5851.678157701324;5861.706914654272;5892.292924849003;5908.497777688902;5916.704164791765;5716.1711551825165;5799.594028418012;5850.531957443394;5910.379410161936;5916.437938395846;5368.8389348319615;5764.8847023059725;5777.711114444261;5885.470307672309;5941.019731744257;5694.430556944314;5712.086066229425;5717.456841600041;5767.106098554731;5770.913436298459;6252.562320637558;6280.214973128359;6292.182016337847;6309.810705678791;6322.58903171297;6719.193696756421;6768.357006084414;6768.390844823989;6817.5227734058635;6840.6921688524135;6722.495812814059;6745.527813053088;6813.046173535709;6842.828929276759;6862.245153033212;6223.43989040984;6301.905471417932;6342.809715708536;6352.301246862841;6353.491720662336;6921.342472465108;6935.479839012094;6939.548929319578;7022.613756243456;7042.507024508235;6502.967485162544;6599.5710278832685;6620.437262832616;6634.635095069721;6639.037339585733;6628.767993120217;6670.199576050808;6687.331266873371;6703.765368212089;6707.094542236736;6568.310327415648;6599.538032337787;6641.767538136239;6767.593944363354;6799.252082270947;6672.899906501407;6738.629375384401;6807.2512023677355;6823.215330236987;6827.317268273133;5219.530242278137;5231.738413079331;5296.073187192226;5300.681959082467;5307.65500242483;4591.586757191869;4635.188841952712;4639.373684552542;4645.488996210414;4681.438227412732;5852.151438041546;5855.443732845373;5864.882702345929;5866.7066646668345;5872.853178670567;6769.086173366631;6839.452843772487;6851.760188393382;6853.828654283683;6859.9314006860295;5778.711064446761;5802.274715660543;5863.70681465925;5865.589408741347;5867.119932010232;5647.661140331593;5713.600047996683;5730.770769169187;5776.971115144482;5837.445442682938;6514.120593719787;6571.014347847766;6574.816533024006;6586.8353291168105;6591.703373348211;6693.397594216543;6726.159230096238;6744.224414192235;6747.561408508432;6767.221769496571;6382.744690212339;6472.093906852951;6518;6581.868362632817;6611.867762644624;6546.672666366758;6645.601263923987;6659.2008958925235;6689.063531105747;6692.862213423827;6785.321467853175;6825.2833452486775;6842.281560436082;6864.48516361265;6883.690233939385;6435.806925792233;6493.512986525935;6507.023946408077;6567.638779867153;6590.94544872818;6274.529410294337;6403.167588213502;6442.742290308335;6577.408033276836;6585.967070164618;6265.718042687999;6269.373062693694;6283.685815709105;6285.748570057147;6286.842828929313;6377.808665740035;6433;6479.1901012373455;6696.966515167393;6732.360425759545;6303.1175635412;6303.684815759102;6357.96821015892;6397.360263973565;6410.839729006812 03:36:08 INFO - PID 15743 | |1;ext.html;852.2798235491009;872.1060912564625;873.0004145253685;875;878.0736323179045;38363.61636383635;42089.57910420895;42262;42364.152716945646;42693.35959960603;39105;39273.21453570927;39421.211575768466;39593;39984.200315993665;6909;7024.262452442496;7025.894611580805;7038.296170382972;7521.699132034712;7606.353459955911;7651.426143039266;7723.343515801163;7723.343515801163;7723.575203363813;7664.463487555873;7745.070591529025;7769.689212431496;7783.2216778322;7785.260400261966;7705.113911900119;7732.342750866183;7747.186545412763;7752.883706744376;7754.651040703182;7591.8861217081785;7607.858821176867;7646.961765191194;7691.23087691232;7698.846023079563;37032.814835925645;37037.25925481502;37097.81451092754;37277.81361093204;37463.43804842929;3393.372226138172;3398.7960722356493;3413.7781044232047;3425.1265927188406;3439.914002149941;31133.532997005062;31134.688653113404;31362.21594460134;31462.842685786654;31488.370232595218;4853.19922212838;4865.41615006198;4903.8528844134735;4942.752862356903;4953.6037117030555;186491;186568;186850.99999999863;187315;187426;40078.39882401766;40929.1814163715;46755.532444675795;46998.29502557465;47065.529344706796;49916.50083499119;50918;51117;51337.48662513327;51437.48562514327;13926.721465570632;13988.160710357412;13990.440382384591;14015.299235038206;14024.929875350763;11411.087113030937;11523.76952460946;11572.189946703818;11600.361980091177;11609.419529023515;13616.86383136156;13619.727605447835;13651.658708532168;13760.518381856587;13886.16682999003;5671.9716401418555;5690;5695.487406133385;5707.315122185364;5832.533397328289;1004.9497525123714;1031.159604921986;1038.0864838941684;1042.0725554256717;1055.1347894726405;23272.767272327397;23793.286201413986;23838.16566420167;23838.88080559586;23878.52242955131;1097.8298363753631;1111.1888321525332;1116.9106471482262;1132.6205721083365;1133.0312582741801;12458.377081145907;12502.562410315595;12519.874801252054;12527.56153534622;12576.119671622899;222894;225178;225510;225542;225961;53436.19845702317;53641.1953820693;53655.731721341144;53872.73063634657;53965.73017134889;1398.3288021749618;1431.241442035702;1434.9497767578084;1436.3823555871077;1451.992740036293;22672.206472773374;22748.4312892179;23024.654630180226;23306.184283550672;23572;37008.444873326385;37478.25043499169;37528.81235593805;37570.8121459391;37602.811985939894;190367;191325;191996;192294;193393;28896.855515722287;32377.51433728543;34970;34983.825080874434;35014.47478287777;42428.57571424246;43616;43957.56042439535;44196.55803441924;44448.33327500025;31952.84023579867;32183.034508964767;32404;32515;32704;31886;32096.839515803207;32177.517337240428;32220.19449513781;32876.835615821765;34724.131896702784;35853;36494.8175259122;36619;36708.44937325889;31719.841400792848;31753;31840.68159318377;31870.36259274848;32521;22763.430914226614;23690.28929132129;23940.76059239455;24053.398665033514;24553.017879285344 03:36:08 INFO - PID 15743 | |2;jquery.html;569.9943000569995;570.3668927490487;571.7484306904962;578.3522454850568;579.2585490572067;21910;22750.317490475292;22821.999999999978;22924.426889327777;22950.426239344026;23124;25620.23139305819;25650.23049308519;25806.74193258067;25844.74155258447;6598.604083754966;6741.359570840762;6756.324367563254;6756.628385438824;6770.1875774907085;6556.93443065568;6648.102506161655;6653.2681405045405;6662.034005069287;6662.600243985376;4083.5508094109773;4095.5904409559103;5622.819207966332;6473.773417930373;6626.900596491032;6331.8417039573915;6509.1863517060365;6511.804645860608;6512.283648798652;6512.8697426051685;6026.8493287667725;6043.425874541911;6044.395560443964;6055.606385584967;6060.36366181549;27893.86053069742;28605.427891442054;28734.425311493862;29021.41957160845;29159.854200729074;1962.9411117666493;2015.4961259685078;2020.939371818833;2029.989850050755;2031.207828946712;19098.14058367377;19725.704114438297;19789;19822.70265946012;19826;2296.0012394608398;2351.2711059571416;2400.987995060031;2413.3604594782396;2418;137049;139291;139604;140206;140786;13842.515511957034;14590.41638334476;14701.779473307908;14752.926235368968;15063.322150503254;23236.883815580815;23272.883635581715;23487.41281467977;23492.530149396916;23502;9293.535323233811;9337.766555836159;9470.90529094714;9471.715848524555;9570.33007689455;8528.872066919;8628;8638.308935285162;8660.913390866011;8734.912650873537;8466.195711407407;8671.262942649819;8779.824403511893;9251.790435351899;9293.488858112869;2760.3651160232857;2813.6482939632547;2829.3492496725457;2850.08797184903;2894.0738963531467;965.7054598347431;970.7281961050917;974.6734843827397;993.4287784523927;1004.5278719002057;19272.036398180036;19423.417297481097;19471;19676.114574844167;20094.59810803805;1027.845823126537;1032.7521394865328;1043.1706793099504;1046.2519298701466;1048.2452634103433;10803.081738052197;10844.891551084389;10912.345259284468;11024.44877756109;11111.055560277468;471458;476760;483391;492100;499781;101924.49037754764;102944;102992.48503757433;104293;108188.45905770421;1128.7516746315962;1160.6692092753694;1182.39697754146;1189.6252680405644;1193.1349771415655;17536.736948946032;17682.911585442504;17852.821471785115;17941.820581794014;18018.459446216635;52627.47372526226;52721;52936;53438;53570.73214633902;66588.33411665821;66853.33146668471;67054;67212.3278767206;68529.3147068523;12297.262164270172;13431.731365372443;14340.426382944564;14663.56009319722;14672.119672819237;22255;22414.99132539007;22604.547909042056;22608.660870086635;22911.541769164858;17637.382691605733;17834.28662853471;18175.81824181741;18548.165332559798;18599.72100418522;16414.343426263295;16604.08677522748;16966.151692415577;16967.91516042412;17128.314867405163;18673.346432874783;18886;18912.338068168097;19103;19267.325643602406;14260.928695356457;14410.495632652806;14428.206448645426;14443.205623690377;14493.492727754478;18057.277708891495;18318.175682094603;18391.172397242422;18612.720809187602;18648.720269196245 03:36:08 INFO - PID 15743 | |3;mootools.html;1321.4119716726057;1400.8389035260948;1422.672785259391;1425.9429622815087;1434.76326406143;14651.12093274403;15089.094654320748;15129.697406051873;15197.848021519781;15221.92389038056;14903.40386384546;14971.700565988674;15090.47183348583;15118;15141.924290378533;2712.5524288492375;2750.9037183698574;2780.4439112177542;2792.4135931454316;2801.957970630442;2727.5090483712925;2780.8331500110057;2802.8738706758245;2810.3676672748675;2814.3808362160294;2618.096756618973;2709.4851978124193;2810.325521874756;2817.7464028237455;2819.8449085300404;2658.175965450707;2660.467906418724;2673.759361657441;2683;2691.259903526526;2669.292637451077;2680.0485827531334;2689.206684028197;2691.0446791389168;2691.8923243070253;14657.41370345185;14974.850251497563;14975.1014939104;15045.849541504555;15102.39590416382;8036.07585127712;8293.295069919064;8323.292520135796;8330.91698079252;8350.540720260384;5259.710715910624;5303.946863353895;5419.83740487786;5497.972510137423;5507.339119305709;1934.41000494849;1937.6124775045048;1953.6190442863647;1998.0708970328722;2014.697795330712;26636.86681566599;26667;26669;26711.46577068467;26959.191224263108;7231.674574644048;7270.091238595176;7458.328750412489;7475.925240747523;7506.43701722373;20137.6979345307;20341.186352545734;20400.0819963102;20435.693464598044;20446;8075.192480751878;8307.875381869277;8320;8329.5418751968;8345.833083338299;7424.814379640552;7443.441741869381;7464.813379665552;7568.508046976929;7582.431317651088;5418.295621569171;5709.857253568694;5743.8851222976145;5753.33836608787;5799.94200057994;1610.5344136835424;1659.145540046877;1701.9659606807795;1729.1959238953946;1757.613325068483;869.8564736818481;900.7973206028591;918.6876462002951;924.0297687428174;932.0306880843982;7635.31282184595;7649.617519124133;8096.542622328037;8334.291585215204;8431.95784021076;791.0665414810463;806.592670701292;1005.0251256281396;1005.4872015272117;1007.6171054999054;4900.583450406755;5017.2355390838;5135.589152867761;5171.586273098218;5214.843554693365;19695.310664126686;21406.25078122258;21437.785622143892;21548.461288467915;21656;20607;20880.791192087883;21076.578468430547;21333.89333053356;21519.78480215209;10667.733306667395;10780.46097695112;10820.621278255223;10843.891561084289;10892.673219803419;8751.737447876574;8780.648774049221;8955.776105597412;9043.18611324984;9057.77355566116;18421.447356579323;18461.815381846547;18656.906715466335;18788.7181692272;18801.6239675203;18763.249470021045;18811.529711757317;19169.8083019168;19285.325013624457;19918.20327186954;11804.291742495478;12145.878541214475;12148.39258037077;12148.453319600816;12163.817542737042;12850;13069.477220911058;13150.408231629408;13158.802617960548;13221;9940.801183976135;10411.11505522039;10667.253292269466;11058;11170.050545703707;11190;11193.27243729155;11388.14588905852;11448.255863369188;11552.480138393961;9285.350025498421;9402.294827888072;9540.713778586654;9543.0456954304;9603.087706667855;6866.828329291808;6906.37842594169;6933.1333583302085;6958.930410695828;6974.570213106403;6904.585724856524;6951.27011663768;7052.33002864727;7071.43428525727;7164.605946672983 03:36:08 INFO - PID 15743 | |4;prototype.html;497.0749053645854;519.2548692626084;527.9234510995906;529.5551736541306;530.5304805247356;6314.24229092509;6343.777967771129;6355.52333574982;6419.422251997319;6501.674916254192;6130.478909292716;6207.37926207379;6222.284437289713;6337.873242535146;6372.681365931708;5148.536631703146;5151;5176.17181250999;5206.609504287194;5234.162533994561;5184.274201611777;5208.593679706477;5214.217867319894;5244.370675518943;5294.179402192647;4804.159272127381;4956.256561515784;4978.178600530908;4992.45083040867;5169.844904652867;4993.525615066563;5013.373328333958;5014.2979982802435;5018.573421259161;5045.520675535819;4470.508244093147;4476.686631935766;4514.616257618107;4519.666698323969;4527.1624749421135;5952.880942381128;6136.662483563402;6137.6624285664275;6154.169187159721;6159.414855588712;5699.601027928046;5706.3722990471015;5721.742521586539;5725.885482290372;5777.422257774231;6552.57408268461;6610.140681711347;6613.743388756121;6629.171353580802;6645.867082658368;4865.3675022247235;4866.537678920497;4899.534544218293;4911.778969946361;4929.605631549467;6716.832079197961;6721.0926524919;6910.827229319257;6934.410575101072;6961.547499412522;4996.950030499721;5001.449840517613;5017.724025178577;5041.344625198701;5046.571041461443;5017.573506251936;5074.4671809460215;5119.462456442095;5122.308488354024;5152.587792976553;5686.3744988051285;5706.343770466367;5718.25662663851;5721.828345149652;5725.370209276976;6606.141201643755;6628.801135965929;6702;6704.899426508607;6705.832354191184;1745.1972092837436;1753.1146770880623;1762.9471115866288;1782.609564539661;1783.2955982386884;1168.7195073182374;1197.21582363552;1203.5907791350983;1209.3590397089556;1224.2348532167396;5529.529989950899;5621.606487545914;5679.983605819957;5737.942620573825;5749.68376739275;6635.042662414599;6651.102101216371;6708.538821683525;6715.160604924385;6757.763478278237;5650.3502097258515;5687.516561092353;5749.540036797046;5776.5089967352405;5795.159701843209;3513.6662017108333;3578.516900218437;3600.7299452541165;3602.423612222032;3605.4772058051435;6468.450181734511;6486.2216534016225;6492.610443373413;6577.6711164441585;6578.638174900427;6858.725650974005;6870.587764734032;6881.690323935435;6886;6922.930770692329;5771.68255745938;6233.010873041258;6283.748650054038;6372.808815735535;6407.359264073555;6548.770793022221;6657.833554161185;6690.264070952288;6704.430123439367;6747.966260168668;6529.804105876831;6600.735970561123;6605.207375115017;6656.134702488645;6763.222229443677;6293;6337.7781777637565;6379.904301435575;6381.712822923072;6405.903911441239;4810.615150787999;4985.825496107619;4987.152184128634;5011.298418221525;5038.571721403721;6391.424771770563;6565.868682626417;6606.966965165144;6655.866882662416;6680.365365290289;6367.172267605181;6464.547481676237;6502.577332473374;6588.8352791180605;6603.570767900071;6370.617762934239;6506.902396464152;6523.804285871432;6579.17760279965;6592.8351791205605;6355.555111142361;6389.265234497906;6439.227292724716;6461.381626289293;6475.255345635313;6594.90107648376;6626.138601981712;6628.933710662832;6638.900416493853;6646.202455705153;6320.841978950563;6323.177986861679;6355.745770169141;6399.712012959335;6404.551681382259 03:36:08 INFO - PID 15743 | |5;yui.html;896.9820603587924;913.616281161912;917.7109210598666;920.9677661281856;945.1399226703699;16902.49292521223;17546.912265438656;17874.285028598857;17889.55276118096;17893.731594026067;15918.681626367495;16106.919465402656;16297.918510407431;16319.10244936528;17584.120793960315;954.1174413667347;963.7590602349412;966.8549717542354;967.8741763570725;968.8498282766183;978.9412635241873;981.926355523335;982.7641366072127;982.9459379734112;986.9161121304697;979.7893452907623;1020.5560581147224;1024.5850430575629;1025.0313453786175;1034.5861655337849;1012.0284526854228;1014.6093753904726;1015.6445244164557;1015.725754046407;1015.8476228565701;749.8912657664663;751.3125490176482;751.3313151295351;751.4664588142425;751.70683433461;17430.825691743048;17882.642347152985;17903.552411189696;17935.551611209692;17956.91021544884;21851.453713657287;21986.780132198794;22277.888610557005;22419.103235870545;22447.663285050738;17332.39336623225;17848.910755446268;17944.91027544867;18219.362322318655;18389.724154137566;3703.9444408333898;3726.087108658396;3752.81235938202;3753.5120434343635;3754.511913451261;136233;138629;139015;139800.30099849537;141571;16973.915130424517;17346.913265433843;17569.736453953203;17739.822601774074;17741.11294435273;31349.373012540076;31573.210669733442;31723.84138079295;31842.363152736816;32405.837970810466;7664.348530374869;7716.884246736304;7730.729424470116;7739.92260077392;7742.690292388242;3404.5574075370537;3461.4461686130603;3465.757396982187;3468.9939917424167;3479.2867462170193;5332.9466705333225;5637.633553819071;5689.089745640677;5700.828975130753;5703.800366987219;1051.8527406163143;1068.1241382066787;1075.3977772447454;1077.5474300793685;1078.320657985464;624.9843753906189;641.2785616181795;650.4211251985737;655.9081728558006;659.9472042236706;10580.947095264628;10646.254762166729;10837.620683276047;11283.887161128448;11409.201355905174;627.7583130494793;645.6416688737702;652.1424327009967;658.2002866517109;667.3693359775064;4753;4852.611791056707;4881.194602890554;4991.725455100004;5024.321716568216;118204.35444048149;119186;121935.39032304782;123497.38251308686;124419.37790310991;108855;110364;113378;117513;118050;93709.5314523423;94170.52914735382;96089.03910960941;96858.51570742101;97611;9094.545272736468;9433.339666223299;9436.103570160823;9484.95257523708;9594;40786.388204176365;41640;42275.57724422716;43016.354754678076;43459.56540434555;54849;55494.44505554893;56928.43071569231;57193.42806572047;57342.13986790118;13908.582742517741;14135.293235338399;14153.575392738234;14208.502702405367;14433;16736.246868891172;16752.246148923085;16780.496585102468;16935.15324233808;17105.23026463837;14407.42370305218;14467;14482.34829432657;14871.925640371728;14884.553463396116;15267.847321526642;15552.222388880737;15576.844231557992;15633.06201627906;15683.451079212173;16278.755818662492;16328.918355408146;16436.506904792874;16535.66928661396;16746;9308.674196403093;9334.953325233331;9564.66523671668;9681.273904457054;9702.563384647567;10420.895791041992;10698.83951740709;10975.780484390427;11043.779124417628;11144 03:36:08 INFO - PID 15743 | __end_tp_report 03:36:08 INFO - PID 15743 | __start_cc_report 03:36:08 INFO - PID 15743 | _x_x_mozilla_cycle_collect,357 03:36:08 INFO - PID 15743 | __end_cc_report 03:36:08 INFO - PID 15743 | __startTimestamp1505298968530__endTimestamp 03:36:08 INFO - PID 15743 | 03:36:08 INFO - PID 15743 | ------- Summary: start ------- 03:36:08 INFO - PID 15743 | Number of tests: 6 03:36:08 INFO - PID 15743 | 03:36:08 INFO - PID 15743 | [#0] dojo.html Cycles:165 Average:6189.55 Median:6359.71 stddev:743.36 (11.7%) stddev-sans-first:705.84 03:36:08 INFO - PID 15743 | Values: 3130.4 3133.9 3151.6 3164.9 3172.4 6206.3 6280.0 6315.7 6359.7 6396.9 6195.8 6242.5 6269.7 6271.2 6296.6 5750.1 5770.2 5792.9 5828.4 5890.3 5851.7 5861.7 5892.3 5908.5 5916.7 5716.2 5799.6 5850.5 5910.4 5916.4 5368.8 5764.9 5777.7 5885.5 5941.0 5694.4 5712.1 5717.5 5767.1 5770.9 6252.6 6280.2 6292.2 6309.8 6322.6 6719.2 6768.4 6768.4 6817.5 6840.7 6722.5 6745.5 6813.0 6842.8 6862.2 6223.4 6301.9 6342.8 6352.3 6353.5 6921.3 6935.5 6939.5 7022.6 7042.5 6503.0 6599.6 6620.4 6634.6 6639.0 6628.8 6670.2 6687.3 6703.8 6707.1 6568.3 6599.5 6641.8 6767.6 6799.3 6672.9 6738.6 6807.3 6823.2 6827.3 5219.5 5231.7 5296.1 5300.7 5307.7 4591.6 4635.2 4639.4 4645.5 4681.4 5852.2 5855.4 5864.9 5866.7 5872.9 6769.1 6839.5 6851.8 6853.8 6859.9 5778.7 5802.3 5863.7 5865.6 5867.1 5647.7 5713.6 5730.8 5777.0 5837.4 6514.1 6571.0 6574.8 6586.8 6591.7 6693.4 6726.2 6744.2 6747.6 6767.2 6382.7 6472.1 6518.0 6581.9 6611.9 6546.7 6645.6 6659.2 6689.1 6692.9 6785.3 6825.3 6842.3 6864.5 6883.7 6435.8 6493.5 6507.0 6567.6 6590.9 6274.5 6403.2 6442.7 6577.4 6586.0 6265.7 6269.4 6283.7 6285.7 6286.8 6377.8 6433.0 6479.2 6697.0 6732.4 6303.1 6303.7 6358.0 6397.4 6410.8 03:36:08 INFO - PID 15743 | 03:36:08 INFO - PID 15743 | [#1] ext.html Cycles:180 Average:36893.78 Median:3432.52 stddev:52329.76 (1524.5%) stddev-sans-first:52406.58 03:36:08 INFO - PID 15743 | Values: 852.3 872.1 873.0 875.0 878.1 38363.6 42089.6 42262.0 42364.2 42693.4 39105.0 39273.2 39421.2 39593.0 39984.2 6909.0 7024.3 7025.9 7038.3 7521.7 7606.4 7651.4 7723.3 7723.3 7723.6 7664.5 7745.1 7769.7 7783.2 7785.3 7705.1 7732.3 7747.2 7752.9 7754.7 7591.9 7607.9 7647.0 7691.2 7698.8 37032.8 37037.3 37097.8 37277.8 37463.4 3393.4 3398.8 3413.8 3425.1 3439.9 31133.5 31134.7 31362.2 31462.8 31488.4 4853.2 4865.4 4903.9 4942.8 4953.6 186491.0 186568.0 186851.0 187315.0 187426.0 40078.4 40929.2 46755.5 46998.3 47065.5 49916.5 50918.0 51117.0 51337.5 51437.5 13926.7 13988.2 13990.4 14015.3 14024.9 11411.1 11523.8 11572.2 11600.4 11609.4 13616.9 13619.7 13651.7 13760.5 13886.2 5672.0 5690.0 5695.5 5707.3 5832.5 1004.9 1031.2 1038.1 1042.1 1055.1 23272.8 23793.3 23838.2 23838.9 23878.5 1097.8 1111.2 1116.9 1132.6 1133.0 12458.4 12502.6 12519.9 12527.6 12576.1 222894.0 225178.0 225510.0 225542.0 225961.0 53436.2 53641.2 53655.7 53872.7 53965.7 1398.3 1431.2 1434.9 1436.4 1452.0 22672.2 22748.4 23024.7 23306.2 23572.0 37008.4 37478.3 37528.8 37570.8 37602.8 190367.0 191325.0 191996.0 192294.0 193393.0 28896.9 32377.5 34970.0 34983.8 35014.5 42428.6 43616.0 43957.6 44196.6 44448.3 31952.8 32183.0 32404.0 32515.0 32704.0 31886.0 32096.8 32177.5 32220.2 32876.8 34724.1 35853.0 36494.8 36619.0 36708.4 31719.8 31753.0 31840.7 31870.4 32521.0 22763.4 23690.3 23940.8 24053.4 24553.0 03:36:08 INFO - PID 15743 | 03:36:08 INFO - PID 15743 | [#2] jquery.html Cycles:180 Average:33983.36 Median:12623.21 stddev:81482.33 (645.5%) stddev-sans-first:81672.29 03:36:08 INFO - PID 15743 | Values: 570.0 570.4 571.7 578.4 579.3 21910.0 22750.3 22822.0 22924.4 22950.4 23124.0 25620.2 25650.2 25806.7 25844.7 6598.6 6741.4 6756.3 6756.6 6770.2 6556.9 6648.1 6653.3 6662.0 6662.6 4083.6 4095.6 5622.8 6473.8 6626.9 6331.8 6509.2 6511.8 6512.3 6512.9 6026.8 6043.4 6044.4 6055.6 6060.4 27893.9 28605.4 28734.4 29021.4 29159.9 1962.9 2015.5 2020.9 2030.0 2031.2 19098.1 19725.7 19789.0 19822.7 19826.0 2296.0 2351.3 2401.0 2413.4 2418.0 137049.0 139291.0 139604.0 140206.0 140786.0 13842.5 14590.4 14701.8 14752.9 15063.3 23236.9 23272.9 23487.4 23492.5 23502.0 9293.5 9337.8 9470.9 9471.7 9570.3 8528.9 8628.0 8638.3 8660.9 8734.9 8466.2 8671.3 8779.8 9251.8 9293.5 2760.4 2813.6 2829.3 2850.1 2894.1 965.7 970.7 974.7 993.4 1004.5 19272.0 19423.4 19471.0 19676.1 20094.6 1027.8 1032.8 1043.2 1046.3 1048.2 10803.1 10844.9 10912.3 11024.4 11111.1 471458.0 476760.0 483391.0 492100.0 499781.0 101924.5 102944.0 102992.5 104293.0 108188.5 1128.8 1160.7 1182.4 1189.6 1193.1 17536.7 17682.9 17852.8 17941.8 18018.5 52627.5 52721.0 52936.0 53438.0 53570.7 66588.3 66853.3 67054.0 67212.3 68529.3 12297.3 13431.7 14340.4 14663.6 14672.1 22255.0 22415.0 22604.5 22608.7 22911.5 17637.4 17834.3 18175.8 18548.2 18599.7 16414.3 16604.1 16966.2 16967.9 17128.3 18673.3 18886.0 18912.3 19103.0 19267.3 14260.9 14410.5 14428.2 14443.2 14493.5 18057.3 18318.2 18391.2 18612.7 18648.7 03:36:08 INFO - PID 15743 | 03:36:08 INFO - PID 15743 | [#3] mootools.html Cycles:180 Average:9408.28 Median:2676.90 stddev:6721.37 (251.1%) stddev-sans-first:6712.76 03:36:08 INFO - PID 15743 | Values: 1321.4 1400.8 1422.7 1425.9 1434.8 14651.1 15089.1 15129.7 15197.8 15221.9 14903.4 14971.7 15090.5 15118.0 15141.9 2712.6 2750.9 2780.4 2792.4 2802.0 2727.5 2780.8 2802.9 2810.4 2814.4 2618.1 2709.5 2810.3 2817.7 2819.8 2658.2 2660.5 2673.8 2683.0 2691.3 2669.3 2680.0 2689.2 2691.0 2691.9 14657.4 14974.9 14975.1 15045.8 15102.4 8036.1 8293.3 8323.3 8330.9 8350.5 5259.7 5303.9 5419.8 5498.0 5507.3 1934.4 1937.6 1953.6 1998.1 2014.7 26636.9 26667.0 26669.0 26711.5 26959.2 7231.7 7270.1 7458.3 7475.9 7506.4 20137.7 20341.2 20400.1 20435.7 20446.0 8075.2 8307.9 8320.0 8329.5 8345.8 7424.8 7443.4 7464.8 7568.5 7582.4 5418.3 5709.9 5743.9 5753.3 5799.9 1610.5 1659.1 1702.0 1729.2 1757.6 869.9 900.8 918.7 924.0 932.0 7635.3 7649.6 8096.5 8334.3 8432.0 791.1 806.6 1005.0 1005.5 1007.6 4900.6 5017.2 5135.6 5171.6 5214.8 19695.3 21406.3 21437.8 21548.5 21656.0 20607.0 20880.8 21076.6 21333.9 21519.8 10667.7 10780.5 10820.6 10843.9 10892.7 8751.7 8780.6 8955.8 9043.2 9057.8 18421.4 18461.8 18656.9 18788.7 18801.6 18763.2 18811.5 19169.8 19285.3 19918.2 11804.3 12145.9 12148.4 12148.5 12163.8 12850.0 13069.5 13150.4 13158.8 13221.0 9940.8 10411.1 10667.3 11058.0 11170.1 11190.0 11193.3 11388.1 11448.3 11552.5 9285.4 9402.3 9540.7 9543.0 9603.1 6866.8 6906.4 6933.1 6958.9 6974.6 6904.6 6951.3 7052.3 7071.4 7164.6 03:36:08 INFO - PID 15743 | 03:36:08 INFO - PID 15743 | [#4] prototype.html Cycles:180 Average:5518.16 Median:6156.79 stddev:1535.93 (24.9%) stddev-sans-first:1493.29 03:36:08 INFO - PID 15743 | Values: 497.1 519.3 527.9 529.6 530.5 6314.2 6343.8 6355.5 6419.4 6501.7 6130.5 6207.4 6222.3 6337.9 6372.7 5148.5 5151.0 5176.2 5206.6 5234.2 5184.3 5208.6 5214.2 5244.4 5294.2 4804.2 4956.3 4978.2 4992.5 5169.8 4993.5 5013.4 5014.3 5018.6 5045.5 4470.5 4476.7 4514.6 4519.7 4527.2 5952.9 6136.7 6137.7 6154.2 6159.4 5699.6 5706.4 5721.7 5725.9 5777.4 6552.6 6610.1 6613.7 6629.2 6645.9 4865.4 4866.5 4899.5 4911.8 4929.6 6716.8 6721.1 6910.8 6934.4 6961.5 4997.0 5001.4 5017.7 5041.3 5046.6 5017.6 5074.5 5119.5 5122.3 5152.6 5686.4 5706.3 5718.3 5721.8 5725.4 6606.1 6628.8 6702.0 6704.9 6705.8 1745.2 1753.1 1762.9 1782.6 1783.3 1168.7 1197.2 1203.6 1209.4 1224.2 5529.5 5621.6 5680.0 5737.9 5749.7 6635.0 6651.1 6708.5 6715.2 6757.8 5650.4 5687.5 5749.5 5776.5 5795.2 3513.7 3578.5 3600.7 3602.4 3605.5 6468.5 6486.2 6492.6 6577.7 6578.6 6858.7 6870.6 6881.7 6886.0 6922.9 5771.7 6233.0 6283.7 6372.8 6407.4 6548.8 6657.8 6690.3 6704.4 6748.0 6529.8 6600.7 6605.2 6656.1 6763.2 6293.0 6337.8 6379.9 6381.7 6405.9 4810.6 4985.8 4987.2 5011.3 5038.6 6391.4 6565.9 6607.0 6655.9 6680.4 6367.2 6464.5 6502.6 6588.8 6603.6 6370.6 6506.9 6523.8 6579.2 6592.8 6355.6 6389.3 6439.2 6461.4 6475.3 6594.9 6626.1 6628.9 6638.9 6646.2 6320.8 6323.2 6355.7 6399.7 6404.6 03:36:08 INFO - PID 15743 | 03:36:08 INFO - PID 15743 | [#5] yui.html Cycles:180 Average:23931.61 Median:22132.33 stddev:35583.25 (160.8%) stddev-sans-first:35641.04 03:36:08 INFO - PID 15743 | Values: 897.0 913.6 917.7 921.0 945.1 16902.5 17546.9 17874.3 17889.6 17893.7 15918.7 16106.9 16297.9 16319.1 17584.1 954.1 963.8 966.9 967.9 968.8 978.9 981.9 982.8 982.9 986.9 979.8 1020.6 1024.6 1025.0 1034.6 1012.0 1014.6 1015.6 1015.7 1015.8 749.9 751.3 751.3 751.5 751.7 17430.8 17882.6 17903.6 17935.6 17956.9 21851.5 21986.8 22277.9 22419.1 22447.7 17332.4 17848.9 17944.9 18219.4 18389.7 3703.9 3726.1 3752.8 3753.5 3754.5 136233.0 138629.0 139015.0 139800.3 141571.0 16973.9 17346.9 17569.7 17739.8 17741.1 31349.4 31573.2 31723.8 31842.4 32405.8 7664.3 7716.9 7730.7 7739.9 7742.7 3404.6 3461.4 3465.8 3469.0 3479.3 5332.9 5637.6 5689.1 5700.8 5703.8 1051.9 1068.1 1075.4 1077.5 1078.3 625.0 641.3 650.4 655.9 659.9 10580.9 10646.3 10837.6 11283.9 11409.2 627.8 645.6 652.1 658.2 667.4 4753.0 4852.6 4881.2 4991.7 5024.3 118204.4 119186.0 121935.4 123497.4 124419.4 108855.0 110364.0 113378.0 117513.0 118050.0 93709.5 94170.5 96089.0 96858.5 97611.0 9094.5 9433.3 9436.1 9485.0 9594.0 40786.4 41640.0 42275.6 43016.4 43459.6 54849.0 55494.4 56928.4 57193.4 57342.1 13908.6 14135.3 14153.6 14208.5 14433.0 16736.2 16752.2 16780.5 16935.2 17105.2 14407.4 14467.0 14482.3 14871.9 14884.6 15267.8 15552.2 15576.8 15633.1 15683.5 16278.8 16328.9 16436.5 16535.7 16746.0 9308.7 9335.0 9564.7 9681.3 9702.6 10420.9 10698.8 10975.8 11043.8 11144.0 03:36:08 INFO - PID 15743 | -------- Summary: end -------- 03:36:08 INFO - PID 15743 | 03:36:08 INFO - PID 15743 | 03:36:08 INFO - PID 15743 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 03:36:08 INFO - PID 15743 | 03:36:09 INFO - TEST-INFO | 15743: exit 0 03:36:09 INFO - TEST-OK | dromaeo_css | took 1113626ms 03:36:09 INFO - TEST-START | kraken 03:36:09 INFO - Initialising browser for kraken test... 03:36:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60714/getInfo.html -profile /tmp/tmpEfSftK/profile 03:36:09 INFO - TEST-INFO | started process 16134 (/builds/slave/test/build/application/firefox/firefox http://localhost:60714/getInfo.html) 03:36:15 INFO - TEST-INFO | 16134: exit 0 03:36:15 INFO - Browser initialized. 03:36:15 INFO - Running cycle 1/1 for kraken test... 03:36:15 INFO - Using env: {'DISPLAY': ':0', 03:36:15 INFO - 'HOME': '/home/cltbld', 03:36:15 INFO - 'JSGC_DISABLE_POISONING': '1', 03:36:15 INFO - 'LANG': 'en_US.UTF-8', 03:36:15 INFO - 'LANGUAGE': 'en_US:en', 03:36:15 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:36:15 INFO - 'LOGNAME': 'cltbld', 03:36:15 INFO - 'MAIL': '/var/mail/cltbld', 03:36:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:36:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:36:15 INFO - 'MOZ_ACCELERATED': '1', 03:36:15 INFO - 'MOZ_CRASHREPORTER': '1', 03:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:15 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:36:15 INFO - 'MOZ_NO_REMOTE': '1', 03:36:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:36:15 INFO - 'MOZ_WEBRENDER': '1', 03:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:15 INFO - 'NO_EM_RESTART': '1', 03:36:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:15 INFO - 'PWD': '/builds/slave/test', 03:36:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:36:15 INFO - 'RUST_BACKTRACE': 'full', 03:36:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:36:15 INFO - 'SHELL': '/bin/bash', 03:36:15 INFO - 'SHLVL': '1', 03:36:15 INFO - 'TERM': 'linux', 03:36:15 INFO - 'TMOUT': '86400', 03:36:15 INFO - 'USER': 'cltbld', 03:36:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1505297761.910715-425634638', 03:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:15 INFO - '_': '/tools/buildbot/bin/python'} 03:36:15 INFO - TEST-INFO | started process 16338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEfSftK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:16 INFO - PID 16338 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:36:16 INFO - PID 16338 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:36:16 INFO - PID 16338 | 03:36:16 INFO - PID 16338 | (/builds/slave/test/build/application/firefox/firefox:16399): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:36:16 INFO - PID 16338 | 03:36:26 INFO - PID 16338 | RSS: Main: 212852736 03:36:26 INFO - PID 16338 | 03:36:29 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60714/tests/kraken/driver.html?testName=audio-beat-detection) 03:36:30 INFO - PID 16338 | RSS: Main: 220495872 03:36:30 INFO - PID 16338 | 03:36:33 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60714/tests/kraken/driver.html?testName=audio-dft) 03:36:33 INFO - PID 16338 | RSS: Main: 220143616 03:36:33 INFO - PID 16338 | 03:36:37 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60714/tests/kraken/driver.html?testName=audio-fft) 03:36:37 INFO - PID 16338 | RSS: Main: 214421504 03:36:37 INFO - PID 16338 | 03:36:39 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60714/tests/kraken/driver.html?testName=audio-oscillator) 03:36:40 INFO - PID 16338 | RSS: Main: 215228416 03:36:40 INFO - PID 16338 | 03:36:42 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60714/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:36:43 INFO - PID 16338 | RSS: Main: 214626304 03:36:43 INFO - PID 16338 | 03:36:46 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60714/tests/kraken/driver.html?testName=imaging-darkroom) 03:36:47 INFO - PID 16338 | RSS: Main: 218865664 03:36:47 INFO - PID 16338 | 03:36:50 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60714/tests/kraken/driver.html?testName=imaging-desaturate) 03:36:51 INFO - PID 16338 | RSS: Main: 217432064 03:36:51 INFO - PID 16338 | 03:36:54 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60714/tests/kraken/driver.html?testName=json-parse-financial) 03:36:55 INFO - PID 16338 | RSS: Main: 217387008 03:36:55 INFO - PID 16338 | 03:36:56 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60714/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:36:57 INFO - PID 16338 | RSS: Main: 218689536 03:36:57 INFO - PID 16338 | 03:36:59 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60714/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:36:59 INFO - PID 16338 | RSS: Main: 216387584 03:36:59 INFO - PID 16338 | 03:37:01 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60714/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:37:02 INFO - PID 16338 | RSS: Main: 215793664 03:37:02 INFO - PID 16338 | 03:37:05 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:37:06 INFO - PID 16338 | RSS: Main: 215343104 03:37:06 INFO - PID 16338 | 03:37:09 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:37:09 INFO - PID 16338 | RSS: Main: 215699456 03:37:09 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | Cycle 1(1): loaded http://localhost:60714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60714/tests/kraken/driver.html?testName=ai-astar) 03:37:11 INFO - PID 16338 | RSS: Main: 218959872 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | __start_tp_report 03:37:11 INFO - PID 16338 | _x_x_mozilla_page_load 03:37:11 INFO - PID 16338 | _x_x_mozilla_page_load_details 03:37:11 INFO - PID 16338 | |i|pagename|runs| 03:37:11 INFO - PID 16338 | |0;ai-astar;108;121;109;98;112;109;107;113;114;112 03:37:11 INFO - PID 16338 | |1;audio-beat-detection;120;124;130;117;123;122;117;123;116;148 03:37:11 INFO - PID 16338 | |2;audio-dft;170;168;167;169;167;171;166;162;166;174 03:37:11 INFO - PID 16338 | |3;audio-fft;76;81;73;77;73;80;80;81;78;76 03:37:11 INFO - PID 16338 | |4;audio-oscillator;79;86;86;80;90;79;81;81;85;79 03:37:11 INFO - PID 16338 | |5;imaging-gaussian-blur;114;116;111;114;115;110;117;111;115;115 03:37:11 INFO - PID 16338 | |6;imaging-darkroom;150;150;151;150;154;150;151;159;152;149 03:37:11 INFO - PID 16338 | |7;imaging-desaturate;98;94;94;95;95;95;100;94;94;95 03:37:11 INFO - PID 16338 | |8;json-parse-financial;59;57;55;56;55;53;53;55;54;56 03:37:11 INFO - PID 16338 | |9;json-stringify-tinderbox;42;41;37;37;38;37;46;41;43;37 03:37:11 INFO - PID 16338 | |10;stanford-crypto-aes;84;77;80;85;81;78;77;78;84;80 03:37:11 INFO - PID 16338 | |11;stanford-crypto-ccm;115;118;126;118;114;115;117;115;112;115 03:37:11 INFO - PID 16338 | |12;stanford-crypto-pbkdf2;187;168;182;178;172;176;172;167;170;177 03:37:11 INFO - PID 16338 | |13;stanford-crypto-sha256-iterative;71;67;67;65;68;68;66;67;67;66 03:37:11 INFO - PID 16338 | __end_tp_report 03:37:11 INFO - PID 16338 | __start_cc_report 03:37:11 INFO - PID 16338 | _x_x_mozilla_cycle_collect,937 03:37:11 INFO - PID 16338 | __end_cc_report 03:37:11 INFO - PID 16338 | __startTimestamp1505299031743__endTimestamp 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | ------- Summary: start ------- 03:37:11 INFO - PID 16338 | Number of tests: 14 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.50 stddev:5.89 (5.2%) stddev-sans-first:6.19 03:37:11 INFO - PID 16338 | Values: 108.0 121.0 109.0 98.0 112.0 109.0 107.0 113.0 114.0 112.0 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:123.00 stddev:9.40 (7.6%) stddev-sans-first:9.86 03:37:11 INFO - PID 16338 | Values: 120.0 124.0 130.0 117.0 123.0 122.0 117.0 123.0 116.0 148.0 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#2] audio-dft Cycles:10 Average:168.00 Median:168.50 stddev:3.27 (1.9%) stddev-sans-first:3.38 03:37:11 INFO - PID 16338 | Values: 170.0 168.0 167.0 169.0 167.0 171.0 166.0 162.0 166.0 174.0 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#3] audio-fft Cycles:10 Average:77.50 Median:79.00 stddev:3.03 (3.8%) stddev-sans-first:3.16 03:37:11 INFO - PID 16338 | Values: 76.0 81.0 73.0 77.0 73.0 80.0 80.0 81.0 78.0 76.0 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#4] audio-oscillator Cycles:10 Average:82.60 Median:83.00 stddev:3.86 (4.7%) stddev-sans-first:3.87 03:37:11 INFO - PID 16338 | Values: 79.0 86.0 86.0 80.0 90.0 79.0 81.0 81.0 85.0 79.0 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:115.00 stddev:2.35 (2.0%) stddev-sans-first:2.49 03:37:11 INFO - PID 16338 | Values: 114.0 116.0 111.0 114.0 115.0 110.0 117.0 111.0 115.0 115.0 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.00 stddev:2.95 (2.0%) stddev-sans-first:3.07 03:37:11 INFO - PID 16338 | Values: 150.0 150.0 151.0 150.0 154.0 150.0 151.0 159.0 152.0 149.0 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:2.01 (2.1%) stddev-sans-first:1.90 03:37:11 INFO - PID 16338 | Values: 98.0 94.0 94.0 95.0 95.0 95.0 100.0 94.0 94.0 95.0 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.83 (3.3%) stddev-sans-first:1.36 03:37:11 INFO - PID 16338 | Values: 59.0 57.0 55.0 56.0 55.0 53.0 53.0 55.0 54.0 56.0 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#9] json-stringify-tinderbox Cycles:10 Average:39.90 Median:41.00 stddev:3.18 (7.8%) stddev-sans-first:3.28 03:37:11 INFO - PID 16338 | Values: 42.0 41.0 37.0 37.0 38.0 37.0 46.0 41.0 43.0 37.0 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.50 stddev:3.03 (3.8%) stddev-sans-first:2.92 03:37:11 INFO - PID 16338 | Values: 84.0 77.0 80.0 85.0 81.0 78.0 77.0 78.0 84.0 80.0 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#11] stanford-crypto-ccm Cycles:10 Average:116.50 Median:116.00 stddev:3.81 (3.3%) stddev-sans-first:4.00 03:37:11 INFO - PID 16338 | Values: 115.0 118.0 126.0 118.0 114.0 115.0 117.0 115.0 112.0 115.0 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:176.50 stddev:6.35 (3.6%) stddev-sans-first:5.00 03:37:11 INFO - PID 16338 | Values: 187.0 168.0 182.0 178.0 172.0 176.0 172.0 167.0 170.0 177.0 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:0.97 03:37:11 INFO - PID 16338 | Values: 71.0 67.0 67.0 65.0 68.0 68.0 66.0 67.0 67.0 66.0 03:37:11 INFO - PID 16338 | -------- Summary: end -------- 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | 03:37:11 INFO - PID 16338 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 03:37:11 INFO - PID 16338 | 03:37:12 INFO - PID 16338 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:37:12 INFO - TEST-INFO | 16338: exit 0 03:37:12 INFO - TEST-OK | kraken | took 63199ms 03:37:12 INFO - SUITE-END | took 1176s 03:37:12 INFO - Completed test suite (00:19:37) 03:37:12 INFO - javascript benchmark 03:37:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8420.134594556772, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.436521426144, 3133.8746450141994, 3151.5902932618756, 3164.920876978076, 3172.3813856298016, 6206.348333424993, 6280.0, 6315.652639104847, 6359.71381287842, 6396.872062558752, 6195.814125576228, 6242.531810114248, 6269.68651567421, 6271.1533942917695, 6296.559240853142, 5750.079987202049, 5770.163326317682, 5792.884142317151, 5828.446297601742, 5890.322612899528, 5851.678157701324, 5861.706914654272, 5892.292924849003, 5908.497777688902, 5916.704164791765, 5716.1711551825165, 5799.594028418012, 5850.531957443394, 5910.379410161936, 5916.437938395846, 5368.8389348319615, 5764.8847023059725, 5777.711114444261, 5885.470307672309, 5941.019731744257, 5694.430556944314, 5712.086066229425, 5717.456841600041, 5767.106098554731, 5770.913436298459, 6252.562320637558, 6280.214973128359, 6292.182016337847, 6309.810705678791, 6322.58903171297, 6719.193696756421, 6768.357006084414, 6768.390844823989, 6817.5227734058635, 6840.6921688524135, 6722.495812814059, 6745.527813053088, 6813.046173535709, 6842.828929276759, 6862.245153033212, 6223.43989040984, 6301.905471417932, 6342.809715708536, 6352.301246862841, 6353.491720662336, 6921.342472465108, 6935.479839012094, 6939.548929319578, 7022.613756243456, 7042.507024508235, 6502.967485162544, 6599.5710278832685, 6620.437262832616, 6634.635095069721, 6639.037339585733, 6628.767993120217, 6670.199576050808, 6687.331266873371, 6703.765368212089, 6707.094542236736, 6568.310327415648, 6599.538032337787, 6641.767538136239, 6767.593944363354, 6799.252082270947, 6672.899906501407, 6738.629375384401, 6807.2512023677355, 6823.215330236987, 6827.317268273133, 5219.530242278137, 5231.738413079331, 5296.073187192226, 5300.681959082467, 5307.65500242483, 4591.586757191869, 4635.188841952712, 4639.373684552542, 4645.488996210414, 4681.438227412732, 5852.151438041546, 5855.443732845373, 5864.882702345929, 5866.7066646668345, 5872.853178670567, 6769.086173366631, 6839.452843772487, 6851.760188393382, 6853.828654283683, 6859.9314006860295, 5778.711064446761, 5802.274715660543, 5863.70681465925, 5865.589408741347, 5867.119932010232, 5647.661140331593, 5713.600047996683, 5730.770769169187, 5776.971115144482, 5837.445442682938, 6514.120593719787, 6571.014347847766, 6574.816533024006, 6586.8353291168105, 6591.703373348211, 6693.397594216543, 6726.159230096238, 6744.224414192235, 6747.561408508432, 6767.221769496571, 6382.744690212339, 6472.093906852951, 6518.0, 6581.868362632817, 6611.867762644624, 6546.672666366758, 6645.601263923987, 6659.2008958925235, 6689.063531105747, 6692.862213423827, 6785.321467853175, 6825.2833452486775, 6842.281560436082, 6864.48516361265, 6883.690233939385, 6435.806925792233, 6493.512986525935, 6507.023946408077, 6567.638779867153, 6590.94544872818, 6274.529410294337, 6403.167588213502, 6442.742290308335, 6577.408033276836, 6585.967070164618, 6265.718042687999, 6269.373062693694, 6283.685815709105, 6285.748570057147, 6286.842828929313, 6377.808665740035, 6433.0, 6479.1901012373455, 6696.966515167393, 6732.360425759545, 6303.1175635412, 6303.684815759102, 6357.96821015892, 6397.360263973565, 6410.839729006812], "value": 6132.856154958852, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [852.2798235491009, 872.1060912564625, 873.0004145253685, 875.0, 878.0736323179045, 38363.61636383635, 42089.57910420895, 42262.0, 42364.152716945646, 42693.35959960603, 39105.0, 39273.21453570927, 39421.211575768466, 39593.0, 39984.200315993665, 6909.0, 7024.262452442496, 7025.894611580805, 7038.296170382972, 7521.699132034712, 7606.353459955911, 7651.426143039266, 7723.343515801163, 7723.343515801163, 7723.575203363813, 7664.463487555873, 7745.070591529025, 7769.689212431496, 7783.2216778322, 7785.260400261966, 7705.113911900119, 7732.342750866183, 7747.186545412763, 7752.883706744376, 7754.651040703182, 7591.8861217081785, 7607.858821176867, 7646.961765191194, 7691.23087691232, 7698.846023079563, 37032.814835925645, 37037.25925481502, 37097.81451092754, 37277.81361093204, 37463.43804842929, 3393.372226138172, 3398.7960722356493, 3413.7781044232047, 3425.1265927188406, 3439.914002149941, 31133.532997005062, 31134.688653113404, 31362.21594460134, 31462.842685786654, 31488.370232595218, 4853.19922212838, 4865.41615006198, 4903.8528844134735, 4942.752862356903, 4953.6037117030555, 186491.0, 186568.0, 186850.99999999863, 187315.0, 187426.0, 40078.39882401766, 40929.1814163715, 46755.532444675795, 46998.29502557465, 47065.529344706796, 49916.50083499119, 50918.0, 51117.0, 51337.48662513327, 51437.48562514327, 13926.721465570632, 13988.160710357412, 13990.440382384591, 14015.299235038206, 14024.929875350763, 11411.087113030937, 11523.76952460946, 11572.189946703818, 11600.361980091177, 11609.419529023515, 13616.86383136156, 13619.727605447835, 13651.658708532168, 13760.518381856587, 13886.16682999003, 5671.9716401418555, 5690.0, 5695.487406133385, 5707.315122185364, 5832.533397328289, 1004.9497525123714, 1031.159604921986, 1038.0864838941684, 1042.0725554256717, 1055.1347894726405, 23272.767272327397, 23793.286201413986, 23838.16566420167, 23838.88080559586, 23878.52242955131, 1097.8298363753631, 1111.1888321525332, 1116.9106471482262, 1132.6205721083365, 1133.0312582741801, 12458.377081145907, 12502.562410315595, 12519.874801252054, 12527.56153534622, 12576.119671622899, 222894.0, 225178.0, 225510.0, 225542.0, 225961.0, 53436.19845702317, 53641.1953820693, 53655.731721341144, 53872.73063634657, 53965.73017134889, 1398.3288021749618, 1431.241442035702, 1434.9497767578084, 1436.3823555871077, 1451.992740036293, 22672.206472773374, 22748.4312892179, 23024.654630180226, 23306.184283550672, 23572.0, 37008.444873326385, 37478.25043499169, 37528.81235593805, 37570.8121459391, 37602.811985939894, 190367.0, 191325.0, 191996.0, 192294.0, 193393.0, 28896.855515722287, 32377.51433728543, 34970.0, 34983.825080874434, 35014.47478287777, 42428.57571424246, 43616.0, 43957.56042439535, 44196.55803441924, 44448.33327500025, 31952.84023579867, 32183.034508964767, 32404.0, 32515.0, 32704.0, 31886.0, 32096.839515803207, 32177.517337240428, 32220.19449513781, 32876.835615821765, 34724.131896702784, 35853.0, 36494.8175259122, 36619.0, 36708.44937325889, 31719.841400792848, 31753.0, 31840.68159318377, 31870.36259274848, 32521.0, 22763.430914226614, 23690.28929132129, 23940.76059239455, 24053.398665033514, 24553.017879285344], "value": 16879.64890372089, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.9943000569995, 570.3668927490487, 571.7484306904962, 578.3522454850568, 579.2585490572067, 21910.0, 22750.317490475292, 22821.999999999978, 22924.426889327777, 22950.426239344026, 23124.0, 25620.23139305819, 25650.23049308519, 25806.74193258067, 25844.74155258447, 6598.604083754966, 6741.359570840762, 6756.324367563254, 6756.628385438824, 6770.1875774907085, 6556.93443065568, 6648.102506161655, 6653.2681405045405, 6662.034005069287, 6662.600243985376, 4083.5508094109773, 4095.5904409559103, 5622.819207966332, 6473.773417930373, 6626.900596491032, 6331.8417039573915, 6509.1863517060365, 6511.804645860608, 6512.283648798652, 6512.8697426051685, 6026.8493287667725, 6043.425874541911, 6044.395560443964, 6055.606385584967, 6060.36366181549, 27893.86053069742, 28605.427891442054, 28734.425311493862, 29021.41957160845, 29159.854200729074, 1962.9411117666493, 2015.4961259685078, 2020.939371818833, 2029.989850050755, 2031.207828946712, 19098.14058367377, 19725.704114438297, 19789.0, 19822.70265946012, 19826.0, 2296.0012394608398, 2351.2711059571416, 2400.987995060031, 2413.3604594782396, 2418.0, 137049.0, 139291.0, 139604.0, 140206.0, 140786.0, 13842.515511957034, 14590.41638334476, 14701.779473307908, 14752.926235368968, 15063.322150503254, 23236.883815580815, 23272.883635581715, 23487.41281467977, 23492.530149396916, 23502.0, 9293.535323233811, 9337.766555836159, 9470.90529094714, 9471.715848524555, 9570.33007689455, 8528.872066919, 8628.0, 8638.308935285162, 8660.913390866011, 8734.912650873537, 8466.195711407407, 8671.262942649819, 8779.824403511893, 9251.790435351899, 9293.488858112869, 2760.3651160232857, 2813.6482939632547, 2829.3492496725457, 2850.08797184903, 2894.0738963531467, 965.7054598347431, 970.7281961050917, 974.6734843827397, 993.4287784523927, 1004.5278719002057, 19272.036398180036, 19423.417297481097, 19471.0, 19676.114574844167, 20094.59810803805, 1027.845823126537, 1032.7521394865328, 1043.1706793099504, 1046.2519298701466, 1048.2452634103433, 10803.081738052197, 10844.891551084389, 10912.345259284468, 11024.44877756109, 11111.055560277468, 471458.0, 476760.0, 483391.0, 492100.0, 499781.0, 101924.49037754764, 102944.0, 102992.48503757433, 104293.0, 108188.45905770421, 1128.7516746315962, 1160.6692092753694, 1182.39697754146, 1189.6252680405644, 1193.1349771415655, 17536.736948946032, 17682.911585442504, 17852.821471785115, 17941.820581794014, 18018.459446216635, 52627.47372526226, 52721.0, 52936.0, 53438.0, 53570.73214633902, 66588.33411665821, 66853.33146668471, 67054.0, 67212.3278767206, 68529.3147068523, 12297.262164270172, 13431.731365372443, 14340.426382944564, 14663.56009319722, 14672.119672819237, 22255.0, 22414.99132539007, 22604.547909042056, 22608.660870086635, 22911.541769164858, 17637.382691605733, 17834.28662853471, 18175.81824181741, 18548.165332559798, 18599.72100418522, 16414.343426263295, 16604.08677522748, 16966.151692415577, 16967.91516042412, 17128.314867405163, 18673.346432874783, 18886.0, 18912.338068168097, 19103.0, 19267.325643602406, 14260.928695356457, 14410.495632652806, 14428.206448645426, 14443.205623690377, 14493.492727754478, 18057.277708891495, 18318.175682094603, 18391.172397242422, 18612.720809187602, 18648.720269196245], "value": 11739.323907679394, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.4119716726057, 1400.8389035260948, 1422.672785259391, 1425.9429622815087, 1434.76326406143, 14651.12093274403, 15089.094654320748, 15129.697406051873, 15197.848021519781, 15221.92389038056, 14903.40386384546, 14971.700565988674, 15090.47183348583, 15118.0, 15141.924290378533, 2712.5524288492375, 2750.9037183698574, 2780.4439112177542, 2792.4135931454316, 2801.957970630442, 2727.5090483712925, 2780.8331500110057, 2802.8738706758245, 2810.3676672748675, 2814.3808362160294, 2618.096756618973, 2709.4851978124193, 2810.325521874756, 2817.7464028237455, 2819.8449085300404, 2658.175965450707, 2660.467906418724, 2673.759361657441, 2683.0, 2691.259903526526, 2669.292637451077, 2680.0485827531334, 2689.206684028197, 2691.0446791389168, 2691.8923243070253, 14657.41370345185, 14974.850251497563, 14975.1014939104, 15045.849541504555, 15102.39590416382, 8036.07585127712, 8293.295069919064, 8323.292520135796, 8330.91698079252, 8350.540720260384, 5259.710715910624, 5303.946863353895, 5419.83740487786, 5497.972510137423, 5507.339119305709, 1934.41000494849, 1937.6124775045048, 1953.6190442863647, 1998.0708970328722, 2014.697795330712, 26636.86681566599, 26667.0, 26669.0, 26711.46577068467, 26959.191224263108, 7231.674574644048, 7270.091238595176, 7458.328750412489, 7475.925240747523, 7506.43701722373, 20137.6979345307, 20341.186352545734, 20400.0819963102, 20435.693464598044, 20446.0, 8075.192480751878, 8307.875381869277, 8320.0, 8329.5418751968, 8345.833083338299, 7424.814379640552, 7443.441741869381, 7464.813379665552, 7568.508046976929, 7582.431317651088, 5418.295621569171, 5709.857253568694, 5743.8851222976145, 5753.33836608787, 5799.94200057994, 1610.5344136835424, 1659.145540046877, 1701.9659606807795, 1729.1959238953946, 1757.613325068483, 869.8564736818481, 900.7973206028591, 918.6876462002951, 924.0297687428174, 932.0306880843982, 7635.31282184595, 7649.617519124133, 8096.542622328037, 8334.291585215204, 8431.95784021076, 791.0665414810463, 806.592670701292, 1005.0251256281396, 1005.4872015272117, 1007.6171054999054, 4900.583450406755, 5017.2355390838, 5135.589152867761, 5171.586273098218, 5214.843554693365, 19695.310664126686, 21406.25078122258, 21437.785622143892, 21548.461288467915, 21656.0, 20607.0, 20880.791192087883, 21076.578468430547, 21333.89333053356, 21519.78480215209, 10667.733306667395, 10780.46097695112, 10820.621278255223, 10843.891561084289, 10892.673219803419, 8751.737447876574, 8780.648774049221, 8955.776105597412, 9043.18611324984, 9057.77355566116, 18421.447356579323, 18461.815381846547, 18656.906715466335, 18788.7181692272, 18801.6239675203, 18763.249470021045, 18811.529711757317, 19169.8083019168, 19285.325013624457, 19918.20327186954, 11804.291742495478, 12145.878541214475, 12148.39258037077, 12148.453319600816, 12163.817542737042, 12850.0, 13069.477220911058, 13150.408231629408, 13158.802617960548, 13221.0, 9940.801183976135, 10411.11505522039, 10667.253292269466, 11058.0, 11170.050545703707, 11190.0, 11193.27243729155, 11388.14588905852, 11448.255863369188, 11552.480138393961, 9285.350025498421, 9402.294827888072, 9540.713778586654, 9543.0456954304, 9603.087706667855, 6866.828329291808, 6906.37842594169, 6933.1333583302085, 6958.930410695828, 6974.570213106403, 6904.585724856524, 6951.27011663768, 7052.33002864727, 7071.43428525727, 7164.605946672983], "value": 6748.406734773324, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.0749053645854, 519.2548692626084, 527.9234510995906, 529.5551736541306, 530.5304805247356, 6314.24229092509, 6343.777967771129, 6355.52333574982, 6419.422251997319, 6501.674916254192, 6130.478909292716, 6207.37926207379, 6222.284437289713, 6337.873242535146, 6372.681365931708, 5148.536631703146, 5151.0, 5176.17181250999, 5206.609504287194, 5234.162533994561, 5184.274201611777, 5208.593679706477, 5214.217867319894, 5244.370675518943, 5294.179402192647, 4804.159272127381, 4956.256561515784, 4978.178600530908, 4992.45083040867, 5169.844904652867, 4993.525615066563, 5013.373328333958, 5014.2979982802435, 5018.573421259161, 5045.520675535819, 4470.508244093147, 4476.686631935766, 4514.616257618107, 4519.666698323969, 4527.1624749421135, 5952.880942381128, 6136.662483563402, 6137.6624285664275, 6154.169187159721, 6159.414855588712, 5699.601027928046, 5706.3722990471015, 5721.742521586539, 5725.885482290372, 5777.422257774231, 6552.57408268461, 6610.140681711347, 6613.743388756121, 6629.171353580802, 6645.867082658368, 4865.3675022247235, 4866.537678920497, 4899.534544218293, 4911.778969946361, 4929.605631549467, 6716.832079197961, 6721.0926524919, 6910.827229319257, 6934.410575101072, 6961.547499412522, 4996.950030499721, 5001.449840517613, 5017.724025178577, 5041.344625198701, 5046.571041461443, 5017.573506251936, 5074.4671809460215, 5119.462456442095, 5122.308488354024, 5152.587792976553, 5686.3744988051285, 5706.343770466367, 5718.25662663851, 5721.828345149652, 5725.370209276976, 6606.141201643755, 6628.801135965929, 6702.0, 6704.899426508607, 6705.832354191184, 1745.1972092837436, 1753.1146770880623, 1762.9471115866288, 1782.609564539661, 1783.2955982386884, 1168.7195073182374, 1197.21582363552, 1203.5907791350983, 1209.3590397089556, 1224.2348532167396, 5529.529989950899, 5621.606487545914, 5679.983605819957, 5737.942620573825, 5749.68376739275, 6635.042662414599, 6651.102101216371, 6708.538821683525, 6715.160604924385, 6757.763478278237, 5650.3502097258515, 5687.516561092353, 5749.540036797046, 5776.5089967352405, 5795.159701843209, 3513.6662017108333, 3578.516900218437, 3600.7299452541165, 3602.423612222032, 3605.4772058051435, 6468.450181734511, 6486.2216534016225, 6492.610443373413, 6577.6711164441585, 6578.638174900427, 6858.725650974005, 6870.587764734032, 6881.690323935435, 6886.0, 6922.930770692329, 5771.68255745938, 6233.010873041258, 6283.748650054038, 6372.808815735535, 6407.359264073555, 6548.770793022221, 6657.833554161185, 6690.264070952288, 6704.430123439367, 6747.966260168668, 6529.804105876831, 6600.735970561123, 6605.207375115017, 6656.134702488645, 6763.222229443677, 6293.0, 6337.7781777637565, 6379.904301435575, 6381.712822923072, 6405.903911441239, 4810.615150787999, 4985.825496107619, 4987.152184128634, 5011.298418221525, 5038.571721403721, 6391.424771770563, 6565.868682626417, 6606.966965165144, 6655.866882662416, 6680.365365290289, 6367.172267605181, 6464.547481676237, 6502.577332473374, 6588.8352791180605, 6603.570767900071, 6370.617762934239, 6506.902396464152, 6523.804285871432, 6579.17760279965, 6592.8351791205605, 6355.555111142361, 6389.265234497906, 6439.227292724716, 6461.381626289293, 6475.255345635313, 6594.90107648376, 6626.138601981712, 6628.933710662832, 6638.900416493853, 6646.202455705153, 6320.841978950563, 6323.177986861679, 6355.745770169141, 6399.712012959335, 6404.551681382259], "value": 5065.81245006972, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.9820603587924, 913.616281161912, 917.7109210598666, 920.9677661281856, 945.1399226703699, 16902.49292521223, 17546.912265438656, 17874.285028598857, 17889.55276118096, 17893.731594026067, 15918.681626367495, 16106.919465402656, 16297.918510407431, 16319.10244936528, 17584.120793960315, 954.1174413667347, 963.7590602349412, 966.8549717542354, 967.8741763570725, 968.8498282766183, 978.9412635241873, 981.926355523335, 982.7641366072127, 982.9459379734112, 986.9161121304697, 979.7893452907623, 1020.5560581147224, 1024.5850430575629, 1025.0313453786175, 1034.5861655337849, 1012.0284526854228, 1014.6093753904726, 1015.6445244164557, 1015.725754046407, 1015.8476228565701, 749.8912657664663, 751.3125490176482, 751.3313151295351, 751.4664588142425, 751.70683433461, 17430.825691743048, 17882.642347152985, 17903.552411189696, 17935.551611209692, 17956.91021544884, 21851.453713657287, 21986.780132198794, 22277.888610557005, 22419.103235870545, 22447.663285050738, 17332.39336623225, 17848.910755446268, 17944.91027544867, 18219.362322318655, 18389.724154137566, 3703.9444408333898, 3726.087108658396, 3752.81235938202, 3753.5120434343635, 3754.511913451261, 136233.0, 138629.0, 139015.0, 139800.30099849537, 141571.0, 16973.915130424517, 17346.913265433843, 17569.736453953203, 17739.822601774074, 17741.11294435273, 31349.373012540076, 31573.210669733442, 31723.84138079295, 31842.363152736816, 32405.837970810466, 7664.348530374869, 7716.884246736304, 7730.729424470116, 7739.92260077392, 7742.690292388242, 3404.5574075370537, 3461.4461686130603, 3465.757396982187, 3468.9939917424167, 3479.2867462170193, 5332.9466705333225, 5637.633553819071, 5689.089745640677, 5700.828975130753, 5703.800366987219, 1051.8527406163143, 1068.1241382066787, 1075.3977772447454, 1077.5474300793685, 1078.320657985464, 624.9843753906189, 641.2785616181795, 650.4211251985737, 655.9081728558006, 659.9472042236706, 10580.947095264628, 10646.254762166729, 10837.620683276047, 11283.887161128448, 11409.201355905174, 627.7583130494793, 645.6416688737702, 652.1424327009967, 658.2002866517109, 667.3693359775064, 4753.0, 4852.611791056707, 4881.194602890554, 4991.725455100004, 5024.321716568216, 118204.35444048149, 119186.0, 121935.39032304782, 123497.38251308686, 124419.37790310991, 108855.0, 110364.0, 113378.0, 117513.0, 118050.0, 93709.5314523423, 94170.52914735382, 96089.03910960941, 96858.51570742101, 97611.0, 9094.545272736468, 9433.339666223299, 9436.103570160823, 9484.95257523708, 9594.0, 40786.388204176365, 41640.0, 42275.57724422716, 43016.354754678076, 43459.56540434555, 54849.0, 55494.44505554893, 56928.43071569231, 57193.42806572047, 57342.13986790118, 13908.582742517741, 14135.293235338399, 14153.575392738234, 14208.502702405367, 14433.0, 16736.246868891172, 16752.246148923085, 16780.496585102468, 16935.15324233808, 17105.23026463837, 14407.42370305218, 14467.0, 14482.34829432657, 14871.925640371728, 14884.553463396116, 15267.847321526642, 15552.222388880737, 15576.844231557992, 15633.06201627906, 15683.451079212173, 16278.755818662492, 16328.918355408146, 16436.506904792874, 16535.66928661396, 16746.0, 9308.674196403093, 9334.953325233331, 9564.66523671668, 9681.273904457054, 9702.563384647567, 10420.895791041992, 10698.83951740709, 10975.780484390427, 11043.779124417628, 11144.0], "value": 8577.679038072501, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1457.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 121.0, 109.0, 98.0, 112.0, 109.0, 107.0, 113.0, 114.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 124.0, 130.0, 117.0, 123.0, 122.0, 117.0, 123.0, 116.0, 148.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 167.0, 169.0, 167.0, 171.0, 166.0, 162.0, 166.0, 174.0], "value": 168.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 73.0, 77.0, 73.0, 80.0, 80.0, 81.0, 78.0, 76.0], "value": 77.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 86.0, 80.0, 90.0, 79.0, 81.0, 81.0, 85.0, 79.0], "value": 82.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 111.0, 114.0, 115.0, 110.0, 117.0, 111.0, 115.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 150.0, 154.0, 150.0, 151.0, 159.0, 152.0, 149.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 95.0, 95.0, 95.0, 100.0, 94.0, 94.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 55.0, 56.0, 55.0, 53.0, 53.0, 55.0, 54.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 41.0, 37.0, 37.0, 38.0, 37.0, 46.0, 41.0, 43.0, 37.0], "value": 39.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 77.0, 80.0, 85.0, 81.0, 78.0, 77.0, 78.0, 84.0, 80.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 118.0, 126.0, 118.0, 114.0, 115.0, 117.0, 115.0, 112.0, 115.0], "value": 116.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 168.0, 182.0, 178.0, 172.0, 176.0, 172.0, 167.0, 170.0, 177.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 67.0, 65.0, 68.0, 68.0, 66.0, 67.0, 67.0, 66.0], "value": 67.2, "unit": "score"}]}]} 03:37:12 INFO - Return code: 0 03:37:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:37:13 INFO - # TBPL SUCCESS # 03:37:13 INFO - Running post-action listener: _package_coverage_data 03:37:13 INFO - Running post-action listener: _resource_record_post_action 03:37:13 INFO - [mozharness: 2017-09-13 10:37:13.044243Z] Finished run-tests step (success) 03:37:13 INFO - Running post-run listener: _resource_record_post_run 03:37:13 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8413184; Write bytes: 291225600; Read time: 6524; Write time: 229612 03:37:13 INFO - TinderboxPrint: CPU usage
13.3% 03:37:13 INFO - TinderboxPrint: I/O read bytes / time
8,413,184 / 6,524 03:37:13 INFO - TinderboxPrint: I/O write bytes / time
291,225,600 / 229,612 03:37:13 INFO - TinderboxPrint: CPU idle
8,252.0 (86.7%) 03:37:13 INFO - TinderboxPrint: CPU user
1,200.0 (12.6%) 03:37:13 INFO - TinderboxPrint: Swap in / out
0 / 0 03:37:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12832768; Read time: 0; Write time: 3244 03:37:13 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:37:13 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8409088; Write bytes: 278392832; Read time: 6512; Write time: 226368 03:37:13 INFO - Running post-run listener: _upload_blobber_files 03:37:13 INFO - Blob upload gear active. 03:37:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:37:13 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 03:37:13 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'] 03:37:13 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 03:37:14 INFO - (blobuploader) - INFO - Open directory for files ... 03:37:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:37:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:37:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:15 INFO - (blobuploader) - INFO - Done attempting. 03:37:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:37:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:37:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:22 INFO - (blobuploader) - INFO - Done attempting. 03:37:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:37:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:23 INFO - (blobuploader) - INFO - Done attempting. 03:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:37:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:24 INFO - (blobuploader) - INFO - Done attempting. 03:37:24 INFO - (blobuploader) - INFO - Iteration through files over. 03:37:24 INFO - Return code: 0 03:37:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:37:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:37:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6074d02923ba833911b85861851b050fe2d5d7ae0c81428dfbcfdd482a86f3b8654076738f3d35b85ef073f5707718f3a868d45f92fef4a70f939a40fe9b4c5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db912ce4c6516051684b308a01922f20a0911dfea1db419d32d84b60d1b5e98001fa19162be639335a575c1e34d6ffc6ef89b884d020d6b7c16cdf6fd043e228", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9cdaa916eca5d30aa42c64b124894a269e434d36e055bd7994dd523dd78b96023b99689043adfb6bef0e5452106e16eb5ba759576e62efa0febfe59c218a50f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b21d05603869a45b6a063c01571307e5d9e2aa0d73d41c529130ffa70e6ed994b0d2502196a1ff35cfbe9eeeaf869d49b2bc079aba573472f13619ddfed8e7a"} 03:37:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:37:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:37:24 INFO - Contents: 03:37:24 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6074d02923ba833911b85861851b050fe2d5d7ae0c81428dfbcfdd482a86f3b8654076738f3d35b85ef073f5707718f3a868d45f92fef4a70f939a40fe9b4c5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db912ce4c6516051684b308a01922f20a0911dfea1db419d32d84b60d1b5e98001fa19162be639335a575c1e34d6ffc6ef89b884d020d6b7c16cdf6fd043e228", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9cdaa916eca5d30aa42c64b124894a269e434d36e055bd7994dd523dd78b96023b99689043adfb6bef0e5452106e16eb5ba759576e62efa0febfe59c218a50f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b21d05603869a45b6a063c01571307e5d9e2aa0d73d41c529130ffa70e6ed994b0d2502196a1ff35cfbe9eeeaf869d49b2bc079aba573472f13619ddfed8e7a"} 03:37:24 INFO - Running post-run listener: copy_logs_to_upload_dir 03:37:24 INFO - Copying logs to upload dir... 03:37:24 INFO - mkdir: /builds/slave/test/build/upload/logs 03:37:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.194008 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-13 03:37:24.624652) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 03:37:24.631719) ========= 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=745a4373a2a16df560f216e000000264-1505297761.910715-425634638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6074d02923ba833911b85861851b050fe2d5d7ae0c81428dfbcfdd482a86f3b8654076738f3d35b85ef073f5707718f3a868d45f92fef4a70f939a40fe9b4c5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db912ce4c6516051684b308a01922f20a0911dfea1db419d32d84b60d1b5e98001fa19162be639335a575c1e34d6ffc6ef89b884d020d6b7c16cdf6fd043e228", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9cdaa916eca5d30aa42c64b124894a269e434d36e055bd7994dd523dd78b96023b99689043adfb6bef0e5452106e16eb5ba759576e62efa0febfe59c218a50f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b21d05603869a45b6a063c01571307e5d9e2aa0d73d41c529130ffa70e6ed994b0d2502196a1ff35cfbe9eeeaf869d49b2bc079aba573472f13619ddfed8e7a"} build_url:https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/PtRvbvlCQYK7a280i3EPGQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6074d02923ba833911b85861851b050fe2d5d7ae0c81428dfbcfdd482a86f3b8654076738f3d35b85ef073f5707718f3a868d45f92fef4a70f939a40fe9b4c5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db912ce4c6516051684b308a01922f20a0911dfea1db419d32d84b60d1b5e98001fa19162be639335a575c1e34d6ffc6ef89b884d020d6b7c16cdf6fd043e228", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9cdaa916eca5d30aa42c64b124894a269e434d36e055bd7994dd523dd78b96023b99689043adfb6bef0e5452106e16eb5ba759576e62efa0febfe59c218a50f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b21d05603869a45b6a063c01571307e5d9e2aa0d73d41c529130ffa70e6ed994b0d2502196a1ff35cfbe9eeeaf869d49b2bc079aba573472f13619ddfed8e7a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 03:37:24.662615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:37:24.662947) ========= 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=745a4373a2a16df560f216e000000264-1505297761.910715-425634638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:37:24.743312) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 03:37:24.746645) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 03:37:24.746939) ========= ========= Total master_lag: 0.87 =========