builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-048 starttime: 1506462504.94 results: success (0) revision: 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:24.935687) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:24.939495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:24.939774) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:24.997533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:24.997800) ========= 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=fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 14:48:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2017-09-26 14:48:25 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.180703 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:25.230941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:25.231255) ========= 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=fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016651 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:25.286545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:25.286833) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b --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 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b --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=fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 14:48:25,531 truncating revision to first 12 chars 2017-09-26 14:48:25,531 Setting DEBUG logging. 2017-09-26 14:48:25,531 attempt 1/10 2017-09-26 14:48:25,531 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7d15bc419c6c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 14:48:25,904 unpacking tar archive at: mozilla-central-7d15bc419c6c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.718143 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:26.021247) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:26.024601) ========= script_repo_revision: 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:26.025001) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:26.025273) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 14:48:26.040252) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-26 14:48:26.040626) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:48:26 INFO - MultiFileLogger online at 20170926 14:48:26 in /builds/slave/test 14:48:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:48:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:48:26 INFO - {'append_to_log': False, 14:48:26 INFO - 'base_work_dir': '/builds/slave/test', 14:48:26 INFO - 'blob_upload_branch': 'Firefox', 14:48:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:48:26 INFO - 'branch': 'Firefox', 14:48:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:48:26 INFO - 'code_coverage': False, 14:48:26 INFO - 'config_files': ('talos/linux_config.py',), 14:48:26 INFO - 'default_actions': ('clobber', 14:48:26 INFO - 'read-buildbot-config', 14:48:26 INFO - 'download-and-extract', 14:48:26 INFO - 'populate-webroot', 14:48:26 INFO - 'create-virtualenv', 14:48:26 INFO - 'install', 14:48:26 INFO - 'setup-mitmproxy', 14:48:26 INFO - 'run-tests'), 14:48:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:48:26 INFO - 'disable_ccov_upload': False, 14:48:26 INFO - 'disable_stylo': False, 14:48:26 INFO - 'download_minidump_stackwalk': True, 14:48:26 INFO - 'download_symbols': 'ondemand', 14:48:26 INFO - 'enable_stylo': False, 14:48:26 INFO - 'enable_webrender': False, 14:48:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 14:48:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:48:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:48:26 INFO - 'gecko_profile': False, 14:48:26 INFO - 'gecko_profile_interval': 0, 14:48:26 INFO - 'installer_path': 'installer.exe', 14:48:26 INFO - 'log_level': 'info', 14:48:26 INFO - 'log_name': 'talos', 14:48:26 INFO - 'log_to_console': True, 14:48:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:48:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:48:26 INFO - 'opt_config_files': (), 14:48:26 INFO - 'pip_index': False, 14:48:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 14:48:26 INFO - 'system_bits': '32', 14:48:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:48:26 INFO - 'title': 'talos-linux64-ix-048', 14:48:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:48:26 INFO - 'use_talos_json': True, 14:48:26 INFO - 'verify': 'False', 14:48:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:48:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:48:26 INFO - 'work_dir': 'build'} 14:48:26 INFO - [mozharness: 2017-09-26 21:48:26.502701Z] Running clobber step. 14:48:26 INFO - Running pre-action listener: _resource_record_pre_action 14:48:26 INFO - Running main action method: clobber 14:48:26 INFO - rmtree: /builds/slave/test/build 14:48:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:48:27 INFO - Running post-action listener: _resource_record_post_action 14:48:27 INFO - [mozharness: 2017-09-26 21:48:27.447202Z] Finished clobber step (success) 14:48:27 INFO - [mozharness: 2017-09-26 21:48:27.447360Z] Running read-buildbot-config step. 14:48:27 INFO - Running pre-action listener: _resource_record_pre_action 14:48:27 INFO - Running main action method: read_buildbot_config 14:48:27 INFO - Using buildbot properties: 14:48:27 INFO - { 14:48:27 INFO - "project": "", 14:48:27 INFO - "product": "firefox", 14:48:27 INFO - "who": "kwierso@gmail.com", 14:48:27 INFO - "installer_path": "public/build/target.tar.bz2", 14:48:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 14:48:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:48:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 14:48:27 INFO - "stage_platform": "linux64-pgo", 14:48:27 INFO - "basedir": "/builds/slave/test", 14:48:27 INFO - "buildnumber": 62, 14:48:27 INFO - "platform": "ubuntu64_hw", 14:48:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:48:27 INFO - "slavebuilddir": "test", 14:48:27 INFO - "taskId": "Rl2wvj_0Q6SiFtJBAMcK0g", 14:48:27 INFO - "branch": "mozilla-central", 14:48:27 INFO - "script_repo_revision": "production", 14:48:27 INFO - "revision": "7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b", 14:48:27 INFO - "slavename": "talos-linux64-ix-048", 14:48:27 INFO - "repo_path": "mozilla-central" 14:48:27 INFO - } 14:48:27 INFO - Finding installer, test and symbols from parent task. 14:48:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rl2wvj_0Q6SiFtJBAMcK0g'}, attempt #1 14:48:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rl2wvj_0Q6SiFtJBAMcK0g'}, attempt #1 14:48:28 INFO - Task dependencies: IKyg_StSS-2K6YFkukKa-w 14:48:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w'}, attempt #1 14:48:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.tar.bz2 14:48:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.test_packages.json 14:48:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.crashreporter-symbols.zip 14:48:28 INFO - Running post-action listener: _resource_record_post_action 14:48:28 INFO - [mozharness: 2017-09-26 21:48:28.896175Z] Finished read-buildbot-config step (success) 14:48:28 INFO - [mozharness: 2017-09-26 21:48:28.896391Z] Running download-and-extract step. 14:48:28 INFO - Running pre-action listener: _resource_record_pre_action 14:48:28 INFO - Running main action method: download_and_extract 14:48:28 INFO - mkdir: /builds/slave/test/build/tests 14:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:28 INFO - trying https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.test_packages.json 14:48:28 INFO - Downloading https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:48:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:48:29 INFO - Downloaded 989 bytes. 14:48:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:48:29 INFO - Using the following test package requirements: 14:48:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:48:29 INFO - u'common': [u'target.common.tests.zip'], 14:48:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:48:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:48:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:48:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:48:29 INFO - u'mozbase': [u'target.common.tests.zip'], 14:48:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:48:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:48:29 INFO - u'web-platform': [u'target.common.tests.zip', 14:48:29 INFO - u'target.web-platform.tests.tar.gz'], 14:48:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:48:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 14:48:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.common.tests.zip 14:48:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:48:29 INFO - Fetch https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.common.tests.zip into memory 14:48:31 INFO - Content-Length response header: 55345889 14:48:31 INFO - Bytes received: 55345889 14:48:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.talos.tests.zip 14:48:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:48:42 INFO - Fetch https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.talos.tests.zip into memory 14:48:44 INFO - Content-Length response header: 14513823 14:48:44 INFO - Bytes received: 14513823 14:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:44 INFO - trying https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.tar.bz2 14:48:44 INFO - Downloading https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:48:47 INFO - Downloaded 62279577 bytes. 14:48:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.tar.bz2 14:48:47 INFO - mkdir: /builds/slave/test/properties 14:48:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:48:47 INFO - Writing to file /builds/slave/test/properties/build_url 14:48:47 INFO - Contents: 14:48:47 INFO - build_url:https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.tar.bz2 14:48:47 INFO - Running post-action listener: _resource_record_post_action 14:48:47 INFO - Running post-action listener: find_tests_for_verification 14:48:47 INFO - Running post-action listener: set_extra_try_arguments 14:48:47 INFO - [mozharness: 2017-09-26 21:48:47.536749Z] Finished download-and-extract step (success) 14:48:47 INFO - [mozharness: 2017-09-26 21:48:47.536980Z] Running populate-webroot step. 14:48:47 INFO - Running pre-action listener: _resource_record_pre_action 14:48:47 INFO - Running main action method: populate_webroot 14:48:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:48:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:47 INFO - 'tests': ['tresize', 14:48:47 INFO - 'tcanvasmark']}, 14:48:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:48:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:47 INFO - 'tests': ['dromaeo_css', 14:48:47 INFO - 'kraken']}, 14:48:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:48:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:48:47 INFO - 'talos_options': ['--disable-stylo'], 14:48:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:48:47 INFO - 'tests': ['damp', 'tps']}, 14:48:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:48:47 INFO - 'talos_options': ['--disable-stylo'], 14:48:47 INFO - 'tests': ['damp', 'tps']}, 14:48:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:48:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:47 INFO - 'tests': ['dromaeo_dom']}, 14:48:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:48:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:47 INFO - 'tests': ['basic_compositor_video', 14:48:47 INFO - 'glvideo']}, 14:48:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:48:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:48:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:48:47 INFO - 'talos_options': ['--disable-stylo'], 14:48:47 INFO - 'tests': ['ts_paint_webext', 14:48:47 INFO - 'tp5o_webext']}, 14:48:47 INFO - 'other-e10s': {'tests': ['a11yr', 14:48:47 INFO - 'ts_paint', 14:48:47 INFO - 'tpaint', 14:48:47 INFO - 'sessionrestore', 14:48:47 INFO - 'sessionrestore_many_windows', 14:48:47 INFO - 'sessionrestore_no_auto_restore', 14:48:47 INFO - 'tabpaint']}, 14:48:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:47 INFO - 'tests': ['a11yr', 14:48:47 INFO - 'ts_paint', 14:48:47 INFO - 'tpaint', 14:48:47 INFO - 'sessionrestore', 14:48:47 INFO - 'sessionrestore_many_windows', 14:48:47 INFO - 'sessionrestore_no_auto_restore', 14:48:47 INFO - 'tabpaint']}, 14:48:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 14:48:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 14:48:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:47 INFO - 'tests': ['perf_reftest_singletons']}, 14:48:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:47 INFO - 'tests': ['perf_reftest']}, 14:48:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:48:47 INFO - 'tsvgr_opacity', 14:48:47 INFO - 'tart', 14:48:47 INFO - 'tscrollx', 14:48:47 INFO - 'tsvg_static']}, 14:48:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:47 INFO - 'tests': ['tsvgx', 14:48:47 INFO - 'tsvgr_opacity', 14:48:47 INFO - 'tart', 14:48:47 INFO - 'tscrollx', 14:48:47 INFO - 'tsvg_static']}, 14:48:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:48:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:48:47 INFO - 'talos_options': ['--disable-stylo'], 14:48:47 INFO - 'tests': ['tp5o']}, 14:48:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:48:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 14:48:47 INFO - 'talos_options': ['--mitmproxy', 14:48:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:48:47 INFO - '--firstNonBlankPaint'], 14:48:47 INFO - 'tests': ['tp6_google', 14:48:47 INFO - 'tp6_youtube', 14:48:47 INFO - 'tp6_amazon', 14:48:47 INFO - 'tp6_facebook']}, 14:48:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:48:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 14:48:47 INFO - 'talos_options': ['--disable-stylo', 14:48:47 INFO - '--mitmproxy', 14:48:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:48:47 INFO - '--firstNonBlankPaint'], 14:48:47 INFO - 'tests': ['tp6_google', 14:48:47 INFO - 'tp6_youtube', 14:48:47 INFO - 'tp6_amazon', 14:48:47 INFO - 'tp6_facebook']}, 14:48:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:48:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 14:48:47 INFO - 'talos_options': ['--stylo-threads=1', 14:48:47 INFO - '--mitmproxy', 14:48:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:48:47 INFO - '--firstNonBlankPaint'], 14:48:47 INFO - 'tests': ['tp6_google', 14:48:47 INFO - 'tp6_youtube', 14:48:47 INFO - 'tp6_amazon', 14:48:47 INFO - 'tp6_facebook']}, 14:48:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:48:47 INFO - 'talos_options': ['--xperf_path', 14:48:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:47 INFO - 'tests': ['tp5n']}, 14:48:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:48:47 INFO - 'talos_options': ['--disable-stylo', 14:48:47 INFO - '--xperf_path', 14:48:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:47 INFO - 'tests': ['tp5n']}}} 14:48:47 INFO - Running post-action listener: _resource_record_post_action 14:48:47 INFO - [mozharness: 2017-09-26 21:48:47.555149Z] Finished populate-webroot step (success) 14:48:47 INFO - [mozharness: 2017-09-26 21:48:47.555239Z] Running create-virtualenv step. 14:48:47 INFO - Running pre-action listener: _resource_record_pre_action 14:48:47 INFO - Running main action method: create_virtualenv 14:48:47 INFO - Creating virtualenv /builds/slave/test/build/venv 14:48:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:48:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 14:48:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:48:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:48:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:48:48 INFO - Installing distribute.............................................................................................................................................................................................done. 14:48:48 INFO - Installing pip...............done. 14:48:48 INFO - Return code: 0 14:48:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:48:49 INFO - Reading from file tmpfile_stdout 14:48:49 INFO - Output received: 14:48:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 14:48:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd60>, '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 0x1a9ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', '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 14:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:48:49 INFO - Using env: {'DISPLAY': ':0', 14:48:49 INFO - 'HOME': '/home/cltbld', 14:48:49 INFO - 'LANG': 'en_US.UTF-8', 14:48:49 INFO - 'LANGUAGE': 'en_US:en', 14:48:49 INFO - 'LOGNAME': 'cltbld', 14:48:49 INFO - 'MAIL': '/var/mail/cltbld', 14:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:49 INFO - 'MOZ_NO_REMOTE': '1', 14:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:49 INFO - 'NO_EM_RESTART': '1', 14:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:49 INFO - 'PWD': '/builds/slave/test', 14:48:49 INFO - 'SHELL': '/bin/bash', 14:48:49 INFO - 'SHLVL': '1', 14:48:49 INFO - 'TERM': 'linux', 14:48:49 INFO - 'TMOUT': '86400', 14:48:49 INFO - 'USER': 'cltbld', 14:48:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', 14:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:49 INFO - '_': '/tools/buildbot/bin/python'} 14:48:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 14:48:50 INFO - Downloading/unpacking pip>=1.5 14:48:50 INFO - Running setup.py egg_info for package pip 14:48:50 INFO - warning: no files found matching 'pip/cacert.pem' 14:48:50 INFO - warning: no files found matching '*.html' under directory 'docs' 14:48:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:48:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:48:50 INFO - Installing collected packages: pip 14:48:50 INFO - Found existing installation: pip 1.1 14:48:50 INFO - Uninstalling pip: 14:48:50 INFO - Successfully uninstalled pip 14:48:50 INFO - Running setup.py install for pip 14:48:50 INFO - warning: no files found matching 'pip/cacert.pem' 14:48:50 INFO - warning: no files found matching '*.html' under directory 'docs' 14:48:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:48:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:48:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 14:48:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 14:48:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 14:48:50 INFO - Successfully installed pip 14:48:50 INFO - Cleaning up... 14:48:50 INFO - Return code: 0 14:48:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd60>, '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 0x1a9ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', '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 14:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:48:50 INFO - Using env: {'DISPLAY': ':0', 14:48:50 INFO - 'HOME': '/home/cltbld', 14:48:50 INFO - 'LANG': 'en_US.UTF-8', 14:48:50 INFO - 'LANGUAGE': 'en_US:en', 14:48:50 INFO - 'LOGNAME': 'cltbld', 14:48:50 INFO - 'MAIL': '/var/mail/cltbld', 14:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:50 INFO - 'MOZ_NO_REMOTE': '1', 14:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:50 INFO - 'NO_EM_RESTART': '1', 14:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:50 INFO - 'PWD': '/builds/slave/test', 14:48:50 INFO - 'SHELL': '/bin/bash', 14:48:50 INFO - 'SHLVL': '1', 14:48:50 INFO - 'TERM': 'linux', 14:48:50 INFO - 'TMOUT': '86400', 14:48:50 INFO - 'USER': 'cltbld', 14:48:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', 14:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:50 INFO - '_': '/tools/buildbot/bin/python'} 14:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:50 INFO - Downloading/unpacking psutil>=3.1.1 14:48:50 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 14:48:50 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 14:48:50 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 14:48:50 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 14:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:48:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:52 INFO - Installing collected packages: psutil 14:48:52 INFO - Running setup.py install for psutil 14:48:52 INFO - building 'psutil._psutil_linux' extension 14:48:52 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 14:48:53 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 14:48:53 INFO - building 'psutil._psutil_posix' extension 14:48:53 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 14:48:54 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 14:48:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:54 INFO - Successfully installed psutil 14:48:54 INFO - Cleaning up... 14:48:54 INFO - Return code: 0 14:48:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48: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')]} 14:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd60>, '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 0x1a9ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', '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 14:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:48:54 INFO - Using env: {'DISPLAY': ':0', 14:48:54 INFO - 'HOME': '/home/cltbld', 14:48:54 INFO - 'LANG': 'en_US.UTF-8', 14:48:54 INFO - 'LANGUAGE': 'en_US:en', 14:48:54 INFO - 'LOGNAME': 'cltbld', 14:48:54 INFO - 'MAIL': '/var/mail/cltbld', 14:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:54 INFO - 'MOZ_NO_REMOTE': '1', 14:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:54 INFO - 'NO_EM_RESTART': '1', 14:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:54 INFO - 'PWD': '/builds/slave/test', 14:48:54 INFO - 'SHELL': '/bin/bash', 14:48:54 INFO - 'SHLVL': '1', 14:48:54 INFO - 'TERM': 'linux', 14:48:54 INFO - 'TMOUT': '86400', 14:48:54 INFO - 'USER': 'cltbld', 14:48:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', 14:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:54 INFO - '_': '/tools/buildbot/bin/python'} 14:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:48:55 INFO - Installing collected packages: mozsystemmonitor 14:48:55 INFO - Running setup.py install for mozsystemmonitor 14:48:55 INFO - Successfully installed mozsystemmonitor 14:48:55 INFO - Cleaning up... 14:48:55 INFO - Return code: 0 14:48:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd60>, '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 0x1a9ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', '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 14:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:48:55 INFO - Using env: {'DISPLAY': ':0', 14:48:55 INFO - 'HOME': '/home/cltbld', 14:48:55 INFO - 'LANG': 'en_US.UTF-8', 14:48:55 INFO - 'LANGUAGE': 'en_US:en', 14:48:55 INFO - 'LOGNAME': 'cltbld', 14:48:55 INFO - 'MAIL': '/var/mail/cltbld', 14:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:55 INFO - 'MOZ_NO_REMOTE': '1', 14:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:55 INFO - 'NO_EM_RESTART': '1', 14:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:55 INFO - 'PWD': '/builds/slave/test', 14:48:55 INFO - 'SHELL': '/bin/bash', 14:48:55 INFO - 'SHLVL': '1', 14:48:55 INFO - 'TERM': 'linux', 14:48:55 INFO - 'TMOUT': '86400', 14:48:55 INFO - 'USER': 'cltbld', 14:48:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', 14:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:55 INFO - '_': '/tools/buildbot/bin/python'} 14:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:55 INFO - Downloading/unpacking jsonschema==2.5.1 14:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:48:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:48:57 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 14:48:57 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 14:48:57 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 14:48:57 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 14:48:57 INFO - Downloading functools32-3.2.3-2.tar.gz 14:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:48:57 INFO - warning: no files found matching '*.txt' 14:48:57 INFO - no previously-included directories found matching 'build' 14:48:57 INFO - no previously-included directories found matching 'dist' 14:48:57 INFO - no previously-included directories found matching '.git*' 14:48:57 INFO - Installing collected packages: jsonschema, functools32 14:48:57 INFO - Running setup.py install for functools32 14:48:57 INFO - warning: no files found matching '*.txt' 14:48:57 INFO - no previously-included directories found matching 'build' 14:48:57 INFO - no previously-included directories found matching 'dist' 14:48:57 INFO - no previously-included directories found matching '.git*' 14:48:57 INFO - Successfully installed jsonschema functools32 14:48:57 INFO - Cleaning up... 14:48:57 INFO - Return code: 0 14:48:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48: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')]} 14:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48: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', '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 0x17311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd60>, '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 0x1a9ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', '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 14:48: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:48: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 functools32==3.2.3-2 14:48:57 INFO - Using env: {'DISPLAY': ':0', 14:48:57 INFO - 'HOME': '/home/cltbld', 14:48:57 INFO - 'LANG': 'en_US.UTF-8', 14:48:57 INFO - 'LANGUAGE': 'en_US:en', 14:48:57 INFO - 'LOGNAME': 'cltbld', 14:48:57 INFO - 'MAIL': '/var/mail/cltbld', 14:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:57 INFO - 'MOZ_NO_REMOTE': '1', 14:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:57 INFO - 'NO_EM_RESTART': '1', 14:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:57 INFO - 'PWD': '/builds/slave/test', 14:48:57 INFO - 'SHELL': '/bin/bash', 14:48:57 INFO - 'SHLVL': '1', 14:48:57 INFO - 'TERM': 'linux', 14:48:57 INFO - 'TMOUT': '86400', 14:48:57 INFO - 'USER': 'cltbld', 14:48:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', 14:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:57 INFO - '_': '/tools/buildbot/bin/python'} 14:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:48:57 INFO - Cleaning up... 14:48:57 INFO - Return code: 0 14:48:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48: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')]} 14:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48: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', '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 0x17311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd60>, '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 0x1a9ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', '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 14:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:48: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 blobuploader==1.2.4 14:48:57 INFO - Using env: {'DISPLAY': ':0', 14:48:57 INFO - 'HOME': '/home/cltbld', 14:48:57 INFO - 'LANG': 'en_US.UTF-8', 14:48:57 INFO - 'LANGUAGE': 'en_US:en', 14:48:57 INFO - 'LOGNAME': 'cltbld', 14:48:57 INFO - 'MAIL': '/var/mail/cltbld', 14:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:57 INFO - 'MOZ_NO_REMOTE': '1', 14:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:57 INFO - 'NO_EM_RESTART': '1', 14:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:57 INFO - 'PWD': '/builds/slave/test', 14:48:57 INFO - 'SHELL': '/bin/bash', 14:48:57 INFO - 'SHLVL': '1', 14:48:57 INFO - 'TERM': 'linux', 14:48:57 INFO - 'TMOUT': '86400', 14:48:57 INFO - 'USER': 'cltbld', 14:48:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', 14:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:57 INFO - '_': '/tools/buildbot/bin/python'} 14:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:57 INFO - Downloading/unpacking blobuploader==1.2.4 14:48:57 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 14:48:57 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 14:48:57 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 14:48:57 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 14:48:59 INFO - Downloading blobuploader-1.2.4.tar.gz 14:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:48:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:48:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:59 INFO - Downloading docopt-0.6.1.tar.gz 14:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:48:59 INFO - Installing collected packages: blobuploader, requests, docopt 14:48:59 INFO - Running setup.py install for blobuploader 14:48:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:48:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:48:59 INFO - Running setup.py install for requests 14:49:00 INFO - Running setup.py install for docopt 14:49:00 INFO - Successfully installed blobuploader requests docopt 14:49:00 INFO - Cleaning up... 14:49:00 INFO - Return code: 0 14:49:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49: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')]} 14:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:00 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 0x17311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd60>, '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 0x1a9ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', '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 14:49:00 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 14:49:00 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 14:49:00 INFO - Using env: {'DISPLAY': ':0', 14:49:00 INFO - 'HOME': '/home/cltbld', 14:49:00 INFO - 'LANG': 'en_US.UTF-8', 14:49:00 INFO - 'LANGUAGE': 'en_US:en', 14:49:00 INFO - 'LOGNAME': 'cltbld', 14:49:00 INFO - 'MAIL': '/var/mail/cltbld', 14:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:00 INFO - 'MOZ_NO_REMOTE': '1', 14:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:00 INFO - 'NO_EM_RESTART': '1', 14:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:00 INFO - 'PWD': '/builds/slave/test', 14:49:00 INFO - 'SHELL': '/bin/bash', 14:49:00 INFO - 'SHLVL': '1', 14:49:00 INFO - 'TERM': 'linux', 14:49:00 INFO - 'TMOUT': '86400', 14:49:00 INFO - 'USER': 'cltbld', 14:49:00 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', 14:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:00 INFO - '_': '/tools/buildbot/bin/python'} 14:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:49:00 INFO - Running setup.py (path:/tmp/pip-zmwpj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:49:00 INFO - Running setup.py (path:/tmp/pip-IKXLRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:49:00 INFO - Running setup.py (path:/tmp/pip-K9WVWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:49:00 INFO - Running setup.py (path:/tmp/pip-jMbk8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:49:00 INFO - Running setup.py (path:/tmp/pip-FnUwR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:49:00 INFO - Running setup.py (path:/tmp/pip-YRoo8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:49:00 INFO - Running setup.py (path:/tmp/pip-yQjMPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:49:00 INFO - Running setup.py (path:/tmp/pip-tWhzwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:49:01 INFO - Running setup.py (path:/tmp/pip-vrTZcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:49:01 INFO - Running setup.py (path:/tmp/pip-Tkd_yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:49:01 INFO - Running setup.py (path:/tmp/pip-rBOc8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:49:01 INFO - Running setup.py (path:/tmp/pip-JaBKaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:49:01 INFO - Running setup.py (path:/tmp/pip-R45mEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:49:01 INFO - Running setup.py (path:/tmp/pip-aP_lcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:01 INFO - Running setup.py (path:/tmp/pip-IkbvUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:49:01 INFO - Running setup.py (path:/tmp/pip-lhy2zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:49:01 INFO - Running setup.py (path:/tmp/pip-nUvTUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:49:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:49:01 INFO - Running setup.py install for manifestparser 14:49:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:49:01 INFO - Running setup.py install for mozcrash 14:49:01 INFO - Running setup.py install for mozdebug 14:49:01 INFO - Running setup.py install for mozdevice 14:49:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:49:02 INFO - Running setup.py install for mozfile 14:49:02 INFO - Running setup.py install for mozhttpd 14:49:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:49:02 INFO - Running setup.py install for mozinfo 14:49:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:49:02 INFO - Running setup.py install for mozInstall 14:49:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:49:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:49:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:49:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:49:02 INFO - Running setup.py install for mozleak 14:49:02 INFO - Running setup.py install for mozlog 14:49:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:49:02 INFO - Running setup.py install for moznetwork 14:49:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:49:02 INFO - Running setup.py install for mozprocess 14:49:02 INFO - Running setup.py install for mozprofile 14:49:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:49:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:49:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:49:03 INFO - Running setup.py install for mozrunner 14:49:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:49:03 INFO - Running setup.py install for mozscreenshot 14:49:03 INFO - Running setup.py install for moztest 14:49:03 INFO - Running setup.py install for mozversion 14:49:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:49:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:49:03 INFO - Cleaning up... 14:49:03 INFO - Return code: 0 14:49:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:03 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 0x17311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd60>, '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 0x1a9ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', '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 14:49:03 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 14:49:03 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 14:49:03 INFO - Using env: {'DISPLAY': ':0', 14:49:03 INFO - 'HOME': '/home/cltbld', 14:49:03 INFO - 'LANG': 'en_US.UTF-8', 14:49:03 INFO - 'LANGUAGE': 'en_US:en', 14:49:03 INFO - 'LOGNAME': 'cltbld', 14:49:03 INFO - 'MAIL': '/var/mail/cltbld', 14:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:03 INFO - 'MOZ_NO_REMOTE': '1', 14:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:03 INFO - 'NO_EM_RESTART': '1', 14:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:03 INFO - 'PWD': '/builds/slave/test', 14:49:03 INFO - 'SHELL': '/bin/bash', 14:49:03 INFO - 'SHLVL': '1', 14:49:03 INFO - 'TERM': 'linux', 14:49:03 INFO - 'TMOUT': '86400', 14:49:03 INFO - 'USER': 'cltbld', 14:49:03 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', 14:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:03 INFO - '_': '/tools/buildbot/bin/python'} 14:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:49:03 INFO - Running setup.py (path:/tmp/pip-gRQL0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:49:03 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)) 14:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:49:03 INFO - Running setup.py (path:/tmp/pip-ZkWK9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:49:03 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)) 14:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:49:03 INFO - Running setup.py (path:/tmp/pip-21gzqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:49:03 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)) 14:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:49:03 INFO - Running setup.py (path:/tmp/pip-o9F6U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:49:03 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)) 14:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:49:03 INFO - Running setup.py (path:/tmp/pip-OoOt6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:49:04 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)) 14:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:49:04 INFO - Running setup.py (path:/tmp/pip-SqDRub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:49:04 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)) 14:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:49:04 INFO - Running setup.py (path:/tmp/pip-lvyBQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:49:04 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)) 14:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:49:04 INFO - Running setup.py (path:/tmp/pip-HPrbqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:49:04 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)) 14:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:49:04 INFO - Running setup.py (path:/tmp/pip-2CPfBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:49:04 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)) 14:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:49:04 INFO - Running setup.py (path:/tmp/pip-ShvmoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:49:04 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)) 14:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:49:04 INFO - Running setup.py (path:/tmp/pip-N2MEOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:49:04 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)) 14:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:49:04 INFO - Running setup.py (path:/tmp/pip-zAAeUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:49:04 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)) 14:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:49:04 INFO - Running setup.py (path:/tmp/pip-XW27oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:49:04 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)) 14:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:49:04 INFO - Running setup.py (path:/tmp/pip-yh33Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:49:04 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)) 14:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:04 INFO - Running setup.py (path:/tmp/pip-uaVqtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:04 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)) 14:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:49:04 INFO - Running setup.py (path:/tmp/pip-empuVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:49:04 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)) 14:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:49:04 INFO - Running setup.py (path:/tmp/pip-HEhIZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:49:04 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)) 14:49:04 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)) 14:49:04 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)) 14:49:04 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)) 14:49:04 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)) 14:49:04 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)) 14:49:04 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)) 14:49:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:49: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 14:49: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 14:49: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 14:49: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 14:49:06 INFO - Downloading blessings-1.6.tar.gz 14:49:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:49:06 INFO - Installing collected packages: blessings 14:49:06 INFO - Running setup.py install for blessings 14:49:06 INFO - Successfully installed blessings 14:49:06 INFO - Cleaning up... 14:49:06 INFO - Return code: 0 14:49:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:49:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:49:06 INFO - Reading from file tmpfile_stdout 14:49:06 INFO - Current package versions: 14:49:06 INFO - argparse == 1.2.1 14:49:06 INFO - blessings == 1.6 14:49:06 INFO - blobuploader == 1.2.4 14:49:06 INFO - docopt == 0.6.1 14:49:06 INFO - functools32 == 3.2.3-2 14:49:06 INFO - jsonschema == 2.5.1 14:49:06 INFO - manifestparser == 1.1 14:49:06 INFO - mozInstall == 1.13 14:49:06 INFO - mozcrash == 1.0 14:49:06 INFO - mozdebug == 0.1 14:49:06 INFO - mozdevice == 0.51 14:49:06 INFO - mozfile == 1.2 14:49:06 INFO - mozhttpd == 0.7 14:49:06 INFO - mozinfo == 0.10 14:49:06 INFO - mozleak == 0.1 14:49:06 INFO - mozlog == 3.5 14:49:06 INFO - moznetwork == 0.27 14:49:06 INFO - mozprocess == 0.25 14:49:06 INFO - mozprofile == 0.28 14:49:06 INFO - mozrunner == 6.13 14:49:06 INFO - mozscreenshot == 0.1 14:49:06 INFO - mozsystemmonitor == 0.3 14:49:06 INFO - moztest == 0.8 14:49:06 INFO - mozversion == 1.4 14:49:06 INFO - psutil == 3.1.1 14:49:06 INFO - requests == 1.2.3 14:49:06 INFO - wsgiref == 0.1.2 14:49:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49: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')]} 14:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:06 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 0x17311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd60>, '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 0x1a9ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', '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 14:49:06 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 14:49:06 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 14:49:06 INFO - Using env: {'DISPLAY': ':0', 14:49:06 INFO - 'HOME': '/home/cltbld', 14:49:06 INFO - 'LANG': 'en_US.UTF-8', 14:49:06 INFO - 'LANGUAGE': 'en_US:en', 14:49:06 INFO - 'LOGNAME': 'cltbld', 14:49:06 INFO - 'MAIL': '/var/mail/cltbld', 14:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:06 INFO - 'MOZ_NO_REMOTE': '1', 14:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:06 INFO - 'NO_EM_RESTART': '1', 14:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:06 INFO - 'PWD': '/builds/slave/test', 14:49:06 INFO - 'SHELL': '/bin/bash', 14:49:06 INFO - 'SHLVL': '1', 14:49:06 INFO - 'TERM': 'linux', 14:49:06 INFO - 'TMOUT': '86400', 14:49:06 INFO - 'USER': 'cltbld', 14:49:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', 14:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:06 INFO - '_': '/tools/buildbot/bin/python'} 14:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:06 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)) 14:49:06 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)) 14:49:06 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)) 14:49:06 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)) 14:49:06 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)) 14:49:06 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)) 14:49:06 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)) 14:49:06 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)) 14:49:06 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)) 14:49:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:49:06 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 14:49:06 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 14:49:06 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 14:49:06 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 14:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:49:07 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)) 14:49:07 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)) 14:49:07 INFO - Installing collected packages: simplejson 14:49:07 INFO - Running setup.py install for simplejson 14:49:07 INFO - building 'simplejson._speedups' extension 14:49:07 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 14:49:08 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 14:49:08 INFO - Successfully installed simplejson 14:49:08 INFO - Cleaning up... 14:49:08 INFO - Return code: 0 14:49:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:08 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 0x17311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd60>, '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 0x1a9ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', '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 14:49:08 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 14:49:08 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 14:49:08 INFO - Using env: {'DISPLAY': ':0', 14:49:08 INFO - 'HOME': '/home/cltbld', 14:49:08 INFO - 'LANG': 'en_US.UTF-8', 14:49:08 INFO - 'LANGUAGE': 'en_US:en', 14:49:08 INFO - 'LOGNAME': 'cltbld', 14:49:08 INFO - 'MAIL': '/var/mail/cltbld', 14:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:08 INFO - 'MOZ_NO_REMOTE': '1', 14:49:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:08 INFO - 'NO_EM_RESTART': '1', 14:49:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:08 INFO - 'PWD': '/builds/slave/test', 14:49:08 INFO - 'SHELL': '/bin/bash', 14:49:08 INFO - 'SHLVL': '1', 14:49:08 INFO - 'TERM': 'linux', 14:49:08 INFO - 'TMOUT': '86400', 14:49:08 INFO - 'USER': 'cltbld', 14:49:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', 14:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:08 INFO - '_': '/tools/buildbot/bin/python'} 14:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:49:09 INFO - Cleaning up... 14:49:09 INFO - Return code: 0 14:49:09 INFO - Running post-action listener: _resource_record_post_action 14:49:09 INFO - Running post-action listener: _start_resource_monitoring 14:49:09 INFO - Starting resource monitoring. 14:49:09 INFO - [mozharness: 2017-09-26 21:49:09.181023Z] Finished create-virtualenv step (success) 14:49:09 INFO - [mozharness: 2017-09-26 21:49:09.182055Z] Running install step. 14:49:09 INFO - Running pre-action listener: _resource_record_pre_action 14:49:09 INFO - Running main action method: install 14:49:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:49:09 INFO - Reading from file tmpfile_stdout 14:49:09 INFO - Detecting whether we're running mozinstall >=1.0... 14:49:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:49:09 INFO - Reading from file tmpfile_stdout 14:49:09 INFO - Output received: 14:49:09 INFO - Usage: mozinstall [options] installer 14:49:09 INFO - Options: 14:49:09 INFO - -h, --help show this help message and exit 14:49:09 INFO - -d DEST, --destination=DEST 14:49:09 INFO - Directory to install application into. [default: 14:49:09 INFO - "/builds/slave/test"] 14:49:09 INFO - --app=APP Application being installed. [default: firefox] 14:49:09 INFO - mkdir: /builds/slave/test/build/application 14:49:09 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'] 14:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:49:27 INFO - Reading from file tmpfile_stdout 14:49:27 INFO - Output received: 14:49:27 INFO - /builds/slave/test/build/application/firefox/firefox 14:49:27 INFO - Running post-action listener: _resource_record_post_action 14:49:27 INFO - [mozharness: 2017-09-26 21:49:27.298579Z] Finished install step (success) 14:49:27 INFO - [mozharness: 2017-09-26 21:49:27.298829Z] Running setup-mitmproxy step. 14:49:27 INFO - Running pre-action listener: _resource_record_pre_action 14:49:27 INFO - Running main action method: setup_mitmproxy 14:49:27 INFO - Skipping: mitmproxy is not required 14:49:27 INFO - Running post-action listener: _resource_record_post_action 14:49:27 INFO - [mozharness: 2017-09-26 21:49:27.299954Z] Finished setup-mitmproxy step (success) 14:49:27 INFO - [mozharness: 2017-09-26 21:49:27.300173Z] Running run-tests step. 14:49:27 INFO - Running pre-action listener: _resource_record_pre_action 14:49:27 INFO - Running pre-action listener: _set_gcov_prefix 14:49:27 INFO - Running main action method: run_tests 14:49:27 WARNING - Try message not found. 14:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:49:27 INFO - Python 2.7.3 14:49:27 INFO - Return code: 0 14:49:27 INFO - grabbing minidump binary from tooltool 14:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:27 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 0x1a9bd60>, '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 0x1a9ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:49:27 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 14:49:27 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 14:49:27 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 14:49:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:49:27 INFO - Return code: 0 14:49:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:49:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:49:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:49:27 INFO - ENV: RUST_BACKTRACE is now full 14:49:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:49:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 14:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 14:49:27 INFO - Using env: {'DISPLAY': ':0', 14:49:27 INFO - 'HOME': '/home/cltbld', 14:49:27 INFO - 'LANG': 'en_US.UTF-8', 14:49:27 INFO - 'LANGUAGE': 'en_US:en', 14:49:27 INFO - 'LOGNAME': 'cltbld', 14:49:27 INFO - 'MAIL': '/var/mail/cltbld', 14:49:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:49:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:27 INFO - 'MOZ_NO_REMOTE': '1', 14:49:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:27 INFO - 'NO_EM_RESTART': '1', 14:49:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:27 INFO - 'PWD': '/builds/slave/test', 14:49:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:49:27 INFO - 'RUST_BACKTRACE': 'full', 14:49:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:49:27 INFO - 'SHELL': '/bin/bash', 14:49:27 INFO - 'SHLVL': '1', 14:49:27 INFO - 'TERM': 'linux', 14:49:27 INFO - 'TMOUT': '86400', 14:49:27 INFO - 'USER': 'cltbld', 14:49:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', 14:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:27 INFO - '_': '/tools/buildbot/bin/python'} 14:49:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 14:49:28 INFO - mozversion application_buildid: 20170926203052 14:49:28 INFO - mozversion application_changeset: 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b 14:49:28 INFO - mozversion application_display_name: Nightly 14:49:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:49:28 INFO - mozversion application_name: Firefox 14:49:28 INFO - mozversion application_remotingname: firefox 14:49:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:49:28 INFO - mozversion application_vendor: Mozilla 14:49:28 INFO - mozversion application_version: 58.0a1 14:49:28 INFO - mozversion platform_buildid: 20170926203052 14:49:28 INFO - mozversion platform_changeset: 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b 14:49:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:49:28 INFO - mozversion platform_version: 58.0a1 14:49:28 INFO - using testdate: 1506462568 14:49:28 INFO - actual date: 1506462568 14:49:28 INFO - starting webserver on 'localhost:40958' 14:49:28 INFO - SUITE-START | Running 2 tests 14:49:28 INFO - TEST-START | dromaeo_css 14:49:28 INFO - Initialising browser for dromaeo_css test... 14:49:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40958/getInfo.html -profile /tmp/tmpK88HEQ/profile 14:49:28 INFO - TEST-INFO | started process 3598 (/builds/slave/test/build/application/firefox/firefox http://localhost:40958/getInfo.html) 14:49:37 INFO - TEST-INFO | 3598: exit 0 14:49:38 INFO - Browser initialized. 14:49:38 INFO - Running cycle 1/1 for dromaeo_css test... 14:49:38 INFO - Using env: {'DISPLAY': ':0', 14:49:38 INFO - 'HOME': '/home/cltbld', 14:49:38 INFO - 'JSGC_DISABLE_POISONING': '1', 14:49:38 INFO - 'LANG': 'en_US.UTF-8', 14:49:38 INFO - 'LANGUAGE': 'en_US:en', 14:49:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:49:38 INFO - 'LOGNAME': 'cltbld', 14:49:38 INFO - 'MAIL': '/var/mail/cltbld', 14:49:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:49:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:49:38 INFO - 'MOZ_CRASHREPORTER': '1', 14:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:49:38 INFO - 'MOZ_NO_REMOTE': '1', 14:49:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:38 INFO - 'NO_EM_RESTART': '1', 14:49:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:38 INFO - 'PWD': '/builds/slave/test', 14:49:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:49:38 INFO - 'RUST_BACKTRACE': 'full', 14:49:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:49:38 INFO - 'SHELL': '/bin/bash', 14:49:38 INFO - 'SHLVL': '1', 14:49:38 INFO - 'STYLO_FORCE_DISABLED': '1', 14:49:38 INFO - 'TERM': 'linux', 14:49:38 INFO - 'TMOUT': '86400', 14:49:38 INFO - 'USER': 'cltbld', 14:49:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', 14:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:38 INFO - '_': '/tools/buildbot/bin/python'} 14:49:38 INFO - TEST-INFO | started process 3834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK88HEQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:49:38 INFO - PID 3834 | 14:49:38 INFO - PID 3834 | (/builds/slave/test/build/application/firefox/firefox:3884): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:49:38 INFO - PID 3834 | 14:49:49 INFO - PID 3834 | RSS: Main: 144609280 14:49:49 INFO - PID 3834 | 14:52:46 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:40958/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40958/tests/dromaeo/cssquery-ext.html) 14:52:47 INFO - PID 3834 | RSS: Main: 146132992 14:52:47 INFO - PID 3834 | 14:55:49 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:40958/tests/dromaeo/cssquery-ext.html (next: http://localhost:40958/tests/dromaeo/cssquery-jquery.html) 14:55:50 INFO - PID 3834 | RSS: Main: 146173952 14:55:50 INFO - PID 3834 | 14:58:51 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:40958/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40958/tests/dromaeo/cssquery-mootools.html) 14:58:52 INFO - PID 3834 | RSS: Main: 145973248 14:58:52 INFO - PID 3834 | 15:01:53 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:40958/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40958/tests/dromaeo/cssquery-prototype.html) 15:01:54 INFO - PID 3834 | RSS: Main: 145096704 15:01:54 INFO - PID 3834 | 15:04:57 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:40958/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40958/tests/dromaeo/cssquery-yui.html) 15:04:57 INFO - PID 3834 | RSS: Main: 147927040 15:04:57 INFO - PID 3834 | 15:07:59 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:40958/tests/dromaeo/cssquery-yui.html (next: http://localhost:40958/tests/dromaeo/cssquery-dojo.html) 15:07:59 INFO - PID 3834 | RSS: Main: 150294528 15:07:59 INFO - PID 3834 | 15:07:59 INFO - PID 3834 | __start_tp_report 15:07:59 INFO - PID 3834 | _x_x_mozilla_page_load 15:07:59 INFO - PID 3834 | _x_x_mozilla_page_load_details 15:07:59 INFO - PID 3834 | |i|pagename|runs| 15:07:59 INFO - PID 3834 | |0;dojo.html;3891.3773796192604;3893.4354518594805;3906.1406490572062;3911.550171730252;3939.9015024624364;6147.723352449139;6175.289841668209;6323.36766323368;6336.239651241852;6430.485561155108;6180.6291622502795;6240.750369985207;6269.655168965705;6413.326600706929;6420.1653785008;5703.800366987156;5708.571857110713;5727.055035919089;5759.366469688331;5804.796832110877;1002.3500458914544;5667.121596152582;5676.602637815355;5697.914531282014;5724.427557244263;5670.376258611549;5675.716214189295;5724.656520608756;5741.770329186827;5765.654060756368;5648.519875810561;5670.092785154356;5749.137629355589;5757.568182386338;5761.510271626917;5650.943490565124;5716.456936591017;5724.141378793172;5728.198052272685;5739.82780516581;6208.534359923024;6300.275468321156;6323.462505687022;6351.745930162788;6399.8080057598345;6748.426383757386;6812.45500359975;6816.625085620289;6825.931740682579;6828.931710682879;6881.208661003999;6974.546654467444;6989.5456795308655;7013.92986070143;7032.191298000745;6340.809775706736;6364.809055728336;6369.777057803001;6448.903266451007;6523.249826269945;7054.823629409203;7122.216556178816;7157.713691452388;7162.2121566628675;7170.713171473187;6646.86706265872;6762.898556521656;6800.591964482147;6873.621950792654;6874.8625027500175;6760.93239067603;6869.931300687029;6916.827079322957;6953.235144134142;6955.782738020927;6899.55152915069;6919.688614012382;6924.169099708067;6928.030075789394;6937.549059311129;6777.695003724844;6810.012548180585;6875.656217189221;6939.23668396476;6961.547499412522;4834.564889159992;4910.337104490919;4936.185529387611;5024.49755024502;5030.522100400456;4488.865334039984;4509.954900451019;4530.569595888385;4563.9087218255445;4579.038401935564;6332.778352757631;6340.873182536416;6375.171227740457;6436.195475565554;6438.098666186737;6783.253842077367;6798.76204332846;6877.9656101720175;6879.484038697117;6972.023916651673;6254.906176407358;6278.6860656966965;6357.237131544151;6416.935830641633;6431.453326467303;5536.141898005815;5538.280023596906;5609.439056094439;5613.045782217033;5635.943640563624;6961.721531138698;6961.860762784716;7181.820454488575;7286.854262914712;7293.27067293277;6691.832704182434;6753.898691519533;6833.111695479556;6846.897296540656;6873.518853680194;7059.541129826544;7063.434925205868;7178.138623365229;7206.4595155364605;7240.927590724236;6754.324567543206;6763.6618169092335;6834.726610935706;6838.794836154923;6850.931490685229;6790.5925644461495;6805.183377994672;6924.896126558005;6946.270641582561;6964.616946068015;6630.801075967729;6694.665266736546;6721.462283017249;6735.023421603938;6737.3599508046655;6536.575122617015;6624.668766561749;6635.4359879410795;6720.731170753311;6741.696623652046;6417.1657684500715;6501.9674901625185;6525.9021114684265;6530.151080359523;6532.248791388861;6536.509761767791;6559.311272316338;6617.205935287604;6621.801345959629;6660.6336651484635;6396.648184349905;6556.2788093308745;6562.048502966947;6570.901436478553;6607.438367738604 15:07:59 INFO - PID 3834 | |1;ext.html;963.4267610771589;990.6037584966014;1017.5014243020922;1019.8164330420526;1019.9898001019992;41547;42588;42835.35746963798;42836.571634283726;42874.78562607186;39861.20277594446;44086.55913440865;44731.105377892425;44818.32772508415;44941.55058449414;8264.380171487133;8292.668293268262;8354.081051084377;8377.748667539983;8378;8282.710105146321;8401.453905496153;8411.200935911109;8413.242808147266;8417.158284171564;8448.493090414595;8452.704155354564;8455.196756308142;8460.323174146084;8482.78793030173;8397.454165479256;8443.282321002722;8446.197611226955;8458.957705211435;8472.534010629413;8225.177482251787;8229.177082291782;8230.465019773696;8246.587670616445;8255.587220639005;39234.803825980685;39361.80319098386;39541.60458395408;39618.60381396178;39655.20689586192;3708.2027364116843;3726.2920045191327;3743.925121497582;3747.662710356081;3752.5496940367057;31880.681193188004;31990;32429;32435.02694919156;32548.67451325504;5162.328897243335;5355.678659280456;5371.81198658049;5429.837104886859;5434.239206511092;226228;227442;229171;231046;239720;52524.73737631287;53055.734721326146;53180.468195318324;53193.2021019685;53279;55276.72361638166;55325;55344.6163845899;55606;55695.44304556984;15718.607034823992;15767.842321576867;15777.447789327549;15859.52421427359;15993.680126397407;12800;12855.871441285468;12878.356082195853;12903.806442903364;12939.805902911465;13432.731345373038;13567.796483052762;13626.795598066037;13752.518661846787;13783.310834458238;5238.68567885928;5326.893462130735;5328.387235467893;5333.893322133536;5349.518543331119;1066.258950029722;1093.2565855218527;1099.9890001100046;1102.3055475050828;1126.0653657464286;24987.500249994897;25011.249662510152;25042.123525676514;25049.4990100197;25110.37224069413;1180.2033627301537;1193.5882120668355;1209.1173443386376;1213.2720367779261;1225.4118023348842;13140.211587304791;13272.137311074943;13273;13364.866351336557;13404.19574825494;271268;272918;274499;275107;275208;56333;56359.71820140955;56498.152527711296;56569;56577;1497.430976229026;1508.1588102192086;1526.1072272720362;1527.9388824446899;1529.3941361570307;24312;24452.26643200707;24645.876770616032;24694.50177803241;24793;38871.6112838868;38875.02812429712;38891.22217555576;38930.0267493315;38946.22107557776;231184;232392;232453;232628;233001;34644;35769.46345804763;36089.81955090208;36126;36152.819235903655;44185;46236;46253.30620040769;46604.30093548667;46957;34211.657883421845;34289.314213715086;34295.828520857234;34797.82601086979;34851.16107335681;33781.790729880624;34305;34380.14049648679;34446.311073777884;35197.47203791894;40221.79889100536;40446.59553404428;40623.796881015405;40671;40727.79636101919;33265.83367083149;33396.66603334033;33793.13784161161;34129;34320.65679343174;25240.368990775376;25389.238322850342;25668;25759;25783.613245801702 15:07:59 INFO - PID 3834 | |2;jquery.html;625.3746253746253;625.4027403829343;627.5669787846388;633.7560039384836;640.7020735358059;23516.88241558792;23882.40293992651;24204.636930446035;24220.75779242207;25103;26075.86962065187;27088.59367109495;27249;27318.31704207396;27401.177964661092;6532.5100617453645;6726.865462690744;6741.865162696743;6749.662516874161;6759.1213142291435;6471;6644.734210631569;6738.460923126138;6745.156855393076;6749.392554670078;6689.531732778707;6699.4305484033675;6699.497537684669;6701.262861085301;6709.664516774166;6520.543561950689;6690.933090669079;6699.129113215299;6742.460603151736;6773.491988100863;6317;6318.905216421757;6323.30443651198;6325.399087086719;6330.778422755181;31301.843490782627;31675.84162079198;31700;31758.364832703217;31799.682003180136;2249.0329158461855;2275.2377953385635;2278.5670722562827;2279.908803647852;2281.041962375806;19886.602267954706;21420;21537.353879383645;21560.56878862414;21609.567808643897;2494.114589320783;2535.0620270500035;2576.7036790768925;2582.9612555811677;2584.5218634552666;133409;140203.29898350546;150610;158108;158873.20563397225;15984.842046323598;16072.919635401748;16249.187540622921;16861.241244144043;17093.743593846102;26511.33721656974;26566;26641.600375994374;26682.733172668413;26751.197464076107;9600.519974001412;9805.411675299505;9862.112409883144;10017.449040302708;10111.544980475895;8665.523396213268;8735.475871447734;8738;8818.470891746516;8851.822963540822;9932;9961.40231586107;10034.147097496649;10264.178865690727;10315.17478601725;2889.5376739721964;2924.6782853886057;2926.6634337051087;2930.615139513865;2960.703929607022;1061.6761887624348;1062.219268837404;1072.828347464402;1074.425182527344;1075.4300220882944;21898.23356182526;22050.88974555149;22245;22331.218407355664;22390.888045559666;1122.4668282565879;1125.4485302202027;1139.5612689114585;1140.8745038045809;1144.3934714601107;11790.94104529472;12095.334756588472;12125.818112728317;12127.151099422956;12252.326122063194;602283;607211;610764;623080;660068;129139.77150571311;132336.02991910258;132948;133342;134966;1125.189863298424;1178.699431644925;1228.2016689152122;1236.7402845402387;1297.156848048757;22551.774482255623;23163;23249.53500929938;23296.6505502421;23334.416639584146;62909.68545157245;63347.6832615834;63756.36243637504;64001.67999159975;65388.67305663441;82294;82389;82607;82867.5856620713;83444;15923.52229433119;16144.67710645757;16241.59396015109;16244.350225990827;16317.510474685778;25097.87451062733;25248.62127068132;25334.239972800846;25574;25608.10371636984;19601.803981959998;20105.698414524086;20527.4868128298;20601.381958541268;20631.174753010313;17569.385071522946;17680;17969.19138638738;18133;18839.24643014319;20428.48928776733;20514;20670.793292066886;20770.1691932321;20894.37316880496;15686.137262450675;15690.137042462318;15849.366025359317;15866.7619985698;15884.68230635404;20236;20361.49096272605;20377.184912603923;20471.692924605846;20545 15:07:59 INFO - PID 3834 | |3;mootools.html;1445.7253121906838;1489.0544504239804;1496;1507.1409296700879;1520.2702702702702;16511.33954641813;17301.82698173018;17303.653926921455;17322.56693582661;17330.74003889943;16868.83131168691;16968;16993.405230816923;17011.744823827652;17017.82982170178;2759.751622353988;2773.653293338333;2794.455081259155;2811.8734656940383;2821.4357128574266;2682.986585067072;2772.1267800642836;2772.348498102944;2775.4726601945567;2779.805413621047;2730.7269273072734;2765.7234276572385;2773.195773225762;2774.140016594852;2780.541210700242;2439.5730747119273;2469.4814089041324;2479.826412151141;2483.67712197415;2488.1664642344836;2021.0400059971544;2046.98976505118;2054.116729806183;2055.198472595689;2065.814076733101;16025.519234422985;16275;16335;16367.83632163675;16368.345266189339;8329.250367466897;8458.196471335214;8571.657133714643;8574.957125214334;8577.785555361104;5359.919601205985;5608.074667679828;5608.186812912105;5638.548916086703;5863.149843272744;2121.193946300396;2159.9136034558755;2179.574982878339;2184.071769497973;2242.7981481666566;27038.45923081547;27884;27923.301917452023;29168.8541557293;29827.70172298271;7513.661885215179;7581.052368453943;7604.315611594983;7743.612819359122;7746.883796743054;22326.776732232796;22339.55320893573;22346.21788237404;22354.217602384164;22543.323700289016;8767.517786521803;8784.341174411944;8787.912120878837;8788.296936245086;8788.956055219684;7476.663550140257;7633.618319084135;7725.575093369918;7729.961350193213;7739.535627862234;5706.343770466367;5903.675297858573;5996.970015149896;6010.647604289;6112.938870611326;1763.8941663500232;1768.7081631530912;1789.4899953513186;1811.148760082759;1814.0657561355913;961.1397798969883;964.6912987843963;973.536951512674;992.6277645882794;996.3573495095623;8970.372073954892;9258.72223833286;9281.72154835356;9333.953330233306;9411.482368469662;786.4612740272931;802.5144787403653;810.4569938141459;815.8613035783931;817.4768148385039;4936.950630493649;4973.626977976666;4990.50094990498;5007.824726134568;5068.138416469209;23672.64491032636;24297.149599763925;24433.267001989967;24491.755082449305;24814.37964050877;23813.523729525314;24409.51180976406;24495.510089798103;24702;24762.133325333525;12260.81608775869;12526.81209781854;12631.747365052648;12632.05259605515;12637.494500219887;9396.906030939603;9598.184154346958;9602.519874006412;9611.951940240533;9640.662576809778;19801.50496237548;20398.694019590013;20527.28154514585;20759.273425430038;20912.37262882116;21119.577608448053;21359.893200533897;21384.893075534525;21484.24805131813;21837.235696750537;12966.35168241603;13004.934975325063;13181.868181318448;13194;13263.535776247785;15300.61748456253;15538.844611553739;15557.299921503785;15577.454789082327;15583;12616.936915315364;12632.621021369374;12721.236725796482;12877.35613219354;12883.098183127091;12187.634370968884;12314.876851231373;12419.130660853654;12490.188137771016;12544.937275313565;10700;10841.945790270998;10960.123190144928;10968.451577420938;11004.174686898354;8170.714025009096;8180.304674102768;8381.664733410595;8404.20160084791;8442.831143376976;8350.123237060265;8354.45696029756;8417.158284171534;8467.15328467173;8495.490270583785 15:07:59 INFO - PID 3834 | |4;prototype.html;545.1985581195644;562.3729541561158;568.2385603291591;573.7561536347052;578.4446930946291;6163.352847950968;6234.251889773228;6271.2788029376525;6278.340774218704;6312.6212427254395;6119.204503414549;6125.969370153154;6136.754529818813;6158.969205153968;6172.259328880529;5031.0441016206805;5049.873753156164;5150.510701483353;5159.613029022819;5196.194589838581;4884.438289596706;5093.714554112596;5101.387833459971;5129.307543481638;5133.974330128344;4957.553820156185;4987.301777751118;4991.351124353847;4995.100881841267;4995.350604421438;4955.851324460272;4957.900841983158;4970.254461830718;4972.925406118911;5016.197408414636;4401.163778882034;4508.61676757476;4539.455265368144;4541.296099104644;4558.680892337537;6151.477124444427;6176.87646247077;6188.319284878659;6204.441600255998;6207.968960155215;5815.767369305223;5845.357010728816;5873.97205489042;5880.147378630075;5895.380984996599;6624.668766561653;6640.1035860158745;6655.334466553354;6657.966710166466;6682.195807132047;5062.443131255559;5090.261912022773;5090.567301779353;5093.108705976476;5102.668326558799;6729.158855143107;6844.965775171142;6916.962455631645;6971.79084627462;6997.650117494156;5152.690838549699;5159.58723302135;5225.1378522543355;5247.081760691864;5254.3169387979315;5219.217117432416;5276.630635855453;5277.498637629419;5312.362516498045;5338.626296159309;5813.6221145625395;5851.64890106595;5855.765769369263;5870.119482077723;5887.852803679943;6589.374009469093;6683.966580167068;6696.129503164558;6721.630310332881;6730.226024007204;1784.723367877981;1786.580153663888;1809.1225755508567;1819.281383853397;1825.1239405085632;1245.483124503339;1269.8984081273477;1290.4773566705499;1292.793153095519;1293.5860524632028;6122.969385153135;6131.356207598138;6153.123532174702;6159.5072394208355;6202.534809889276;6557.639329836905;6604.603723776589;6640.236372817188;6685.364890335411;6742.595444273359;5958.272101090722;6038.215032045894;6079.574429789872;6113.23584551931;6115.449609535074;3473.166440054419;3480.617132115465;3495.147571786957;3502.422100353464;3538;6837.316268373223;6851.314868513208;6913.930860691429;6987.26633703464;6999.040268724765;6810.216825065082;6831.760888368884;6892.379685828299;6901.551399159039;6947.40947019509;6963.338482844122;7017.543859649107;7051.6474176292;7068;7129.60787156701;6600.765624843696;6693.096431981815;6705.228898676714;6708.26209116987;6757.729690812509;6603.9009414859775;6626.602403855784;6637.867242655217;6641.203055633355;6654.700538475877;6835.931640683729;6890.931090689029;6920.550164239308;6948.305169483011;6990.405815505739;5144.151215049625;5157.716325602128;5168.198929165986;5184.585233181412;5196.752779333008;6511.479081673549;6547.443467305332;6655.900161497485;6688.933110669026;6740.9325906740305;6274.780382686584;6434.613923164625;6499.545031847725;6520.967395162994;6528.543001990005;6424.453921416545;6514.055461958084;6538.1827271591055;6555.2133743951035;6578.013298005338;6443.710033048618;6476.773312934213;6512.251091124582;6526.934730652632;6532.41208291256;6547.279799222177;6624.735010599715;6659.500537459613;6660;6667.666616669244;6244.469220116341;6411.775587854403;6471.191101112361;6473.385028422293;6478.740850365933 15:07:59 INFO - PID 3834 | |5;yui.html;1003.3528374198642;1009.904059114384;1024.7643042100317;1031.0514326819325;1041.2659075351876;21163.788362116375;21504.89247553764;21550.676739848896;21551.245706400277;21614.24350147743;18789.530261743465;19117.904410477964;19127.713084303712;19142.904285478588;19265.133069011892;1044.1281529922524;1069.668402795136;1070.5878236878818;1073.6349641122017;1074.269496742217;1077.0790973717476;1085.5332207150923;1087.6954452753203;1088.9891101089006;1090.1333439915247;1095.8575385199913;1135.6195674449027;1137.1925932587872;1140.3386036099043;1140.914431417647;1122.2144498850837;1123.960661376856;1130.587335622496;1132.2640283815504;1134.0474001838454;784.5528049012065;814.9975530097953;818.3248819723692;821.0106821280343;822.6997146041712;21158.894205529028;21312.68030979521;21316.467088322763;21382.57234855294;21492.46268843276;22978.54042919149;23540.64689029666;23685.644715329283;23927.401814954592;23949.401264968343;18360.63278734431;18818.62362752751;19002.33491827793;19048.80951190484;19058.14238359277;4010.5387880393837;4022.658074063708;4034.3141665916864;4034.3141665916864;4042.191561687645;135003;159537;159587.2020639901;161332;162418;18323.175457104462;18356.632867342578;18604.34884779026;18687.439376818445;18787.436376908714;35066.474002889976;35121.770738024046;35196.64803351985;35357;35811.4628280576;10150.746231344276;10158.339707918962;10184.694459166238;10196.643117491001;10205.38767673942;4535.070310586388;4595.931061034087;4626.051659409813;4657.091867085954;4677.345171675968;6235.625862448268;6341.778037768749;6341.8097457076365;6355.459785918156;6363.236411630634;1207.7946749052683;1215.5867005218267;1237.8576463706788;1248.1076030638137;1252.017166524274;737.1154614462666;748.7940816275568;754.0235395163277;755.2636179724834;771.8957940677936;13153.53962611304;13245.867541324656;13598.524051658145;14101.153930763981;14273.357698903574;726.2156870579761;731.0751898847961;734.3354264390734;741.9035525381665;751.8158051277472;6355.3644635536075;6361.840953976095;6367.872642547123;6377.043443483514;6446.097546343516;145896;146771;149583;152615;154629.22685386502;122152.38923805323;124798.3760081212;131088;131750;136613;115172.42413787877;115545.4222728881;117589.4120529392;117973.41013294879;118817;13573.11774734639;14034.508792192633;14176.362063707364;14357.712845743235;14400.639984000483;55718.607034824454;55971;56200.71899640476;56694.14958775704;57411.71294143503;92924.53537732268;95165;95316.52341738247;98577.50711246398;103198.48400757948;19440.90279548593;20392;20424.489387765425;20432.0805563747;20467.590648186655;20271.797282027583;20393.796062039783;20469;20562.28032018872;21021.159153634297;20007.699884502035;20245.59508809845;20799.06404211784;21135.471613209793;21250.681239781727;18275.360362387786;18415.355462558746;18507.629847402706;19238.519037024187;20193.798062019778;18192.81807181964;18308.908455457637;18329.3584724534;18418.35535756242;18551.90724046371;15090.17004064787;15220.238988050332;15301;15514.5345639631;15576.766348505009;14955.40178392852;15273.556231002985;15557.688846222785;15594.376224950875;15752.60618484547 15:07:59 INFO - PID 3834 | __end_tp_report 15:07:59 INFO - PID 3834 | __start_cc_report 15:07:59 INFO - PID 3834 | _x_x_mozilla_cycle_collect,270 15:07:59 INFO - PID 3834 | __end_cc_report 15:07:59 INFO - PID 3834 | __startTimestamp1506463679642__endTimestamp 15:07:59 INFO - PID 3834 | 15:07:59 INFO - PID 3834 | ------- Summary: start ------- 15:07:59 INFO - PID 3834 | Number of tests: 6 15:07:59 INFO - PID 3834 | 15:07:59 INFO - PID 3834 | [#0] dojo.html Cycles:165 Average:6293.85 Median:6536.58 stddev:861.82 (13.2%) stddev-sans-first:843.60 15:07:59 INFO - PID 3834 | Values: 3891.4 3893.4 3906.1 3911.6 3939.9 6147.7 6175.3 6323.4 6336.2 6430.5 6180.6 6240.8 6269.7 6413.3 6420.2 5703.8 5708.6 5727.1 5759.4 5804.8 1002.4 5667.1 5676.6 5697.9 5724.4 5670.4 5675.7 5724.7 5741.8 5765.7 5648.5 5670.1 5749.1 5757.6 5761.5 5650.9 5716.5 5724.1 5728.2 5739.8 6208.5 6300.3 6323.5 6351.7 6399.8 6748.4 6812.5 6816.6 6825.9 6828.9 6881.2 6974.5 6989.5 7013.9 7032.2 6340.8 6364.8 6369.8 6448.9 6523.2 7054.8 7122.2 7157.7 7162.2 7170.7 6646.9 6762.9 6800.6 6873.6 6874.9 6760.9 6869.9 6916.8 6953.2 6955.8 6899.6 6919.7 6924.2 6928.0 6937.5 6777.7 6810.0 6875.7 6939.2 6961.5 4834.6 4910.3 4936.2 5024.5 5030.5 4488.9 4510.0 4530.6 4563.9 4579.0 6332.8 6340.9 6375.2 6436.2 6438.1 6783.3 6798.8 6878.0 6879.5 6972.0 6254.9 6278.7 6357.2 6416.9 6431.5 5536.1 5538.3 5609.4 5613.0 5635.9 6961.7 6961.9 7181.8 7286.9 7293.3 6691.8 6753.9 6833.1 6846.9 6873.5 7059.5 7063.4 7178.1 7206.5 7240.9 6754.3 6763.7 6834.7 6838.8 6850.9 6790.6 6805.2 6924.9 6946.3 6964.6 6630.8 6694.7 6721.5 6735.0 6737.4 6536.6 6624.7 6635.4 6720.7 6741.7 6417.2 6502.0 6525.9 6530.2 6532.2 6536.5 6559.3 6617.2 6621.8 6660.6 6396.6 6556.3 6562.0 6570.9 6607.4 15:07:59 INFO - PID 3834 | 15:07:59 INFO - PID 3834 | [#1] ext.html Cycles:180 Average:42100.29 Median:36107.91 stddev:64069.89 (177.4%) stddev-sans-first:64175.17 15:07:59 INFO - PID 3834 | Values: 963.4 990.6 1017.5 1019.8 1020.0 41547.0 42588.0 42835.4 42836.6 42874.8 39861.2 44086.6 44731.1 44818.3 44941.6 8264.4 8292.7 8354.1 8377.7 8378.0 8282.7 8401.5 8411.2 8413.2 8417.2 8448.5 8452.7 8455.2 8460.3 8482.8 8397.5 8443.3 8446.2 8459.0 8472.5 8225.2 8229.2 8230.5 8246.6 8255.6 39234.8 39361.8 39541.6 39618.6 39655.2 3708.2 3726.3 3743.9 3747.7 3752.5 31880.7 31990.0 32429.0 32435.0 32548.7 5162.3 5355.7 5371.8 5429.8 5434.2 226228.0 227442.0 229171.0 231046.0 239720.0 52524.7 53055.7 53180.5 53193.2 53279.0 55276.7 55325.0 55344.6 55606.0 55695.4 15718.6 15767.8 15777.4 15859.5 15993.7 12800.0 12855.9 12878.4 12903.8 12939.8 13432.7 13567.8 13626.8 13752.5 13783.3 5238.7 5326.9 5328.4 5333.9 5349.5 1066.3 1093.3 1100.0 1102.3 1126.1 24987.5 25011.2 25042.1 25049.5 25110.4 1180.2 1193.6 1209.1 1213.3 1225.4 13140.2 13272.1 13273.0 13364.9 13404.2 271268.0 272918.0 274499.0 275107.0 275208.0 56333.0 56359.7 56498.2 56569.0 56577.0 1497.4 1508.2 1526.1 1527.9 1529.4 24312.0 24452.3 24645.9 24694.5 24793.0 38871.6 38875.0 38891.2 38930.0 38946.2 231184.0 232392.0 232453.0 232628.0 233001.0 34644.0 35769.5 36089.8 36126.0 36152.8 44185.0 46236.0 46253.3 46604.3 46957.0 34211.7 34289.3 34295.8 34797.8 34851.2 33781.8 34305.0 34380.1 34446.3 35197.5 40221.8 40446.6 40623.8 40671.0 40727.8 33265.8 33396.7 33793.1 34129.0 34320.7 25240.4 25389.2 25668.0 25759.0 25783.6 15:07:59 INFO - PID 3834 | 15:07:59 INFO - PID 3834 | [#2] jquery.html Cycles:180 Average:40637.42 Median:23699.64 stddev:103699.34 (437.6%) stddev-sans-first:103946.72 15:07:59 INFO - PID 3834 | Values: 625.4 625.4 627.6 633.8 640.7 23516.9 23882.4 24204.6 24220.8 25103.0 26075.9 27088.6 27249.0 27318.3 27401.2 6532.5 6726.9 6741.9 6749.7 6759.1 6471.0 6644.7 6738.5 6745.2 6749.4 6689.5 6699.4 6699.5 6701.3 6709.7 6520.5 6690.9 6699.1 6742.5 6773.5 6317.0 6318.9 6323.3 6325.4 6330.8 31301.8 31675.8 31700.0 31758.4 31799.7 2249.0 2275.2 2278.6 2279.9 2281.0 19886.6 21420.0 21537.4 21560.6 21609.6 2494.1 2535.1 2576.7 2583.0 2584.5 133409.0 140203.3 150610.0 158108.0 158873.2 15984.8 16072.9 16249.2 16861.2 17093.7 26511.3 26566.0 26641.6 26682.7 26751.2 9600.5 9805.4 9862.1 10017.4 10111.5 8665.5 8735.5 8738.0 8818.5 8851.8 9932.0 9961.4 10034.1 10264.2 10315.2 2889.5 2924.7 2926.7 2930.6 2960.7 1061.7 1062.2 1072.8 1074.4 1075.4 21898.2 22050.9 22245.0 22331.2 22390.9 1122.5 1125.4 1139.6 1140.9 1144.4 11790.9 12095.3 12125.8 12127.2 12252.3 602283.0 607211.0 610764.0 623080.0 660068.0 129139.8 132336.0 132948.0 133342.0 134966.0 1125.2 1178.7 1228.2 1236.7 1297.2 22551.8 23163.0 23249.5 23296.7 23334.4 62909.7 63347.7 63756.4 64001.7 65388.7 82294.0 82389.0 82607.0 82867.6 83444.0 15923.5 16144.7 16241.6 16244.4 16317.5 25097.9 25248.6 25334.2 25574.0 25608.1 19601.8 20105.7 20527.5 20601.4 20631.2 17569.4 17680.0 17969.2 18133.0 18839.2 20428.5 20514.0 20670.8 20770.2 20894.4 15686.1 15690.1 15849.4 15866.8 15884.7 20236.0 20361.5 20377.2 20471.7 20545.0 15:07:59 INFO - PID 3834 | 15:07:59 INFO - PID 3834 | [#3] mootools.html Cycles:180 Average:10383.98 Median:13620.98 stddev:7598.26 (55.8%) stddev-sans-first:7589.90 15:07:59 INFO - PID 3834 | Values: 1445.7 1489.1 1496.0 1507.1 1520.3 16511.3 17301.8 17303.7 17322.6 17330.7 16868.8 16968.0 16993.4 17011.7 17017.8 2759.8 2773.7 2794.5 2811.9 2821.4 2683.0 2772.1 2772.3 2775.5 2779.8 2730.7 2765.7 2773.2 2774.1 2780.5 2439.6 2469.5 2479.8 2483.7 2488.2 2021.0 2047.0 2054.1 2055.2 2065.8 16025.5 16275.0 16335.0 16367.8 16368.3 8329.3 8458.2 8571.7 8575.0 8577.8 5359.9 5608.1 5608.2 5638.5 5863.1 2121.2 2159.9 2179.6 2184.1 2242.8 27038.5 27884.0 27923.3 29168.9 29827.7 7513.7 7581.1 7604.3 7743.6 7746.9 22326.8 22339.6 22346.2 22354.2 22543.3 8767.5 8784.3 8787.9 8788.3 8789.0 7476.7 7633.6 7725.6 7730.0 7739.5 5706.3 5903.7 5997.0 6010.6 6112.9 1763.9 1768.7 1789.5 1811.1 1814.1 961.1 964.7 973.5 992.6 996.4 8970.4 9258.7 9281.7 9334.0 9411.5 786.5 802.5 810.5 815.9 817.5 4937.0 4973.6 4990.5 5007.8 5068.1 23672.6 24297.1 24433.3 24491.8 24814.4 23813.5 24409.5 24495.5 24702.0 24762.1 12260.8 12526.8 12631.7 12632.1 12637.5 9396.9 9598.2 9602.5 9612.0 9640.7 19801.5 20398.7 20527.3 20759.3 20912.4 21119.6 21359.9 21384.9 21484.2 21837.2 12966.4 13004.9 13181.9 13194.0 13263.5 15300.6 15538.8 15557.3 15577.5 15583.0 12616.9 12632.6 12721.2 12877.4 12883.1 12187.6 12314.9 12419.1 12490.2 12544.9 10700.0 10841.9 10960.1 10968.5 11004.2 8170.7 8180.3 8381.7 8404.2 8442.8 8350.1 8354.5 8417.2 8467.2 8495.5 15:07:59 INFO - PID 3834 | 15:07:59 INFO - PID 3834 | [#4] prototype.html Cycles:180 Average:5615.93 Median:6174.57 stddev:1563.26 (25.3%) stddev-sans-first:1520.61 15:07:59 INFO - PID 3834 | Values: 545.2 562.4 568.2 573.8 578.4 6163.4 6234.3 6271.3 6278.3 6312.6 6119.2 6126.0 6136.8 6159.0 6172.3 5031.0 5049.9 5150.5 5159.6 5196.2 4884.4 5093.7 5101.4 5129.3 5134.0 4957.6 4987.3 4991.4 4995.1 4995.4 4955.9 4957.9 4970.3 4972.9 5016.2 4401.2 4508.6 4539.5 4541.3 4558.7 6151.5 6176.9 6188.3 6204.4 6208.0 5815.8 5845.4 5874.0 5880.1 5895.4 6624.7 6640.1 6655.3 6658.0 6682.2 5062.4 5090.3 5090.6 5093.1 5102.7 6729.2 6845.0 6917.0 6971.8 6997.7 5152.7 5159.6 5225.1 5247.1 5254.3 5219.2 5276.6 5277.5 5312.4 5338.6 5813.6 5851.6 5855.8 5870.1 5887.9 6589.4 6684.0 6696.1 6721.6 6730.2 1784.7 1786.6 1809.1 1819.3 1825.1 1245.5 1269.9 1290.5 1292.8 1293.6 6123.0 6131.4 6153.1 6159.5 6202.5 6557.6 6604.6 6640.2 6685.4 6742.6 5958.3 6038.2 6079.6 6113.2 6115.4 3473.2 3480.6 3495.1 3502.4 3538.0 6837.3 6851.3 6913.9 6987.3 6999.0 6810.2 6831.8 6892.4 6901.6 6947.4 6963.3 7017.5 7051.6 7068.0 7129.6 6600.8 6693.1 6705.2 6708.3 6757.7 6603.9 6626.6 6637.9 6641.2 6654.7 6835.9 6890.9 6920.6 6948.3 6990.4 5144.2 5157.7 5168.2 5184.6 5196.8 6511.5 6547.4 6655.9 6688.9 6740.9 6274.8 6434.6 6499.5 6521.0 6528.5 6424.5 6514.1 6538.2 6555.2 6578.0 6443.7 6476.8 6512.3 6526.9 6532.4 6547.3 6624.7 6659.5 6660.0 6667.7 6244.5 6411.8 6471.2 6473.4 6478.7 15:07:59 INFO - PID 3834 | 15:07:59 INFO - PID 3834 | [#5] yui.html Cycles:180 Average:29479.10 Median:18804.08 stddev:42736.26 (227.3%) stddev-sans-first:42802.66 15:07:59 INFO - PID 3834 | Values: 1003.4 1009.9 1024.8 1031.1 1041.3 21163.8 21504.9 21550.7 21551.2 21614.2 18789.5 19117.9 19127.7 19142.9 19265.1 1044.1 1069.7 1070.6 1073.6 1074.3 1077.1 1085.5 1087.7 1089.0 1090.1 1095.9 1135.6 1137.2 1140.3 1140.9 1122.2 1124.0 1130.6 1132.3 1134.0 784.6 815.0 818.3 821.0 822.7 21158.9 21312.7 21316.5 21382.6 21492.5 22978.5 23540.6 23685.6 23927.4 23949.4 18360.6 18818.6 19002.3 19048.8 19058.1 4010.5 4022.7 4034.3 4034.3 4042.2 135003.0 159537.0 159587.2 161332.0 162418.0 18323.2 18356.6 18604.3 18687.4 18787.4 35066.5 35121.8 35196.6 35357.0 35811.5 10150.7 10158.3 10184.7 10196.6 10205.4 4535.1 4595.9 4626.1 4657.1 4677.3 6235.6 6341.8 6341.8 6355.5 6363.2 1207.8 1215.6 1237.9 1248.1 1252.0 737.1 748.8 754.0 755.3 771.9 13153.5 13245.9 13598.5 14101.2 14273.4 726.2 731.1 734.3 741.9 751.8 6355.4 6361.8 6367.9 6377.0 6446.1 145896.0 146771.0 149583.0 152615.0 154629.2 122152.4 124798.4 131088.0 131750.0 136613.0 115172.4 115545.4 117589.4 117973.4 118817.0 13573.1 14034.5 14176.4 14357.7 14400.6 55718.6 55971.0 56200.7 56694.1 57411.7 92924.5 95165.0 95316.5 98577.5 103198.5 19440.9 20392.0 20424.5 20432.1 20467.6 20271.8 20393.8 20469.0 20562.3 21021.2 20007.7 20245.6 20799.1 21135.5 21250.7 18275.4 18415.4 18507.6 19238.5 20193.8 18192.8 18308.9 18329.4 18418.4 18551.9 15090.2 15220.2 15301.0 15514.5 15576.8 14955.4 15273.6 15557.7 15594.4 15752.6 15:07:59 INFO - PID 3834 | -------- Summary: end -------- 15:07:59 INFO - PID 3834 | 15:08:00 INFO - TEST-INFO | 3834: exit 0 15:08:00 INFO - TEST-OK | dromaeo_css | took 1112247ms 15:08:00 INFO - TEST-START | kraken 15:08:00 INFO - Initialising browser for kraken test... 15:08:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40958/getInfo.html -profile /tmp/tmpMcj1b5/profile 15:08:00 INFO - TEST-INFO | started process 4207 (/builds/slave/test/build/application/firefox/firefox http://localhost:40958/getInfo.html) 15:08:06 INFO - TEST-INFO | 4207: exit 0 15:08:06 INFO - Browser initialized. 15:08:06 INFO - Running cycle 1/1 for kraken test... 15:08:06 INFO - Using env: {'DISPLAY': ':0', 15:08:06 INFO - 'HOME': '/home/cltbld', 15:08:06 INFO - 'JSGC_DISABLE_POISONING': '1', 15:08:06 INFO - 'LANG': 'en_US.UTF-8', 15:08:06 INFO - 'LANGUAGE': 'en_US:en', 15:08:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:08:06 INFO - 'LOGNAME': 'cltbld', 15:08:06 INFO - 'MAIL': '/var/mail/cltbld', 15:08:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:08:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:08:06 INFO - 'MOZ_CRASHREPORTER': '1', 15:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:08:06 INFO - 'MOZ_NO_REMOTE': '1', 15:08:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:06 INFO - 'NO_EM_RESTART': '1', 15:08:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:06 INFO - 'PWD': '/builds/slave/test', 15:08:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:08:06 INFO - 'RUST_BACKTRACE': 'full', 15:08:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:08:06 INFO - 'SHELL': '/bin/bash', 15:08:06 INFO - 'SHLVL': '1', 15:08:06 INFO - 'STYLO_FORCE_DISABLED': '1', 15:08:06 INFO - 'TERM': 'linux', 15:08:06 INFO - 'TMOUT': '86400', 15:08:06 INFO - 'USER': 'cltbld', 15:08:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118', 15:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:06 INFO - '_': '/tools/buildbot/bin/python'} 15:08:06 INFO - TEST-INFO | started process 4444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMcj1b5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:08:06 INFO - PID 4444 | 15:08:06 INFO - PID 4444 | (/builds/slave/test/build/application/firefox/firefox:4495): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:08:06 INFO - PID 4444 | 15:08:17 INFO - PID 4444 | RSS: Main: 144699392 15:08:17 INFO - PID 4444 | 15:08:19 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40958/tests/kraken/driver.html?testName=audio-beat-detection) 15:08:20 INFO - PID 4444 | RSS: Main: 151949312 15:08:20 INFO - PID 4444 | 15:08:23 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40958/tests/kraken/driver.html?testName=audio-dft) 15:08:23 INFO - PID 4444 | RSS: Main: 151904256 15:08:23 INFO - PID 4444 | 15:08:26 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40958/tests/kraken/driver.html?testName=audio-fft) 15:08:27 INFO - PID 4444 | RSS: Main: 147464192 15:08:27 INFO - PID 4444 | 15:08:29 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40958/tests/kraken/driver.html?testName=audio-oscillator) 15:08:30 INFO - PID 4444 | RSS: Main: 148561920 15:08:30 INFO - PID 4444 | 15:08:32 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40958/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:08:32 INFO - PID 4444 | RSS: Main: 148258816 15:08:32 INFO - PID 4444 | 15:08:35 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40958/tests/kraken/driver.html?testName=imaging-darkroom) 15:08:36 INFO - PID 4444 | RSS: Main: 148561920 15:08:36 INFO - PID 4444 | 15:08:40 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40958/tests/kraken/driver.html?testName=imaging-desaturate) 15:08:40 INFO - PID 4444 | RSS: Main: 148840448 15:08:40 INFO - PID 4444 | 15:08:43 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40958/tests/kraken/driver.html?testName=json-parse-financial) 15:08:44 INFO - PID 4444 | RSS: Main: 151379968 15:08:44 INFO - PID 4444 | 15:08:45 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40958/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:08:46 INFO - PID 4444 | RSS: Main: 151539712 15:08:46 INFO - PID 4444 | 15:08:47 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:08:48 INFO - PID 4444 | RSS: Main: 151437312 15:08:48 INFO - PID 4444 | 15:08:50 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:08:51 INFO - PID 4444 | RSS: Main: 148131840 15:08:51 INFO - PID 4444 | 15:08:53 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:08:54 INFO - PID 4444 | RSS: Main: 148197376 15:08:54 INFO - PID 4444 | 15:08:56 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:08:57 INFO - PID 4444 | RSS: Main: 148934656 15:08:57 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40958/tests/kraken/driver.html?testName=ai-astar) 15:08:59 INFO - PID 4444 | RSS: Main: 150384640 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | __start_tp_report 15:08:59 INFO - PID 4444 | _x_x_mozilla_page_load 15:08:59 INFO - PID 4444 | _x_x_mozilla_page_load_details 15:08:59 INFO - PID 4444 | |i|pagename|runs| 15:08:59 INFO - PID 4444 | |0;ai-astar;105;105;105;105;106;105;108;107;106;106 15:08:59 INFO - PID 4444 | |1;audio-beat-detection;127;129;118;112;114;114;112;111;116;120 15:08:59 INFO - PID 4444 | |2;audio-dft;164;163;161;162;161;161;161;163;165;167 15:08:59 INFO - PID 4444 | |3;audio-fft;73;74;73;74;73;74;84;73;73;73 15:08:59 INFO - PID 4444 | |4;audio-oscillator;79;79;78;77;78;81;78;78;78;78 15:08:59 INFO - PID 4444 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;118;114;114 15:08:59 INFO - PID 4444 | |6;imaging-darkroom;149;151;150;151;150;151;151;151;150;150 15:08:59 INFO - PID 4444 | |7;imaging-desaturate;95;94;94;94;94;94;94;93;95;94 15:08:59 INFO - PID 4444 | |8;json-parse-financial;44;44;45;44;45;45;45;44;45;47 15:08:59 INFO - PID 4444 | |9;json-stringify-tinderbox;40;40;41;40;40;40;40;40;40;40 15:08:59 INFO - PID 4444 | |10;stanford-crypto-aes;70;73;73;70;71;77;71;74;71;71 15:08:59 INFO - PID 4444 | |11;stanford-crypto-ccm;102;102;106;113;106;105;105;107;105;114 15:08:59 INFO - PID 4444 | |12;stanford-crypto-pbkdf2;156;150;147;149;153;155;149;151;159;150 15:08:59 INFO - PID 4444 | |13;stanford-crypto-sha256-iterative;61;58;62;57;68;60;60;60;59;64 15:08:59 INFO - PID 4444 | __end_tp_report 15:08:59 INFO - PID 4444 | __start_cc_report 15:08:59 INFO - PID 4444 | _x_x_mozilla_cycle_collect,705 15:08:59 INFO - PID 4444 | __end_cc_report 15:08:59 INFO - PID 4444 | __startTimestamp1506463739448__endTimestamp 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | ------- Summary: start ------- 15:08:59 INFO - PID 4444 | Number of tests: 14 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#0] ai-astar Cycles:10 Average:105.80 Median:106.00 stddev:1.03 (1.0%) stddev-sans-first:1.05 15:08:59 INFO - PID 4444 | Values: 105.0 105.0 105.0 105.0 106.0 105.0 108.0 107.0 106.0 106.0 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#1] audio-beat-detection Cycles:10 Average:117.30 Median:117.00 stddev:6.31 (5.4%) stddev-sans-first:5.63 15:08:59 INFO - PID 4444 | Values: 127.0 129.0 118.0 112.0 114.0 114.0 112.0 111.0 116.0 120.0 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:2.04 (1.3%) stddev-sans-first:2.12 15:08:59 INFO - PID 4444 | Values: 164.0 163.0 161.0 162.0 161.0 161.0 161.0 163.0 165.0 167.0 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#3] audio-fft Cycles:10 Average:74.40 Median:73.50 stddev:3.41 (4.6%) stddev-sans-first:3.57 15:08:59 INFO - PID 4444 | Values: 73.0 74.0 73.0 74.0 73.0 74.0 84.0 73.0 73.0 73.0 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:78.00 stddev:1.07 (1.4%) stddev-sans-first:1.12 15:08:59 INFO - PID 4444 | Values: 79.0 79.0 78.0 77.0 78.0 81.0 78.0 78.0 78.0 78.0 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.26 (1.1%) stddev-sans-first:1.33 15:08:59 INFO - PID 4444 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 118.0 114.0 114.0 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 15:08:59 INFO - PID 4444 | Values: 149.0 151.0 150.0 151.0 150.0 151.0 151.0 151.0 150.0 150.0 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 15:08:59 INFO - PID 4444 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 95.0 94.0 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#8] json-parse-financial Cycles:10 Average:44.80 Median:45.00 stddev:0.92 (2.0%) stddev-sans-first:0.93 15:08:59 INFO - PID 4444 | Values: 44.0 44.0 45.0 44.0 45.0 45.0 45.0 44.0 45.0 47.0 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#9] json-stringify-tinderbox Cycles:10 Average:40.10 Median:40.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 15:08:59 INFO - PID 4444 | Values: 40.0 40.0 41.0 40.0 40.0 40.0 40.0 40.0 40.0 40.0 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#10] stanford-crypto-aes Cycles:10 Average:72.10 Median:72.00 stddev:2.18 (3.0%) stddev-sans-first:2.18 15:08:59 INFO - PID 4444 | Values: 70.0 73.0 73.0 70.0 71.0 77.0 71.0 74.0 71.0 71.0 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#11] stanford-crypto-ccm Cycles:10 Average:106.50 Median:106.00 stddev:4.03 (3.8%) stddev-sans-first:3.94 15:08:59 INFO - PID 4444 | Values: 102.0 102.0 106.0 113.0 106.0 105.0 105.0 107.0 105.0 114.0 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:152.00 stddev:3.75 (2.5%) stddev-sans-first:3.68 15:08:59 INFO - PID 4444 | Values: 156.0 150.0 147.0 149.0 153.0 155.0 149.0 151.0 159.0 150.0 15:08:59 INFO - PID 4444 | 15:08:59 INFO - PID 4444 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:60.50 stddev:3.18 (5.3%) stddev-sans-first:3.37 15:08:59 INFO - PID 4444 | Values: 61.0 58.0 62.0 57.0 68.0 60.0 60.0 60.0 59.0 64.0 15:08:59 INFO - PID 4444 | -------- Summary: end -------- 15:08:59 INFO - PID 4444 | 15:09:01 INFO - PID 4444 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:09:01 INFO - TEST-INFO | 4444: exit 0 15:09:02 INFO - TEST-OK | kraken | took 61662ms 15:09:02 INFO - SUITE-END | took 1173s 15:09:02 INFO - Completed test suite (00:19:34) 15:09:02 INFO - javascript benchmark 15:09:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9127.438287077885, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3891.3773796192604, 3893.4354518594805, 3906.1406490572062, 3911.550171730252, 3939.9015024624364, 6147.723352449139, 6175.289841668209, 6323.36766323368, 6336.239651241852, 6430.485561155108, 6180.6291622502795, 6240.750369985207, 6269.655168965705, 6413.326600706929, 6420.1653785008, 5703.800366987156, 5708.571857110713, 5727.055035919089, 5759.366469688331, 5804.796832110877, 1002.3500458914544, 5667.121596152582, 5676.602637815355, 5697.914531282014, 5724.427557244263, 5670.376258611549, 5675.716214189295, 5724.656520608756, 5741.770329186827, 5765.654060756368, 5648.519875810561, 5670.092785154356, 5749.137629355589, 5757.568182386338, 5761.510271626917, 5650.943490565124, 5716.456936591017, 5724.141378793172, 5728.198052272685, 5739.82780516581, 6208.534359923024, 6300.275468321156, 6323.462505687022, 6351.745930162788, 6399.8080057598345, 6748.426383757386, 6812.45500359975, 6816.625085620289, 6825.931740682579, 6828.931710682879, 6881.208661003999, 6974.546654467444, 6989.5456795308655, 7013.92986070143, 7032.191298000745, 6340.809775706736, 6364.809055728336, 6369.777057803001, 6448.903266451007, 6523.249826269945, 7054.823629409203, 7122.216556178816, 7157.713691452388, 7162.2121566628675, 7170.713171473187, 6646.86706265872, 6762.898556521656, 6800.591964482147, 6873.621950792654, 6874.8625027500175, 6760.93239067603, 6869.931300687029, 6916.827079322957, 6953.235144134142, 6955.782738020927, 6899.55152915069, 6919.688614012382, 6924.169099708067, 6928.030075789394, 6937.549059311129, 6777.695003724844, 6810.012548180585, 6875.656217189221, 6939.23668396476, 6961.547499412522, 4834.564889159992, 4910.337104490919, 4936.185529387611, 5024.49755024502, 5030.522100400456, 4488.865334039984, 4509.954900451019, 4530.569595888385, 4563.9087218255445, 4579.038401935564, 6332.778352757631, 6340.873182536416, 6375.171227740457, 6436.195475565554, 6438.098666186737, 6783.253842077367, 6798.76204332846, 6877.9656101720175, 6879.484038697117, 6972.023916651673, 6254.906176407358, 6278.6860656966965, 6357.237131544151, 6416.935830641633, 6431.453326467303, 5536.141898005815, 5538.280023596906, 5609.439056094439, 5613.045782217033, 5635.943640563624, 6961.721531138698, 6961.860762784716, 7181.820454488575, 7286.854262914712, 7293.27067293277, 6691.832704182434, 6753.898691519533, 6833.111695479556, 6846.897296540656, 6873.518853680194, 7059.541129826544, 7063.434925205868, 7178.138623365229, 7206.4595155364605, 7240.927590724236, 6754.324567543206, 6763.6618169092335, 6834.726610935706, 6838.794836154923, 6850.931490685229, 6790.5925644461495, 6805.183377994672, 6924.896126558005, 6946.270641582561, 6964.616946068015, 6630.801075967729, 6694.665266736546, 6721.462283017249, 6735.023421603938, 6737.3599508046655, 6536.575122617015, 6624.668766561749, 6635.4359879410795, 6720.731170753311, 6741.696623652046, 6417.1657684500715, 6501.9674901625185, 6525.9021114684265, 6530.151080359523, 6532.248791388861, 6536.509761767791, 6559.311272316338, 6617.205935287604, 6621.801345959629, 6660.6336651484635, 6396.648184349905, 6556.2788093308745, 6562.048502966947, 6570.901436478553, 6607.438367738604], "value": 6236.342846012019, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [963.4267610771589, 990.6037584966014, 1017.5014243020922, 1019.8164330420526, 1019.9898001019992, 41547.0, 42588.0, 42835.35746963798, 42836.571634283726, 42874.78562607186, 39861.20277594446, 44086.55913440865, 44731.105377892425, 44818.32772508415, 44941.55058449414, 8264.380171487133, 8292.668293268262, 8354.081051084377, 8377.748667539983, 8378.0, 8282.710105146321, 8401.453905496153, 8411.200935911109, 8413.242808147266, 8417.158284171564, 8448.493090414595, 8452.704155354564, 8455.196756308142, 8460.323174146084, 8482.78793030173, 8397.454165479256, 8443.282321002722, 8446.197611226955, 8458.957705211435, 8472.534010629413, 8225.177482251787, 8229.177082291782, 8230.465019773696, 8246.587670616445, 8255.587220639005, 39234.803825980685, 39361.80319098386, 39541.60458395408, 39618.60381396178, 39655.20689586192, 3708.2027364116843, 3726.2920045191327, 3743.925121497582, 3747.662710356081, 3752.5496940367057, 31880.681193188004, 31990.0, 32429.0, 32435.02694919156, 32548.67451325504, 5162.328897243335, 5355.678659280456, 5371.81198658049, 5429.837104886859, 5434.239206511092, 226228.0, 227442.0, 229171.0, 231046.0, 239720.0, 52524.73737631287, 53055.734721326146, 53180.468195318324, 53193.2021019685, 53279.0, 55276.72361638166, 55325.0, 55344.6163845899, 55606.0, 55695.44304556984, 15718.607034823992, 15767.842321576867, 15777.447789327549, 15859.52421427359, 15993.680126397407, 12800.0, 12855.871441285468, 12878.356082195853, 12903.806442903364, 12939.805902911465, 13432.731345373038, 13567.796483052762, 13626.795598066037, 13752.518661846787, 13783.310834458238, 5238.68567885928, 5326.893462130735, 5328.387235467893, 5333.893322133536, 5349.518543331119, 1066.258950029722, 1093.2565855218527, 1099.9890001100046, 1102.3055475050828, 1126.0653657464286, 24987.500249994897, 25011.249662510152, 25042.123525676514, 25049.4990100197, 25110.37224069413, 1180.2033627301537, 1193.5882120668355, 1209.1173443386376, 1213.2720367779261, 1225.4118023348842, 13140.211587304791, 13272.137311074943, 13273.0, 13364.866351336557, 13404.19574825494, 271268.0, 272918.0, 274499.0, 275107.0, 275208.0, 56333.0, 56359.71820140955, 56498.152527711296, 56569.0, 56577.0, 1497.430976229026, 1508.1588102192086, 1526.1072272720362, 1527.9388824446899, 1529.3941361570307, 24312.0, 24452.26643200707, 24645.876770616032, 24694.50177803241, 24793.0, 38871.6112838868, 38875.02812429712, 38891.22217555576, 38930.0267493315, 38946.22107557776, 231184.0, 232392.0, 232453.0, 232628.0, 233001.0, 34644.0, 35769.46345804763, 36089.81955090208, 36126.0, 36152.819235903655, 44185.0, 46236.0, 46253.30620040769, 46604.30093548667, 46957.0, 34211.657883421845, 34289.314213715086, 34295.828520857234, 34797.82601086979, 34851.16107335681, 33781.790729880624, 34305.0, 34380.14049648679, 34446.311073777884, 35197.47203791894, 40221.79889100536, 40446.59553404428, 40623.796881015405, 40671.0, 40727.79636101919, 33265.83367083149, 33396.66603334033, 33793.13784161161, 34129.0, 34320.65679343174, 25240.368990775376, 25389.238322850342, 25668.0, 25759.0, 25783.613245801702], "value": 18346.661351814902, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.3746253746253, 625.4027403829343, 627.5669787846388, 633.7560039384836, 640.7020735358059, 23516.88241558792, 23882.40293992651, 24204.636930446035, 24220.75779242207, 25103.0, 26075.86962065187, 27088.59367109495, 27249.0, 27318.31704207396, 27401.177964661092, 6532.5100617453645, 6726.865462690744, 6741.865162696743, 6749.662516874161, 6759.1213142291435, 6471.0, 6644.734210631569, 6738.460923126138, 6745.156855393076, 6749.392554670078, 6689.531732778707, 6699.4305484033675, 6699.497537684669, 6701.262861085301, 6709.664516774166, 6520.543561950689, 6690.933090669079, 6699.129113215299, 6742.460603151736, 6773.491988100863, 6317.0, 6318.905216421757, 6323.30443651198, 6325.399087086719, 6330.778422755181, 31301.843490782627, 31675.84162079198, 31700.0, 31758.364832703217, 31799.682003180136, 2249.0329158461855, 2275.2377953385635, 2278.5670722562827, 2279.908803647852, 2281.041962375806, 19886.602267954706, 21420.0, 21537.353879383645, 21560.56878862414, 21609.567808643897, 2494.114589320783, 2535.0620270500035, 2576.7036790768925, 2582.9612555811677, 2584.5218634552666, 133409.0, 140203.29898350546, 150610.0, 158108.0, 158873.20563397225, 15984.842046323598, 16072.919635401748, 16249.187540622921, 16861.241244144043, 17093.743593846102, 26511.33721656974, 26566.0, 26641.600375994374, 26682.733172668413, 26751.197464076107, 9600.519974001412, 9805.411675299505, 9862.112409883144, 10017.449040302708, 10111.544980475895, 8665.523396213268, 8735.475871447734, 8738.0, 8818.470891746516, 8851.822963540822, 9932.0, 9961.40231586107, 10034.147097496649, 10264.178865690727, 10315.17478601725, 2889.5376739721964, 2924.6782853886057, 2926.6634337051087, 2930.615139513865, 2960.703929607022, 1061.6761887624348, 1062.219268837404, 1072.828347464402, 1074.425182527344, 1075.4300220882944, 21898.23356182526, 22050.88974555149, 22245.0, 22331.218407355664, 22390.888045559666, 1122.4668282565879, 1125.4485302202027, 1139.5612689114585, 1140.8745038045809, 1144.3934714601107, 11790.94104529472, 12095.334756588472, 12125.818112728317, 12127.151099422956, 12252.326122063194, 602283.0, 607211.0, 610764.0, 623080.0, 660068.0, 129139.77150571311, 132336.02991910258, 132948.0, 133342.0, 134966.0, 1125.189863298424, 1178.699431644925, 1228.2016689152122, 1236.7402845402387, 1297.156848048757, 22551.774482255623, 23163.0, 23249.53500929938, 23296.6505502421, 23334.416639584146, 62909.68545157245, 63347.6832615834, 63756.36243637504, 64001.67999159975, 65388.67305663441, 82294.0, 82389.0, 82607.0, 82867.5856620713, 83444.0, 15923.52229433119, 16144.67710645757, 16241.59396015109, 16244.350225990827, 16317.510474685778, 25097.87451062733, 25248.62127068132, 25334.239972800846, 25574.0, 25608.10371636984, 19601.803981959998, 20105.698414524086, 20527.4868128298, 20601.381958541268, 20631.174753010313, 17569.385071522946, 17680.0, 17969.19138638738, 18133.0, 18839.24643014319, 20428.48928776733, 20514.0, 20670.793292066886, 20770.1691932321, 20894.37316880496, 15686.137262450675, 15690.137042462318, 15849.366025359317, 15866.7619985698, 15884.68230635404, 20236.0, 20361.49096272605, 20377.184912603923, 20471.692924605846, 20545.0], "value": 13022.253453975556, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.7253121906838, 1489.0544504239804, 1496.0, 1507.1409296700879, 1520.2702702702702, 16511.33954641813, 17301.82698173018, 17303.653926921455, 17322.56693582661, 17330.74003889943, 16868.83131168691, 16968.0, 16993.405230816923, 17011.744823827652, 17017.82982170178, 2759.751622353988, 2773.653293338333, 2794.455081259155, 2811.8734656940383, 2821.4357128574266, 2682.986585067072, 2772.1267800642836, 2772.348498102944, 2775.4726601945567, 2779.805413621047, 2730.7269273072734, 2765.7234276572385, 2773.195773225762, 2774.140016594852, 2780.541210700242, 2439.5730747119273, 2469.4814089041324, 2479.826412151141, 2483.67712197415, 2488.1664642344836, 2021.0400059971544, 2046.98976505118, 2054.116729806183, 2055.198472595689, 2065.814076733101, 16025.519234422985, 16275.0, 16335.0, 16367.83632163675, 16368.345266189339, 8329.250367466897, 8458.196471335214, 8571.657133714643, 8574.957125214334, 8577.785555361104, 5359.919601205985, 5608.074667679828, 5608.186812912105, 5638.548916086703, 5863.149843272744, 2121.193946300396, 2159.9136034558755, 2179.574982878339, 2184.071769497973, 2242.7981481666566, 27038.45923081547, 27884.0, 27923.301917452023, 29168.8541557293, 29827.70172298271, 7513.661885215179, 7581.052368453943, 7604.315611594983, 7743.612819359122, 7746.883796743054, 22326.776732232796, 22339.55320893573, 22346.21788237404, 22354.217602384164, 22543.323700289016, 8767.517786521803, 8784.341174411944, 8787.912120878837, 8788.296936245086, 8788.956055219684, 7476.663550140257, 7633.618319084135, 7725.575093369918, 7729.961350193213, 7739.535627862234, 5706.343770466367, 5903.675297858573, 5996.970015149896, 6010.647604289, 6112.938870611326, 1763.8941663500232, 1768.7081631530912, 1789.4899953513186, 1811.148760082759, 1814.0657561355913, 961.1397798969883, 964.6912987843963, 973.536951512674, 992.6277645882794, 996.3573495095623, 8970.372073954892, 9258.72223833286, 9281.72154835356, 9333.953330233306, 9411.482368469662, 786.4612740272931, 802.5144787403653, 810.4569938141459, 815.8613035783931, 817.4768148385039, 4936.950630493649, 4973.626977976666, 4990.50094990498, 5007.824726134568, 5068.138416469209, 23672.64491032636, 24297.149599763925, 24433.267001989967, 24491.755082449305, 24814.37964050877, 23813.523729525314, 24409.51180976406, 24495.510089798103, 24702.0, 24762.133325333525, 12260.81608775869, 12526.81209781854, 12631.747365052648, 12632.05259605515, 12637.494500219887, 9396.906030939603, 9598.184154346958, 9602.519874006412, 9611.951940240533, 9640.662576809778, 19801.50496237548, 20398.694019590013, 20527.28154514585, 20759.273425430038, 20912.37262882116, 21119.577608448053, 21359.893200533897, 21384.893075534525, 21484.24805131813, 21837.235696750537, 12966.35168241603, 13004.934975325063, 13181.868181318448, 13194.0, 13263.535776247785, 15300.61748456253, 15538.844611553739, 15557.299921503785, 15577.454789082327, 15583.0, 12616.936915315364, 12632.621021369374, 12721.236725796482, 12877.35613219354, 12883.098183127091, 12187.634370968884, 12314.876851231373, 12419.130660853654, 12490.188137771016, 12544.937275313565, 10700.0, 10841.945790270998, 10960.123190144928, 10968.451577420938, 11004.174686898354, 8170.714025009096, 8180.304674102768, 8381.664733410595, 8404.20160084791, 8442.831143376976, 8350.123237060265, 8354.45696029756, 8417.158284171534, 8467.15328467173, 8495.490270583785], "value": 7210.990268867147, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.1985581195644, 562.3729541561158, 568.2385603291591, 573.7561536347052, 578.4446930946291, 6163.352847950968, 6234.251889773228, 6271.2788029376525, 6278.340774218704, 6312.6212427254395, 6119.204503414549, 6125.969370153154, 6136.754529818813, 6158.969205153968, 6172.259328880529, 5031.0441016206805, 5049.873753156164, 5150.510701483353, 5159.613029022819, 5196.194589838581, 4884.438289596706, 5093.714554112596, 5101.387833459971, 5129.307543481638, 5133.974330128344, 4957.553820156185, 4987.301777751118, 4991.351124353847, 4995.100881841267, 4995.350604421438, 4955.851324460272, 4957.900841983158, 4970.254461830718, 4972.925406118911, 5016.197408414636, 4401.163778882034, 4508.61676757476, 4539.455265368144, 4541.296099104644, 4558.680892337537, 6151.477124444427, 6176.87646247077, 6188.319284878659, 6204.441600255998, 6207.968960155215, 5815.767369305223, 5845.357010728816, 5873.97205489042, 5880.147378630075, 5895.380984996599, 6624.668766561653, 6640.1035860158745, 6655.334466553354, 6657.966710166466, 6682.195807132047, 5062.443131255559, 5090.261912022773, 5090.567301779353, 5093.108705976476, 5102.668326558799, 6729.158855143107, 6844.965775171142, 6916.962455631645, 6971.79084627462, 6997.650117494156, 5152.690838549699, 5159.58723302135, 5225.1378522543355, 5247.081760691864, 5254.3169387979315, 5219.217117432416, 5276.630635855453, 5277.498637629419, 5312.362516498045, 5338.626296159309, 5813.6221145625395, 5851.64890106595, 5855.765769369263, 5870.119482077723, 5887.852803679943, 6589.374009469093, 6683.966580167068, 6696.129503164558, 6721.630310332881, 6730.226024007204, 1784.723367877981, 1786.580153663888, 1809.1225755508567, 1819.281383853397, 1825.1239405085632, 1245.483124503339, 1269.8984081273477, 1290.4773566705499, 1292.793153095519, 1293.5860524632028, 6122.969385153135, 6131.356207598138, 6153.123532174702, 6159.5072394208355, 6202.534809889276, 6557.639329836905, 6604.603723776589, 6640.236372817188, 6685.364890335411, 6742.595444273359, 5958.272101090722, 6038.215032045894, 6079.574429789872, 6113.23584551931, 6115.449609535074, 3473.166440054419, 3480.617132115465, 3495.147571786957, 3502.422100353464, 3538.0, 6837.316268373223, 6851.314868513208, 6913.930860691429, 6987.26633703464, 6999.040268724765, 6810.216825065082, 6831.760888368884, 6892.379685828299, 6901.551399159039, 6947.40947019509, 6963.338482844122, 7017.543859649107, 7051.6474176292, 7068.0, 7129.60787156701, 6600.765624843696, 6693.096431981815, 6705.228898676714, 6708.26209116987, 6757.729690812509, 6603.9009414859775, 6626.602403855784, 6637.867242655217, 6641.203055633355, 6654.700538475877, 6835.931640683729, 6890.931090689029, 6920.550164239308, 6948.305169483011, 6990.405815505739, 5144.151215049625, 5157.716325602128, 5168.198929165986, 5184.585233181412, 5196.752779333008, 6511.479081673549, 6547.443467305332, 6655.900161497485, 6688.933110669026, 6740.9325906740305, 6274.780382686584, 6434.613923164625, 6499.545031847725, 6520.967395162994, 6528.543001990005, 6424.453921416545, 6514.055461958084, 6538.1827271591055, 6555.2133743951035, 6578.013298005338, 6443.710033048618, 6476.773312934213, 6512.251091124582, 6526.934730652632, 6532.41208291256, 6547.279799222177, 6624.735010599715, 6659.500537459613, 6660.0, 6667.666616669244, 6244.469220116341, 6411.775587854403, 6471.191101112361, 6473.385028422293, 6478.740850365933], "value": 5166.23848095482, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1003.3528374198642, 1009.904059114384, 1024.7643042100317, 1031.0514326819325, 1041.2659075351876, 21163.788362116375, 21504.89247553764, 21550.676739848896, 21551.245706400277, 21614.24350147743, 18789.530261743465, 19117.904410477964, 19127.713084303712, 19142.904285478588, 19265.133069011892, 1044.1281529922524, 1069.668402795136, 1070.5878236878818, 1073.6349641122017, 1074.269496742217, 1077.0790973717476, 1085.5332207150923, 1087.6954452753203, 1088.9891101089006, 1090.1333439915247, 1095.8575385199913, 1135.6195674449027, 1137.1925932587872, 1140.3386036099043, 1140.914431417647, 1122.2144498850837, 1123.960661376856, 1130.587335622496, 1132.2640283815504, 1134.0474001838454, 784.5528049012065, 814.9975530097953, 818.3248819723692, 821.0106821280343, 822.6997146041712, 21158.894205529028, 21312.68030979521, 21316.467088322763, 21382.57234855294, 21492.46268843276, 22978.54042919149, 23540.64689029666, 23685.644715329283, 23927.401814954592, 23949.401264968343, 18360.63278734431, 18818.62362752751, 19002.33491827793, 19048.80951190484, 19058.14238359277, 4010.5387880393837, 4022.658074063708, 4034.3141665916864, 4034.3141665916864, 4042.191561687645, 135003.0, 159537.0, 159587.2020639901, 161332.0, 162418.0, 18323.175457104462, 18356.632867342578, 18604.34884779026, 18687.439376818445, 18787.436376908714, 35066.474002889976, 35121.770738024046, 35196.64803351985, 35357.0, 35811.4628280576, 10150.746231344276, 10158.339707918962, 10184.694459166238, 10196.643117491001, 10205.38767673942, 4535.070310586388, 4595.931061034087, 4626.051659409813, 4657.091867085954, 4677.345171675968, 6235.625862448268, 6341.778037768749, 6341.8097457076365, 6355.459785918156, 6363.236411630634, 1207.7946749052683, 1215.5867005218267, 1237.8576463706788, 1248.1076030638137, 1252.017166524274, 737.1154614462666, 748.7940816275568, 754.0235395163277, 755.2636179724834, 771.8957940677936, 13153.53962611304, 13245.867541324656, 13598.524051658145, 14101.153930763981, 14273.357698903574, 726.2156870579761, 731.0751898847961, 734.3354264390734, 741.9035525381665, 751.8158051277472, 6355.3644635536075, 6361.840953976095, 6367.872642547123, 6377.043443483514, 6446.097546343516, 145896.0, 146771.0, 149583.0, 152615.0, 154629.22685386502, 122152.38923805323, 124798.3760081212, 131088.0, 131750.0, 136613.0, 115172.42413787877, 115545.4222728881, 117589.4120529392, 117973.41013294879, 118817.0, 13573.11774734639, 14034.508792192633, 14176.362063707364, 14357.712845743235, 14400.639984000483, 55718.607034824454, 55971.0, 56200.71899640476, 56694.14958775704, 57411.71294143503, 92924.53537732268, 95165.0, 95316.52341738247, 98577.50711246398, 103198.48400757948, 19440.90279548593, 20392.0, 20424.489387765425, 20432.0805563747, 20467.590648186655, 20271.797282027583, 20393.796062039783, 20469.0, 20562.28032018872, 21021.159153634297, 20007.699884502035, 20245.59508809845, 20799.06404211784, 21135.471613209793, 21250.681239781727, 18275.360362387786, 18415.355462558746, 18507.629847402706, 19238.519037024187, 20193.798062019778, 18192.81807181964, 18308.908455457637, 18329.3584724534, 18418.35535756242, 18551.90724046371, 15090.17004064787, 15220.238988050332, 15301.0, 15514.5345639631, 15576.766348505009, 14955.40178392852, 15273.556231002985, 15557.688846222785, 15594.376224950875, 15752.60618484547], "value": 10416.54632777052, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1373.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 105.0, 106.0, 105.0, 108.0, 107.0, 106.0, 106.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 129.0, 118.0, 112.0, 114.0, 114.0, 112.0, 111.0, 116.0, 120.0], "value": 117.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 161.0, 162.0, 161.0, 161.0, 161.0, 163.0, 165.0, 167.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 74.0, 73.0, 74.0, 84.0, 73.0, 73.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 77.0, 78.0, 81.0, 78.0, 78.0, 78.0, 78.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 118.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 150.0, 151.0, 150.0, 151.0, 151.0, 151.0, 150.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 95.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 45.0, 44.0, 45.0, 45.0, 45.0, 44.0, 45.0, 47.0], "value": 44.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 40.0, 41.0, 40.0, 40.0, 40.0, 40.0, 40.0, 40.0, 40.0], "value": 40.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 73.0, 70.0, 71.0, 77.0, 71.0, 74.0, 71.0, 71.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 102.0, 106.0, 113.0, 106.0, 105.0, 105.0, 107.0, 105.0, 114.0], "value": 106.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 150.0, 147.0, 149.0, 153.0, 155.0, 149.0, 151.0, 159.0, 150.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 62.0, 57.0, 68.0, 60.0, 60.0, 60.0, 59.0, 64.0], "value": 60.9, "unit": "score"}]}]} 15:09:02 INFO - Return code: 0 15:09:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:09:02 INFO - # TBPL SUCCESS # 15:09:02 INFO - Running post-action listener: _package_coverage_data 15:09:02 INFO - Running post-action listener: _resource_record_post_action 15:09:02 INFO - [mozharness: 2017-09-26 22:09:02.223126Z] Finished run-tests step (success) 15:09:02 INFO - Running post-run listener: _resource_record_post_run 15:09:02 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 11681792; Write bytes: 559554560; Read time: 5072; Write time: 735704 15:09:02 INFO - TinderboxPrint: CPU usage
13.1% 15:09:02 INFO - TinderboxPrint: I/O read bytes / time
11,681,792 / 5,072 15:09:02 INFO - TinderboxPrint: I/O write bytes / time
559,554,560 / 735,704 15:09:02 INFO - TinderboxPrint: CPU idle
8,263.3 (86.9%) 15:09:02 INFO - TinderboxPrint: CPU user
1,188.8 (12.5%) 15:09:02 INFO - TinderboxPrint: Swap in / out
0 / 0 15:09:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 74899456; Read time: 280; Write time: 57824 15:09:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:09:02 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 9490432; Write bytes: 442155008; Read time: 4224; Write time: 656468 15:09:02 INFO - Running post-run listener: _upload_blobber_files 15:09:02 INFO - Blob upload gear active. 15:09:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:09:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:09:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:09:03 INFO - (blobuploader) - INFO - Open directory for files ... 15:09:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:09:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:09:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:06 INFO - (blobuploader) - INFO - Done attempting. 15:09:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 15:09:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 15:09:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:08 INFO - (blobuploader) - INFO - Done attempting. 15:09:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:09:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:09:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:09 INFO - (blobuploader) - INFO - Done attempting. 15:09:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 15:09:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 15:09:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:10 INFO - (blobuploader) - INFO - Done attempting. 15:09:10 INFO - (blobuploader) - INFO - Iteration through files over. 15:09:10 INFO - Return code: 0 15:09:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:09:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:09:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3422fbd1630d23a1e118445fa7b958d35a671310517ab9df0d2ab935a1af7221b117e87ae1b0b80aa1da05398b293389684cc0de4c2cca0b351368f2bf021454", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/993e4f76ea0c9ba9f705f31e6c46aaa096963da6a8c320466ccb9c1fa457dc971ecc1a65a23e404101a140794c8115af5134d5119ad93ccc77ffb587d9967237", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f5f3e5e8c94e2ce582d98c019b82a012eaefbe96268d0e11d3495c70afc56fb893311278c0c074f45c1e5cfeaabc5fc1df5dc15d8ec69e9fc7988270c112379", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85116b41f88fbb46bbcabe5a97d468b65905307837cdcb7ed241420a3347d44e65f8b0762c2a41e279ec7af4d657282fafee76550befc00085f52788c644d8d4"} 15:09:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:09:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:09:10 INFO - Contents: 15:09:10 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3422fbd1630d23a1e118445fa7b958d35a671310517ab9df0d2ab935a1af7221b117e87ae1b0b80aa1da05398b293389684cc0de4c2cca0b351368f2bf021454", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/993e4f76ea0c9ba9f705f31e6c46aaa096963da6a8c320466ccb9c1fa457dc971ecc1a65a23e404101a140794c8115af5134d5119ad93ccc77ffb587d9967237", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f5f3e5e8c94e2ce582d98c019b82a012eaefbe96268d0e11d3495c70afc56fb893311278c0c074f45c1e5cfeaabc5fc1df5dc15d8ec69e9fc7988270c112379", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85116b41f88fbb46bbcabe5a97d468b65905307837cdcb7ed241420a3347d44e65f8b0762c2a41e279ec7af4d657282fafee76550befc00085f52788c644d8d4"} 15:09:10 INFO - Running post-run listener: copy_logs_to_upload_dir 15:09:10 INFO - Copying logs to upload dir... 15:09:10 INFO - mkdir: /builds/slave/test/build/upload/logs 15:09:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.621246 ========= master_lag: 0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-26 15:09:10.918200) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 15:09:10.922554) ========= 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=fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118 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/3422fbd1630d23a1e118445fa7b958d35a671310517ab9df0d2ab935a1af7221b117e87ae1b0b80aa1da05398b293389684cc0de4c2cca0b351368f2bf021454", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/993e4f76ea0c9ba9f705f31e6c46aaa096963da6a8c320466ccb9c1fa457dc971ecc1a65a23e404101a140794c8115af5134d5119ad93ccc77ffb587d9967237", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f5f3e5e8c94e2ce582d98c019b82a012eaefbe96268d0e11d3495c70afc56fb893311278c0c074f45c1e5cfeaabc5fc1df5dc15d8ec69e9fc7988270c112379", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85116b41f88fbb46bbcabe5a97d468b65905307837cdcb7ed241420a3347d44e65f8b0762c2a41e279ec7af4d657282fafee76550befc00085f52788c644d8d4"} build_url:https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/IKyg_StSS-2K6YFkukKa-w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3422fbd1630d23a1e118445fa7b958d35a671310517ab9df0d2ab935a1af7221b117e87ae1b0b80aa1da05398b293389684cc0de4c2cca0b351368f2bf021454", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/993e4f76ea0c9ba9f705f31e6c46aaa096963da6a8c320466ccb9c1fa457dc971ecc1a65a23e404101a140794c8115af5134d5119ad93ccc77ffb587d9967237", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f5f3e5e8c94e2ce582d98c019b82a012eaefbe96268d0e11d3495c70afc56fb893311278c0c074f45c1e5cfeaabc5fc1df5dc15d8ec69e9fc7988270c112379", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85116b41f88fbb46bbcabe5a97d468b65905307837cdcb7ed241420a3347d44e65f8b0762c2a41e279ec7af4d657282fafee76550befc00085f52788c644d8d4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 15:09:10.950874) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 15:09:10.951234) ========= 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=fa44defc139c4ba8574fe040000001db-1506461581.723595-451916118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 15:09:11.032760) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 15:09:11.036087) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 15:09:11.036402) ========= ========= Total master_lag: 0.46 =========