builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-011 starttime: 1505410273.8 results: success (0) revision: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 10:31:13.799309) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 10:31:13.800051) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 10:31:13.800328) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 10:31:13.909251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:31:13.909611) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 10:31:14-- 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% 99.1M=0s 2017-09-14 10:31:14 (99.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119160 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:31:14.084574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:31:14.085001) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018538 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:31:14.142723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-14 10:31:14.143063) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b --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 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b --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=5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 10:31:14,626 truncating revision to first 12 chars 2017-09-14 10:31:14,626 Setting DEBUG logging. 2017-09-14 10:31:14,626 attempt 1/10 2017-09-14 10:31:14,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/943c2c2a1daf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 10:31:15,753 unpacking tar archive at: mozilla-central-943c2c2a1daf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.453970 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-14 10:31:15.622603) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 10:31:15.625920) ========= script_repo_revision: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 10:31:15.626272) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 10:31:15.626534) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 10:31:15.647256) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-14 10:31:15.647608) ========= /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=5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:31:16 INFO - MultiFileLogger online at 20170914 10:31:16 in /builds/slave/test 10:31:16 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 10:31:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:31:16 INFO - {'append_to_log': False, 10:31:16 INFO - 'base_work_dir': '/builds/slave/test', 10:31:16 INFO - 'blob_upload_branch': 'Firefox', 10:31:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:31:16 INFO - 'branch': 'Firefox', 10:31:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:31:16 INFO - 'code_coverage': False, 10:31:16 INFO - 'config_files': ('talos/linux_config.py',), 10:31:16 INFO - 'default_actions': ('clobber', 10:31:16 INFO - 'read-buildbot-config', 10:31:16 INFO - 'download-and-extract', 10:31:16 INFO - 'populate-webroot', 10:31:16 INFO - 'create-virtualenv', 10:31:16 INFO - 'install', 10:31:16 INFO - 'setup-mitmproxy', 10:31:16 INFO - 'run-tests'), 10:31:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:31:16 INFO - 'disable_ccov_upload': False, 10:31:16 INFO - 'disable_stylo': False, 10:31:16 INFO - 'download_minidump_stackwalk': True, 10:31:16 INFO - 'download_symbols': 'ondemand', 10:31:16 INFO - 'enable_stylo': False, 10:31:16 INFO - 'enable_webrender': False, 10:31:16 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 10:31:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:31:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:31:16 INFO - 'gecko_profile': False, 10:31:16 INFO - 'gecko_profile_interval': 0, 10:31:16 INFO - 'installer_path': 'installer.exe', 10:31:16 INFO - 'log_level': 'info', 10:31:16 INFO - 'log_name': 'talos', 10:31:16 INFO - 'log_to_console': True, 10:31:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:31:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:31:16 INFO - 'opt_config_files': (), 10:31:16 INFO - 'pip_index': False, 10:31:16 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 10:31:16 INFO - 'system_bits': '32', 10:31:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:31:16 INFO - 'title': 'talos-linux64-ix-011', 10:31:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:31:16 INFO - 'use_talos_json': True, 10:31:16 INFO - 'verify': 'False', 10:31:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:31:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:31:16 INFO - 'work_dir': 'build'} 10:31:16 INFO - [mozharness: 2017-09-14 17:31:16.271280Z] Running clobber step. 10:31:16 INFO - Running pre-action listener: _resource_record_pre_action 10:31:16 INFO - Running main action method: clobber 10:31:16 INFO - rmtree: /builds/slave/test/build 10:31:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:31:17 INFO - Running post-action listener: _resource_record_post_action 10:31:17 INFO - [mozharness: 2017-09-14 17:31:17.779649Z] Finished clobber step (success) 10:31:17 INFO - [mozharness: 2017-09-14 17:31:17.779747Z] Running read-buildbot-config step. 10:31:17 INFO - Running pre-action listener: _resource_record_pre_action 10:31:17 INFO - Running main action method: read_buildbot_config 10:31:17 INFO - Using buildbot properties: 10:31:17 INFO - { 10:31:17 INFO - "project": "", 10:31:17 INFO - "product": "firefox", 10:31:17 INFO - "who": "ryanvm@gmail.com", 10:31:17 INFO - "installer_path": "public/build/target.tar.bz2", 10:31:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 10:31:17 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:31:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 10:31:17 INFO - "stage_platform": "linux64-pgo", 10:31:17 INFO - "basedir": "/builds/slave/test", 10:31:17 INFO - "buildnumber": 14, 10:31:17 INFO - "platform": "ubuntu64_hw", 10:31:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:31:17 INFO - "slavebuilddir": "test", 10:31:17 INFO - "taskId": "Ws22uQadTwS9DVk15OIlcw", 10:31:17 INFO - "branch": "mozilla-central", 10:31:17 INFO - "script_repo_revision": "production", 10:31:17 INFO - "revision": "943c2c2a1daf5cd0d3287c1974eb510615d5ed5b", 10:31:17 INFO - "slavename": "talos-linux64-ix-011", 10:31:17 INFO - "repo_path": "mozilla-central" 10:31:17 INFO - } 10:31:17 INFO - Finding installer, test and symbols from parent task. 10:31:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ws22uQadTwS9DVk15OIlcw'}, attempt #1 10:31:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ws22uQadTwS9DVk15OIlcw'}, attempt #1 10:31:18 INFO - Task dependencies: GExoNZT9Sqq3GjuszWpuhw 10:31:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw'}, attempt #1 10:31:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2 10:31:19 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.test_packages.json 10:31:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.crashreporter-symbols.zip 10:31:19 INFO - Running post-action listener: _resource_record_post_action 10:31:19 INFO - [mozharness: 2017-09-14 17:31:19.275290Z] Finished read-buildbot-config step (success) 10:31:19 INFO - [mozharness: 2017-09-14 17:31:19.275510Z] Running download-and-extract step. 10:31:19 INFO - Running pre-action listener: _resource_record_pre_action 10:31:19 INFO - Running main action method: download_and_extract 10:31:19 INFO - mkdir: /builds/slave/test/build/tests 10:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:19 INFO - trying https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.test_packages.json 10:31:19 INFO - Downloading https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:31:19 INFO - Downloaded 989 bytes. 10:31:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:31:19 INFO - Using the following test package requirements: 10:31:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:31:19 INFO - u'common': [u'target.common.tests.zip'], 10:31:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:31:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:31:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:31:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:31:19 INFO - u'mozbase': [u'target.common.tests.zip'], 10:31:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:31:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:31:19 INFO - u'web-platform': [u'target.common.tests.zip', 10:31:19 INFO - u'target.web-platform.tests.tar.gz'], 10:31:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:31:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 10:31:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.common.tests.zip 10:31:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:31:19 INFO - Fetch https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.common.tests.zip into memory 10:31:20 INFO - Content-Length response header: 55193481 10:31:20 INFO - Bytes received: 55193481 10:31:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.talos.tests.zip 10:31:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:31:31 INFO - Fetch https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.talos.tests.zip into memory 10:31:32 INFO - Content-Length response header: 14500356 10:31:32 INFO - Bytes received: 14500356 10:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:32 INFO - trying https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2 10:31:32 INFO - Downloading https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:31:34 INFO - Downloaded 62178071 bytes. 10:31:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2 10:31:34 INFO - mkdir: /builds/slave/test/properties 10:31:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:31:34 INFO - Writing to file /builds/slave/test/properties/build_url 10:31:34 INFO - Contents: 10:31:34 INFO - build_url:https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2 10:31:34 INFO - Running post-action listener: _resource_record_post_action 10:31:34 INFO - Running post-action listener: find_tests_for_verification 10:31:34 INFO - Running post-action listener: set_extra_try_arguments 10:31:34 INFO - [mozharness: 2017-09-14 17:31:34.231908Z] Finished download-and-extract step (success) 10:31:34 INFO - [mozharness: 2017-09-14 17:31:34.232006Z] Running populate-webroot step. 10:31:34 INFO - Running pre-action listener: _resource_record_pre_action 10:31:34 INFO - Running main action method: populate_webroot 10:31:34 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:31:34 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:34 INFO - 'tests': ['tresize', 10:31:34 INFO - 'tcanvasmark']}, 10:31:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:31:34 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:34 INFO - 'tests': ['dromaeo_css', 10:31:34 INFO - 'kraken']}, 10:31:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:31:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:34 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:31:34 INFO - 'talos_options': ['--disable-stylo'], 10:31:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:31:34 INFO - 'tests': ['damp', 'tps']}, 10:31:34 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:31:34 INFO - 'talos_options': ['--disable-stylo'], 10:31:34 INFO - 'tests': ['damp', 'tps']}, 10:31:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:31:34 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:34 INFO - 'tests': ['dromaeo_dom']}, 10:31:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:31:34 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:34 INFO - 'tests': ['basic_compositor_video', 10:31:34 INFO - 'glvideo']}, 10:31:34 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:31:34 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:31:34 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:31:34 INFO - 'talos_options': ['--disable-stylo'], 10:31:34 INFO - 'tests': ['ts_paint_webext', 10:31:34 INFO - 'tp5o_webext']}, 10:31:34 INFO - 'other-e10s': {'tests': ['a11yr', 10:31:34 INFO - 'ts_paint', 10:31:34 INFO - 'tpaint', 10:31:34 INFO - 'sessionrestore', 10:31:34 INFO - 'sessionrestore_many_windows', 10:31:34 INFO - 'sessionrestore_no_auto_restore', 10:31:34 INFO - 'tabpaint']}, 10:31:34 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:34 INFO - 'tests': ['a11yr', 10:31:34 INFO - 'ts_paint', 10:31:34 INFO - 'tpaint', 10:31:34 INFO - 'sessionrestore', 10:31:34 INFO - 'sessionrestore_many_windows', 10:31:34 INFO - 'sessionrestore_no_auto_restore', 10:31:34 INFO - 'tabpaint']}, 10:31:34 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:31:34 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:31:34 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:34 INFO - 'tests': ['bloom_basic_singleton']}, 10:31:34 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:34 INFO - 'tests': ['bloom_basic']}, 10:31:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:31:34 INFO - 'tsvgr_opacity', 10:31:34 INFO - 'tart', 10:31:34 INFO - 'tscrollx', 10:31:34 INFO - 'tsvg_static']}, 10:31:34 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:34 INFO - 'tests': ['tsvgx', 10:31:34 INFO - 'tsvgr_opacity', 10:31:34 INFO - 'tart', 10:31:34 INFO - 'tscrollx', 10:31:34 INFO - 'tsvg_static']}, 10:31:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:31:34 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:31:34 INFO - 'talos_options': ['--disable-stylo'], 10:31:34 INFO - 'tests': ['tp5o']}, 10:31:34 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:31:34 INFO - 'talos_options': ['--mitmproxy', 10:31:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:31:34 INFO - '--firstNonBlankPaint'], 10:31:34 INFO - 'tests': ['tp6_google', 10:31:34 INFO - 'tp6_youtube', 10:31:34 INFO - 'tp6_amazon', 10:31:34 INFO - 'tp6_facebook']}, 10:31:34 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:31:34 INFO - 'talos_options': ['--disable-stylo', 10:31:34 INFO - '--mitmproxy', 10:31:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:31:34 INFO - '--firstNonBlankPaint'], 10:31:34 INFO - 'tests': ['tp6_google', 10:31:34 INFO - 'tp6_youtube', 10:31:34 INFO - 'tp6_amazon', 10:31:34 INFO - 'tp6_facebook']}, 10:31:34 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:31:34 INFO - 'talos_options': ['--stylo-threads=1', 10:31:34 INFO - '--mitmproxy', 10:31:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:31:34 INFO - '--firstNonBlankPaint'], 10:31:34 INFO - 'tests': ['tp6_google', 10:31:34 INFO - 'tp6_youtube', 10:31:34 INFO - 'tp6_amazon', 10:31:34 INFO - 'tp6_facebook']}, 10:31:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:31:34 INFO - 'talos_options': ['--xperf_path', 10:31:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:34 INFO - 'tests': ['tp5n']}, 10:31:34 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:31:34 INFO - 'talos_options': ['--disable-stylo', 10:31:34 INFO - '--xperf_path', 10:31:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:34 INFO - 'tests': ['tp5n']}}} 10:31:34 INFO - Running post-action listener: _resource_record_post_action 10:31:34 INFO - [mozharness: 2017-09-14 17:31:34.247032Z] Finished populate-webroot step (success) 10:31:34 INFO - [mozharness: 2017-09-14 17:31:34.247122Z] Running create-virtualenv step. 10:31:34 INFO - Running pre-action listener: _resource_record_pre_action 10:31:34 INFO - Running main action method: create_virtualenv 10:31:34 INFO - Creating virtualenv /builds/slave/test/build/venv 10:31:34 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:31:34 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 10:31:34 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:31:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:31:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:31:34 INFO - Installing distribute.............................................................................................................................................................................................done. 10:31:35 INFO - Installing pip...............done. 10:31:35 INFO - Return code: 0 10:31:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:31:35 INFO - Reading from file tmpfile_stdout 10:31:35 INFO - Output received: 10:31:35 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 10:31:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', '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 10:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:31:35 INFO - Using env: {'DISPLAY': ':0', 10:31:35 INFO - 'HOME': '/home/cltbld', 10:31:35 INFO - 'LANG': 'en_US.UTF-8', 10:31:35 INFO - 'LANGUAGE': 'en_US:en', 10:31:35 INFO - 'LOGNAME': 'cltbld', 10:31:35 INFO - 'MAIL': '/var/mail/cltbld', 10:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:35 INFO - 'MOZ_NO_REMOTE': '1', 10:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:35 INFO - 'NO_EM_RESTART': '1', 10:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:35 INFO - 'PWD': '/builds/slave/test', 10:31:35 INFO - 'SHELL': '/bin/bash', 10:31:35 INFO - 'SHLVL': '1', 10:31:35 INFO - 'TERM': 'linux', 10:31:35 INFO - 'TMOUT': '86400', 10:31:35 INFO - 'USER': 'cltbld', 10:31:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', 10:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:35 INFO - '_': '/tools/buildbot/bin/python'} 10:31:36 INFO - Ignoring indexes: http://pypi.python.org/simple/ 10:31:36 INFO - Downloading/unpacking pip>=1.5 10:31:36 INFO - Running setup.py egg_info for package pip 10:31:36 INFO - warning: no files found matching 'pip/cacert.pem' 10:31:36 INFO - warning: no files found matching '*.html' under directory 'docs' 10:31:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:31:36 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:31:36 INFO - Installing collected packages: pip 10:31:36 INFO - Found existing installation: pip 1.1 10:31:36 INFO - Uninstalling pip: 10:31:36 INFO - Successfully uninstalled pip 10:31:36 INFO - Running setup.py install for pip 10:31:36 INFO - warning: no files found matching 'pip/cacert.pem' 10:31:36 INFO - warning: no files found matching '*.html' under directory 'docs' 10:31:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:31:36 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:31:36 INFO - Installing pip script to /builds/slave/test/build/venv/bin 10:31:36 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 10:31:36 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 10:31:36 INFO - Successfully installed pip 10:31:36 INFO - Cleaning up... 10:31:36 INFO - Return code: 0 10:31:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:31:36 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')]} 10:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:36 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')]} 10:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:36 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', '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 10:31:36 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 10:31:36 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 10:31:36 INFO - Using env: {'DISPLAY': ':0', 10:31:36 INFO - 'HOME': '/home/cltbld', 10:31:36 INFO - 'LANG': 'en_US.UTF-8', 10:31:36 INFO - 'LANGUAGE': 'en_US:en', 10:31:36 INFO - 'LOGNAME': 'cltbld', 10:31:36 INFO - 'MAIL': '/var/mail/cltbld', 10:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:36 INFO - 'MOZ_NO_REMOTE': '1', 10:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:36 INFO - 'NO_EM_RESTART': '1', 10:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:36 INFO - 'PWD': '/builds/slave/test', 10:31:36 INFO - 'SHELL': '/bin/bash', 10:31:36 INFO - 'SHLVL': '1', 10:31:36 INFO - 'TERM': 'linux', 10:31:36 INFO - 'TMOUT': '86400', 10:31:36 INFO - 'USER': 'cltbld', 10:31:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', 10:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:36 INFO - '_': '/tools/buildbot/bin/python'} 10:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:36 INFO - Downloading/unpacking psutil>=3.1.1 10:31:36 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 10:31:36 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 10:31:36 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 10:31:36 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 10:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:31:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:37 INFO - Installing collected packages: psutil 10:31:37 INFO - Running setup.py install for psutil 10:31:37 INFO - building 'psutil._psutil_linux' extension 10:31:37 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 10:31:38 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 10:31:38 INFO - building 'psutil._psutil_posix' extension 10:31:38 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 10:31:38 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 10:31:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:38 INFO - Successfully installed psutil 10:31:38 INFO - Cleaning up... 10:31:38 INFO - Return code: 0 10:31:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:38 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', '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 10:31:38 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 10:31:38 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 10:31:38 INFO - Using env: {'DISPLAY': ':0', 10:31:38 INFO - 'HOME': '/home/cltbld', 10:31:38 INFO - 'LANG': 'en_US.UTF-8', 10:31:38 INFO - 'LANGUAGE': 'en_US:en', 10:31:38 INFO - 'LOGNAME': 'cltbld', 10:31:38 INFO - 'MAIL': '/var/mail/cltbld', 10:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:38 INFO - 'MOZ_NO_REMOTE': '1', 10:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:38 INFO - 'NO_EM_RESTART': '1', 10:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:38 INFO - 'PWD': '/builds/slave/test', 10:31:38 INFO - 'SHELL': '/bin/bash', 10:31:38 INFO - 'SHLVL': '1', 10:31:38 INFO - 'TERM': 'linux', 10:31:38 INFO - 'TMOUT': '86400', 10:31:38 INFO - 'USER': 'cltbld', 10:31:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', 10:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:38 INFO - '_': '/tools/buildbot/bin/python'} 10:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:31:38 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 10:31:38 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 10:31:38 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 10:31:38 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 10:31:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:31:39 INFO - Installing collected packages: mozsystemmonitor 10:31:39 INFO - Running setup.py install for mozsystemmonitor 10:31:40 INFO - Successfully installed mozsystemmonitor 10:31:40 INFO - Cleaning up... 10:31:40 INFO - Return code: 0 10:31:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:40 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', '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 10:31:40 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 10:31:40 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 10:31:40 INFO - Using env: {'DISPLAY': ':0', 10:31:40 INFO - 'HOME': '/home/cltbld', 10:31:40 INFO - 'LANG': 'en_US.UTF-8', 10:31:40 INFO - 'LANGUAGE': 'en_US:en', 10:31:40 INFO - 'LOGNAME': 'cltbld', 10:31:40 INFO - 'MAIL': '/var/mail/cltbld', 10:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:41 INFO - 'MOZ_NO_REMOTE': '1', 10:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:41 INFO - 'NO_EM_RESTART': '1', 10:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:41 INFO - 'PWD': '/builds/slave/test', 10:31:41 INFO - 'SHELL': '/bin/bash', 10:31:41 INFO - 'SHLVL': '1', 10:31:41 INFO - 'TERM': 'linux', 10:31:41 INFO - 'TMOUT': '86400', 10:31:41 INFO - 'USER': 'cltbld', 10:31:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', 10:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:41 INFO - '_': '/tools/buildbot/bin/python'} 10:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:41 INFO - Downloading/unpacking jsonschema==2.5.1 10:31:41 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 10:31:41 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 10:31:41 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 10:31:41 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 10:31:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:31:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:42 INFO - Downloading functools32-3.2.3-2.tar.gz 10:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:31:42 INFO - warning: no files found matching '*.txt' 10:31:42 INFO - no previously-included directories found matching 'build' 10:31:42 INFO - no previously-included directories found matching 'dist' 10:31:42 INFO - no previously-included directories found matching '.git*' 10:31:42 INFO - Installing collected packages: jsonschema, functools32 10:31:42 INFO - Running setup.py install for functools32 10:31:43 INFO - warning: no files found matching '*.txt' 10:31:43 INFO - no previously-included directories found matching 'build' 10:31:43 INFO - no previously-included directories found matching 'dist' 10:31:43 INFO - no previously-included directories found matching '.git*' 10:31:43 INFO - Successfully installed jsonschema functools32 10:31:43 INFO - Cleaning up... 10:31:43 INFO - Return code: 0 10:31:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:43 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', '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 10:31:43 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 10:31:43 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 10:31:43 INFO - Using env: {'DISPLAY': ':0', 10:31:43 INFO - 'HOME': '/home/cltbld', 10:31:43 INFO - 'LANG': 'en_US.UTF-8', 10:31:43 INFO - 'LANGUAGE': 'en_US:en', 10:31:43 INFO - 'LOGNAME': 'cltbld', 10:31:43 INFO - 'MAIL': '/var/mail/cltbld', 10:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:43 INFO - 'MOZ_NO_REMOTE': '1', 10:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:43 INFO - 'NO_EM_RESTART': '1', 10:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:43 INFO - 'PWD': '/builds/slave/test', 10:31:43 INFO - 'SHELL': '/bin/bash', 10:31:43 INFO - 'SHLVL': '1', 10:31:43 INFO - 'TERM': 'linux', 10:31:43 INFO - 'TMOUT': '86400', 10:31:43 INFO - 'USER': 'cltbld', 10:31:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', 10:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:43 INFO - '_': '/tools/buildbot/bin/python'} 10:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:31:44 INFO - Cleaning up... 10:31:44 INFO - Return code: 0 10:31:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:31: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')]} 10:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31: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')]} 10:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', '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 10:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:31:44 INFO - Using env: {'DISPLAY': ':0', 10:31:44 INFO - 'HOME': '/home/cltbld', 10:31:44 INFO - 'LANG': 'en_US.UTF-8', 10:31:44 INFO - 'LANGUAGE': 'en_US:en', 10:31:44 INFO - 'LOGNAME': 'cltbld', 10:31:44 INFO - 'MAIL': '/var/mail/cltbld', 10:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:44 INFO - 'MOZ_NO_REMOTE': '1', 10:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:44 INFO - 'NO_EM_RESTART': '1', 10:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:44 INFO - 'PWD': '/builds/slave/test', 10:31:44 INFO - 'SHELL': '/bin/bash', 10:31:44 INFO - 'SHLVL': '1', 10:31:44 INFO - 'TERM': 'linux', 10:31:44 INFO - 'TMOUT': '86400', 10:31:44 INFO - 'USER': 'cltbld', 10:31:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', 10:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:44 INFO - '_': '/tools/buildbot/bin/python'} 10:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:44 INFO - Downloading/unpacking blobuploader==1.2.4 10:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:45 INFO - Downloading blobuploader-1.2.4.tar.gz 10:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:31:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:31:45 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 10:31:45 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 10:31:45 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 10:31:45 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 10:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:31:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:31:45 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 10:31:45 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 10:31:45 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 10:31:45 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 10:31:45 INFO - Downloading docopt-0.6.1.tar.gz 10:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:31:46 INFO - Installing collected packages: blobuploader, requests, docopt 10:31:46 INFO - Running setup.py install for blobuploader 10:31:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:31:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:31:46 INFO - Running setup.py install for requests 10:31:46 INFO - Running setup.py install for docopt 10:31:46 INFO - Successfully installed blobuploader requests docopt 10:31:46 INFO - Cleaning up... 10:31:46 INFO - Return code: 0 10:31:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:46 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', '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 10:31:46 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 10:31:46 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 10:31:46 INFO - Using env: {'DISPLAY': ':0', 10:31:46 INFO - 'HOME': '/home/cltbld', 10:31:46 INFO - 'LANG': 'en_US.UTF-8', 10:31:46 INFO - 'LANGUAGE': 'en_US:en', 10:31:46 INFO - 'LOGNAME': 'cltbld', 10:31:46 INFO - 'MAIL': '/var/mail/cltbld', 10:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:46 INFO - 'MOZ_NO_REMOTE': '1', 10:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:46 INFO - 'NO_EM_RESTART': '1', 10:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:46 INFO - 'PWD': '/builds/slave/test', 10:31:46 INFO - 'SHELL': '/bin/bash', 10:31:46 INFO - 'SHLVL': '1', 10:31:46 INFO - 'TERM': 'linux', 10:31:46 INFO - 'TMOUT': '86400', 10:31:46 INFO - 'USER': 'cltbld', 10:31:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', 10:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:46 INFO - '_': '/tools/buildbot/bin/python'} 10:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:46 INFO - Running setup.py (path:/tmp/pip-5V2EtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:46 INFO - Running setup.py (path:/tmp/pip-_qmpgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:46 INFO - Running setup.py (path:/tmp/pip-0A2iGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:47 INFO - Running setup.py (path:/tmp/pip-stnprf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:47 INFO - Running setup.py (path:/tmp/pip-Z67m0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:47 INFO - Running setup.py (path:/tmp/pip-02C2Us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:47 INFO - Running setup.py (path:/tmp/pip-btt1n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:47 INFO - Running setup.py (path:/tmp/pip-6XvqMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:47 INFO - Running setup.py (path:/tmp/pip-xqveST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:47 INFO - Running setup.py (path:/tmp/pip-siKjI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:47 INFO - Running setup.py (path:/tmp/pip-EgPEN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:47 INFO - Running setup.py (path:/tmp/pip-fHWpwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:47 INFO - Running setup.py (path:/tmp/pip-D0rLJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:47 INFO - Running setup.py (path:/tmp/pip-olRqbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:47 INFO - Running setup.py (path:/tmp/pip-Ll7360-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:47 INFO - Running setup.py (path:/tmp/pip-RKel_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:47 INFO - Running setup.py (path:/tmp/pip-TaVHEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:31:48 INFO - Running setup.py install for manifestparser 10:31:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:31:48 INFO - Running setup.py install for mozcrash 10:31:48 INFO - Running setup.py install for mozdebug 10:31:48 INFO - Running setup.py install for mozdevice 10:31:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:31:48 INFO - Running setup.py install for mozfile 10:31:48 INFO - Running setup.py install for mozhttpd 10:31:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:31:48 INFO - Running setup.py install for mozinfo 10:31:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:31:48 INFO - Running setup.py install for mozInstall 10:31:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:31:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:31:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:31:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:31:48 INFO - Running setup.py install for mozleak 10:31:48 INFO - Running setup.py install for mozlog 10:31:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:31:49 INFO - Running setup.py install for moznetwork 10:31:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:31:49 INFO - Running setup.py install for mozprocess 10:31:49 INFO - Running setup.py install for mozprofile 10:31:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:31:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:31:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:31:49 INFO - Running setup.py install for mozrunner 10:31:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:31:49 INFO - Running setup.py install for mozscreenshot 10:31:49 INFO - Running setup.py install for moztest 10:31:49 INFO - Running setup.py install for mozversion 10:31:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:31:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:31:49 INFO - Cleaning up... 10:31:49 INFO - Return code: 0 10:31:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31: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')]} 10:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31: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')]} 10:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:49 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', '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 10:31:49 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 10:31:49 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 10:31:49 INFO - Using env: {'DISPLAY': ':0', 10:31:49 INFO - 'HOME': '/home/cltbld', 10:31:49 INFO - 'LANG': 'en_US.UTF-8', 10:31:49 INFO - 'LANGUAGE': 'en_US:en', 10:31:49 INFO - 'LOGNAME': 'cltbld', 10:31:49 INFO - 'MAIL': '/var/mail/cltbld', 10:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:49 INFO - 'MOZ_NO_REMOTE': '1', 10:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:49 INFO - 'NO_EM_RESTART': '1', 10:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:49 INFO - 'PWD': '/builds/slave/test', 10:31:49 INFO - 'SHELL': '/bin/bash', 10:31:49 INFO - 'SHLVL': '1', 10:31:49 INFO - 'TERM': 'linux', 10:31:49 INFO - 'TMOUT': '86400', 10:31:49 INFO - 'USER': 'cltbld', 10:31:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', 10:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:49 INFO - '_': '/tools/buildbot/bin/python'} 10:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:50 INFO - Running setup.py (path:/tmp/pip-an47W1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:50 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)) 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:50 INFO - Running setup.py (path:/tmp/pip-hYEYBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:50 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)) 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:50 INFO - Running setup.py (path:/tmp/pip-ebyGUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:50 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)) 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:50 INFO - Running setup.py (path:/tmp/pip-GInNfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:50 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)) 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:50 INFO - Running setup.py (path:/tmp/pip-20rny9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:50 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)) 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:50 INFO - Running setup.py (path:/tmp/pip-07CiGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:50 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)) 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:50 INFO - Running setup.py (path:/tmp/pip-6dL9HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:50 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)) 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:50 INFO - Running setup.py (path:/tmp/pip-804oQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:50 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)) 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:50 INFO - Running setup.py (path:/tmp/pip-QUddbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:50 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)) 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:50 INFO - Running setup.py (path:/tmp/pip-TYAKz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:50 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)) 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:50 INFO - Running setup.py (path:/tmp/pip-cckJy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:50 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)) 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:50 INFO - Running setup.py (path:/tmp/pip-jih2GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:50 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)) 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:50 INFO - Running setup.py (path:/tmp/pip-_wDpAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:50 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)) 10:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:50 INFO - Running setup.py (path:/tmp/pip-jdUIhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:51 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)) 10:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:51 INFO - Running setup.py (path:/tmp/pip-FRYv77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:51 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)) 10:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:51 INFO - Running setup.py (path:/tmp/pip-z1Z6FS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:51 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)) 10:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:51 INFO - Running setup.py (path:/tmp/pip-cQdCiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:51 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)) 10:31:51 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)) 10:31:51 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)) 10:31:51 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)) 10:31:51 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)) 10:31:51 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)) 10:31:51 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)) 10:31:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:52 INFO - Downloading blessings-1.6.tar.gz 10:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:31:52 INFO - Installing collected packages: blessings 10:31:52 INFO - Running setup.py install for blessings 10:31:52 INFO - Successfully installed blessings 10:31:52 INFO - Cleaning up... 10:31:52 INFO - Return code: 0 10:31:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:31:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:52 INFO - Reading from file tmpfile_stdout 10:31:52 INFO - Current package versions: 10:31:52 INFO - argparse == 1.2.1 10:31:52 INFO - blessings == 1.6 10:31:52 INFO - blobuploader == 1.2.4 10:31:52 INFO - docopt == 0.6.1 10:31:52 INFO - functools32 == 3.2.3-2 10:31:52 INFO - jsonschema == 2.5.1 10:31:52 INFO - manifestparser == 1.1 10:31:52 INFO - mozInstall == 1.13 10:31:52 INFO - mozcrash == 1.0 10:31:52 INFO - mozdebug == 0.1 10:31:52 INFO - mozdevice == 0.51 10:31:52 INFO - mozfile == 1.2 10:31:52 INFO - mozhttpd == 0.7 10:31:52 INFO - mozinfo == 0.10 10:31:52 INFO - mozleak == 0.1 10:31:52 INFO - mozlog == 3.5 10:31:52 INFO - moznetwork == 0.27 10:31:52 INFO - mozprocess == 0.25 10:31:52 INFO - mozprofile == 0.28 10:31:52 INFO - mozrunner == 6.13 10:31:52 INFO - mozscreenshot == 0.1 10:31:52 INFO - mozsystemmonitor == 0.3 10:31:52 INFO - moztest == 0.8 10:31:52 INFO - mozversion == 1.4 10:31:52 INFO - psutil == 3.1.1 10:31:52 INFO - requests == 1.2.3 10:31:52 INFO - wsgiref == 0.1.2 10:31:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:52 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', '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 10:31:52 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 10:31:52 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 10:31:52 INFO - Using env: {'DISPLAY': ':0', 10:31:52 INFO - 'HOME': '/home/cltbld', 10:31:52 INFO - 'LANG': 'en_US.UTF-8', 10:31:52 INFO - 'LANGUAGE': 'en_US:en', 10:31:52 INFO - 'LOGNAME': 'cltbld', 10:31:52 INFO - 'MAIL': '/var/mail/cltbld', 10:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:52 INFO - 'MOZ_NO_REMOTE': '1', 10:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:52 INFO - 'NO_EM_RESTART': '1', 10:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:52 INFO - 'PWD': '/builds/slave/test', 10:31:52 INFO - 'SHELL': '/bin/bash', 10:31:52 INFO - 'SHLVL': '1', 10:31:52 INFO - 'TERM': 'linux', 10:31:52 INFO - 'TMOUT': '86400', 10:31:52 INFO - 'USER': 'cltbld', 10:31:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', 10:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:52 INFO - '_': '/tools/buildbot/bin/python'} 10:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:53 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)) 10:31:53 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)) 10:31:53 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)) 10:31:53 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)) 10:31:53 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)) 10:31:53 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)) 10:31:53 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)) 10:31:53 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)) 10:31:53 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)) 10:31:53 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:31:55 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)) 10:31:55 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)) 10:31:55 INFO - Installing collected packages: simplejson 10:31:55 INFO - Running setup.py install for simplejson 10:31:55 INFO - building 'simplejson._speedups' extension 10:31:55 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 10:31:56 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 10:31:56 INFO - Successfully installed simplejson 10:31:56 INFO - Cleaning up... 10:31:56 INFO - Return code: 0 10:31:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:31:56 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')]} 10:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:56 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')]} 10:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:56 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', '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 10:31:56 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 10:31:56 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 10:31:56 INFO - Using env: {'DISPLAY': ':0', 10:31:56 INFO - 'HOME': '/home/cltbld', 10:31:56 INFO - 'LANG': 'en_US.UTF-8', 10:31:56 INFO - 'LANGUAGE': 'en_US:en', 10:31:56 INFO - 'LOGNAME': 'cltbld', 10:31:56 INFO - 'MAIL': '/var/mail/cltbld', 10:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:56 INFO - 'MOZ_NO_REMOTE': '1', 10:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:56 INFO - 'NO_EM_RESTART': '1', 10:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:56 INFO - 'PWD': '/builds/slave/test', 10:31:56 INFO - 'SHELL': '/bin/bash', 10:31:56 INFO - 'SHLVL': '1', 10:31:56 INFO - 'TERM': 'linux', 10:31:56 INFO - 'TMOUT': '86400', 10:31:56 INFO - 'USER': 'cltbld', 10:31:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', 10:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:56 INFO - '_': '/tools/buildbot/bin/python'} 10:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:31:56 INFO - Cleaning up... 10:31:56 INFO - Return code: 0 10:31:56 INFO - Running post-action listener: _resource_record_post_action 10:31:56 INFO - Running post-action listener: _start_resource_monitoring 10:31:56 INFO - Starting resource monitoring. 10:31:56 INFO - [mozharness: 2017-09-14 17:31:56.509572Z] Finished create-virtualenv step (success) 10:31:56 INFO - [mozharness: 2017-09-14 17:31:56.510033Z] Running install step. 10:31:56 INFO - Running pre-action listener: _resource_record_pre_action 10:31:56 INFO - Running main action method: install 10:31:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:56 INFO - Reading from file tmpfile_stdout 10:31:56 INFO - Detecting whether we're running mozinstall >=1.0... 10:31:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:31:56 INFO - Reading from file tmpfile_stdout 10:31:56 INFO - Output received: 10:31:56 INFO - Usage: mozinstall [options] installer 10:31:56 INFO - Options: 10:31:56 INFO - -h, --help show this help message and exit 10:31:56 INFO - -d DEST, --destination=DEST 10:31:56 INFO - Directory to install application into. [default: 10:31:56 INFO - "/builds/slave/test"] 10:31:56 INFO - --app=APP Application being installed. [default: firefox] 10:31:56 INFO - mkdir: /builds/slave/test/build/application 10:31:56 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'] 10:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:32:14 INFO - Reading from file tmpfile_stdout 10:32:14 INFO - Output received: 10:32:14 INFO - /builds/slave/test/build/application/firefox/firefox 10:32:14 INFO - Running post-action listener: _resource_record_post_action 10:32:14 INFO - [mozharness: 2017-09-14 17:32:14.464034Z] Finished install step (success) 10:32:14 INFO - [mozharness: 2017-09-14 17:32:14.464178Z] Running setup-mitmproxy step. 10:32:14 INFO - Running pre-action listener: _resource_record_pre_action 10:32:14 INFO - Running main action method: setup_mitmproxy 10:32:14 INFO - Skipping: mitmproxy is not required 10:32:14 INFO - Running post-action listener: _resource_record_post_action 10:32:14 INFO - [mozharness: 2017-09-14 17:32:14.464708Z] Finished setup-mitmproxy step (success) 10:32:14 INFO - [mozharness: 2017-09-14 17:32:14.464810Z] Running run-tests step. 10:32:14 INFO - Running pre-action listener: _resource_record_pre_action 10:32:14 INFO - Running pre-action listener: _set_gcov_prefix 10:32:14 INFO - Running main action method: run_tests 10:32:14 WARNING - Try message not found. 10:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:32:14 INFO - Python 2.7.3 10:32:14 INFO - Return code: 0 10:32:14 INFO - grabbing minidump binary from tooltool 10:32:14 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')]} 10:32:14 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 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:32:14 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 10:32:14 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 10:32:14 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 10:32:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:32:14 INFO - Return code: 0 10:32:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:32:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:32:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:32:14 INFO - ENV: RUST_BACKTRACE is now full 10:32:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:32:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:32:14 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/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 10:32:14 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/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 10:32:14 INFO - Using env: {'DISPLAY': ':0', 10:32:14 INFO - 'HOME': '/home/cltbld', 10:32:14 INFO - 'LANG': 'en_US.UTF-8', 10:32:14 INFO - 'LANGUAGE': 'en_US:en', 10:32:14 INFO - 'LOGNAME': 'cltbld', 10:32:14 INFO - 'MAIL': '/var/mail/cltbld', 10:32:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:32:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:14 INFO - 'MOZ_NO_REMOTE': '1', 10:32:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:14 INFO - 'NO_EM_RESTART': '1', 10:32:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:14 INFO - 'PWD': '/builds/slave/test', 10:32:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:32:14 INFO - 'RUST_BACKTRACE': 'full', 10:32:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:32:14 INFO - 'SHELL': '/bin/bash', 10:32:14 INFO - 'SHLVL': '1', 10:32:14 INFO - 'TERM': 'linux', 10:32:14 INFO - 'TMOUT': '86400', 10:32:14 INFO - 'USER': 'cltbld', 10:32:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', 10:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:14 INFO - '_': '/tools/buildbot/bin/python'} 10:32:14 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/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 10:32:14 INFO - mozversion application_buildid: 20170914161400 10:32:14 INFO - mozversion application_changeset: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b 10:32:14 INFO - mozversion application_display_name: Nightly 10:32:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:32:14 INFO - mozversion application_name: Firefox 10:32:14 INFO - mozversion application_remotingname: firefox 10:32:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:32:14 INFO - mozversion application_vendor: Mozilla 10:32:14 INFO - mozversion application_version: 57.0a1 10:32:14 INFO - mozversion platform_buildid: 20170914161400 10:32:14 INFO - mozversion platform_changeset: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b 10:32:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:32:14 INFO - mozversion platform_version: 57.0a1 10:32:14 INFO - using testdate: 1505410334 10:32:14 INFO - actual date: 1505410334 10:32:14 INFO - starting webserver on 'localhost:46958' 10:32:14 INFO - SUITE-START | Running 2 tests 10:32:14 INFO - TEST-START | dromaeo_css 10:32:14 INFO - Initialising browser for dromaeo_css test... 10:32:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46958/getInfo.html -profile /tmp/tmpEhVHKe/profile 10:32:14 INFO - TEST-INFO | started process 1842 (/builds/slave/test/build/application/firefox/firefox http://localhost:46958/getInfo.html) 10:32:21 INFO - TEST-INFO | 1842: exit 0 10:32:21 INFO - Browser initialized. 10:32:21 INFO - Running cycle 1/1 for dromaeo_css test... 10:32:21 INFO - Using env: {'DISPLAY': ':0', 10:32:21 INFO - 'HOME': '/home/cltbld', 10:32:21 INFO - 'JSGC_DISABLE_POISONING': '1', 10:32:21 INFO - 'LANG': 'en_US.UTF-8', 10:32:21 INFO - 'LANGUAGE': 'en_US:en', 10:32:21 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:32:21 INFO - 'LOGNAME': 'cltbld', 10:32:21 INFO - 'MAIL': '/var/mail/cltbld', 10:32:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:32:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:32:21 INFO - 'MOZ_CRASHREPORTER': '1', 10:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:21 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:32:21 INFO - 'MOZ_NO_REMOTE': '1', 10:32:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:21 INFO - 'NO_EM_RESTART': '1', 10:32:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:21 INFO - 'PWD': '/builds/slave/test', 10:32:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:32:21 INFO - 'RUST_BACKTRACE': 'full', 10:32:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:32:21 INFO - 'SHELL': '/bin/bash', 10:32:21 INFO - 'SHLVL': '1', 10:32:21 INFO - 'STYLO_FORCE_DISABLED': '1', 10:32:21 INFO - 'TERM': 'linux', 10:32:21 INFO - 'TMOUT': '86400', 10:32:21 INFO - 'USER': 'cltbld', 10:32:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', 10:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:21 INFO - '_': '/tools/buildbot/bin/python'} 10:32:21 INFO - TEST-INFO | started process 2079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEhVHKe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:22 INFO - PID 2079 | 10:32:22 INFO - PID 2079 | (/builds/slave/test/build/application/firefox/firefox:2128): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:32:22 INFO - PID 2079 | 10:32:32 INFO - PID 2079 | RSS: Main: 164196352 10:32:32 INFO - PID 2079 | 10:35:30 INFO - PID 2079 | Cycle 1(1): loaded http://localhost:46958/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46958/tests/dromaeo/cssquery-ext.html) 10:35:31 INFO - PID 2079 | RSS: Main: 168894464 10:35:31 INFO - PID 2079 | 10:38:33 INFO - PID 2079 | Cycle 1(1): loaded http://localhost:46958/tests/dromaeo/cssquery-ext.html (next: http://localhost:46958/tests/dromaeo/cssquery-jquery.html) 10:38:33 INFO - PID 2079 | RSS: Main: 165031936 10:38:33 INFO - PID 2079 | 10:41:35 INFO - PID 2079 | Cycle 1(1): loaded http://localhost:46958/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46958/tests/dromaeo/cssquery-mootools.html) 10:41:36 INFO - PID 2079 | RSS: Main: 167325696 10:41:36 INFO - PID 2079 | 10:44:37 INFO - PID 2079 | Cycle 1(1): loaded http://localhost:46958/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46958/tests/dromaeo/cssquery-prototype.html) 10:44:38 INFO - PID 2079 | RSS: Main: 165822464 10:44:38 INFO - PID 2079 | 10:47:41 INFO - PID 2079 | Cycle 1(1): loaded http://localhost:46958/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46958/tests/dromaeo/cssquery-yui.html) 10:47:41 INFO - PID 2079 | RSS: Main: 167256064 10:47:41 INFO - PID 2079 | 10:50:43 INFO - PID 2079 | Cycle 1(1): loaded http://localhost:46958/tests/dromaeo/cssquery-yui.html (next: http://localhost:46958/tests/dromaeo/cssquery-dojo.html) 10:50:43 INFO - PID 2079 | RSS: Main: 170328064 10:50:43 INFO - PID 2079 | 10:50:43 INFO - PID 2079 | __start_tp_report 10:50:43 INFO - PID 2079 | _x_x_mozilla_page_load 10:50:43 INFO - PID 2079 | _x_x_mozilla_page_load_details 10:50:43 INFO - PID 2079 | |i|pagename|runs| 10:50:43 INFO - PID 2079 | |0;dojo.html;3837.80810959452;3864.343061679514;3903.4340020697;3928.901777455563;3940.5665376808547;6244.375562443754;6286.497080233582;6338.714757835897;6361.650109243989;6404.839879003027;6295.779647712331;6366.108744775735;6369.840753981152;6372.139761132245;6383.170187875581;5616.101423772197;5636.549076073904;5644.068728659766;5654.9151762723595;5719.027765279912;5682.147677848335;5723.198752174699;5738.196652468637;5766.336871259796;5789.39211382805;5623.80316688916;5632.605717599769;5686;5715.914261286084;5719.513841323493;5474.835754927359;5569.192467092289;5574.60977731559;5627.127795191752;5632.971835140839;5529.502344788948;5539.113741801333;5610.971945140289;5611.3546942101775;5627.831165065055;6160.815175544741;6216.347283535209;6292.056191571255;6295.276043254993;6298.086777417295;6766.15423072116;6814.1482314710665;6820.556663816886;6824.727010919557;6835.213950395719;6878.484113691443;6880.552764070369;6880.65596720162;6886.552374095718;6887.242403335679;6351;6380.872382552323;6432.228132624068;6464.709088091;6471.579347342407;6902.137232845895;7000.894986575206;7071.752488662872;7091.751788687371;7092.397146242524;6707.899381509281;6713.496487763339;6755.1556055493065;6799.3200679931615;6813.523053386314;6799.388055075067;6857.759978400732;6907.447404207652;6915.962605609199;6949.826254343682;6832.145981752281;6870.690818913161;6881.587104773729;6906;6923.169219693669;6801.897971530431;6881.690323935435;6888;6896.827579310558;6930.029795828588;4973.079980203674;5003.974980125149;5033.874153146201;5069.923951140736;5074.873128171751;4441.422615060022;4502.819887204475;4508.639308855284;4516.36770852081;4599.862004139881;6353.459955903708;6395.488360931115;6448.677566121769;6454.483641308684;6471.2234531856475;6821.4542836572955;6844.589324640538;6853.862922741518;6856;6952.409045231111;6295.150154729145;6397.584157029778;6418.19772528434;6433.195850518685;6453.193350831146;5542.0301447247375;5561.749721262553;5565.16522521625;5571;5571.025070612626;7114.537555058904;7122.03852479919;7208.207097219407;7210.531315464478;7244.855102897913;6705.798826035227;6708.22855371619;6798.184217893884;6798.286179951034;6809.965950170217;6978.441724661913;7035.296470352924;7093.077899872984;7127.394171495481;7133.750318738819;6725.932740672531;6766.120404347404;6767.1879374475375;6777.457803375817;6799.626020568916;6673.366030227121;6758.594484330956;6771.052052712723;6773.356531129535;6850.6574671267235;6611.537192396486;6621.569597976116;6631.403173714389;6658.667066646552;6660.733570657119;6563.245226798788;6573.737050517926;6643.335666433318;6649.434798042027;6656.5340426169705;6452;6516.934830651633;6530.118434011348;6596.472282217315;6603.339666033358;6622.205335359788;6646.302138275411;6655.068290439245;6680.866382672417;6723.697433615401;6418.486521078209;6465.612063276219;6465.903011454738;6529.608223506605;6553.574017688835 10:50:43 INFO - PID 2079 | |1;ext.html;936.9999999999998;945.763559110222;956.1872408452814;991.6777047459568;994.4828689081673;44358.55641443584;45495.545044549624;45508.0898382033;45573;45582.316265256006;46030.539694603045;46873;46923.53076469234;46936.765316173456;46967;7927.8810817837775;8002.479838810488;8004.719834805783;8033.919660803404;8064.959675201616;8373;8448.957755211215;8479.703210387637;8500;8508.659653613848;8467.703630372938;8498.107698691641;8535.402521823475;8539.444936079135;8545.74362769118;8420;8504.404691671616;8508.36187285953;8508.489490630582;8511.489310641382;8289.04675962266;8309.044459887129;8324.83350332996;8350.958245208734;8354.665813367457;41070;41470.58529414728;41521.37717934234;41684.58315416837;41775.7911210445;3796.9430458543143;3847.2305538892333;3854;3860.4209368594657;3865.1496670732677;33901.49147762785;33949.660503394894;33998.49002264968;34028;34053;5414.3232095988005;5546.029444847136;5556.305461817273;5562.7774889004395;5612.466815652507;208058.9999999985;208836;209454;209545;209733;52571.737141314814;52718.209226861625;52751.73624131932;52839.73580132152;56116;58857;58951.705241473515;59029.93395231146;59068;59086;15569.922150389402;15742.685146297239;15750.369985200692;15754.527364178864;15759.68480630381;14104.224267665377;14268.072575282573;14294.785578216335;14299.857001429853;14300.213488258038;16510;16603.83396166047;16628.750568741478;16711.91644041772;16753.246103925354;6229.937700623026;6312.842178945563;6327.3988971047675;6388.744450221939;6570.704318305688;1098.758273179899;1100.9284396514201;1111.8499002634703;1114.7157474843864;1117.100733909211;26194.73805261961;26218.475630487665;26264.737352626613;26398.20805375842;26513.204603861916;1220.3776074202221;1221.6151912147823;1235.4502246500401;1236.3262022197923;1236.783562876511;13570.253636049914;13736.519221827188;13838.377273022737;14154.646133846736;14194.716105677828;275084;277440;277990;278122;278237;60013;64832.35167648357;64949.67525162344;65110;65155;1533.9002964807476;1536.247238852954;1549.5816129644932;1553.642662187703;1567.9294431750598;30332.545011824397;31249.68755311557;31421.528677069404;31841.681583183872;32176;43395;43586;43590.346144808485;43597.346039810065;43687.78156109199;243522;245297;245586;246145;246210;38260.80869595746;38709.6129038706;39333.21333573255;39710.60289397069;40024.199516008935;47431.52568474271;49436.50563494319;49590.50409495859;49820.0071997116;50112.74943625258;35513;35555.11112222215;35707;36136.81931590325;36316;35428.29143417066;35494;35668.28663426665;35728.464073038405;35821.82089089538;41692.583074170085;42046;42152.156956860075;42324.36513452362;42481.787591061846;34229;34291;34307.65692343045;34319.656803431644;34385.484217737256;25527.489450211262;25717.3570660735;26121.73878261269;26261.34346641349;26394.86802566052 10:50:43 INFO - PID 2079 | |2;jquery.html;584.1092334190356;589.3870374810198;598.5929567893833;599.3916175082293;617.7837756785125;23106.537869242606;23633.64549531754;23800.40498987522;23827.642585361235;23885.16401925933;24101.51796964064;25064.248072557853;25237.74762252377;25271.368215794613;25818.35454113648;6338.619682819034;6502.447291980164;6507.251666058393;6508.088867558534;6515.31589183136;6372.617642941415;6413.6793160341795;6522.217333919936;6581.835454113638;6591.143151390313;6537.967310163443;6559.836004099888;6560.376764207416;6573.737050517973;6574.835629109262;6447.2907980122145;6490.675466226669;6522.869542609169;6534.575252608565;6549.148610680629;6132.846678833021;6140.355262697397;6143.354947730469;6157.969210153965;6165.136880836686;28973.56539651907;29957.850210749024;30084.69915300841;30470.542941855667;30484.8475757622;2193.5722534105857;2236.7651396603446;2239.3393948784983;2242.551489702066;2244.4276709438986;19676.70484942727;20045.79954200454;20249.29127480546;20310.695339569917;20333.389998300074;2461.8399804012683;2579.7678208961097;2590.559604867158;2620.9475810483873;2622.1740151852296;136375;139757;151378;156279;157184;15691.607709807118;16061.437849675205;16088.597785055466;16117.67764644724;16384.67230655404;25458.363540911625;25480.74519254821;25577.616335754978;25640.358991025;25785.742142578332;10698.946505267424;10770.515326810313;10795;10908.781824363468;10987.285826421257;9895.851562226573;9967.152792012615;9988.450635215133;10017.849732254022;10072.23735846224;9516.003278622857;9974.451405172786;10047.346922450017;10101.292909496266;10203.795924081476;2832.4759919414564;2836.716328367188;2918.5768063630653;2926.4978443430987;2969.693943781482;1048.7954848804563;1053.0575135254057;1056.3609016545033;1057.1965306367217;1067.7010437077631;20443.8977805113;21024;21036.789632103788;21228.78771212299;21411.8929405352;1126.5775334249656;1130.4856290387854;1133.6712353417581;1143.937083460401;1147.0708725932022;11353.26203796767;11515.654530364103;11564.363959982113;11623.476943537562;11658.300501969909;609919;617022;633076;660309;663816;121914;127810.36094819652;127839;128119;128681.35659321831;1123.393367581497;1173.5775120956448;1220.4507971412722;1261.0920137500984;1278.4886045581657;21682.024308906453;21940.232091876707;21966.121355146253;22152.889235554365;22290.331290061324;61580;61785;62261;63682;64053.67973160104;79958.20041799507;80393.19606803857;81053;81345;82050.58974705088;15445.304961276544;15736.763948540553;15772.132532710812;15809.525714228592;15838.841611583737;23836.16573419922;23864.284071477883;24248.393790155387;24390.75609243956;24629.753702462745;19761;19818.108185131416;19855.411567074887;19924.203031878562;20214.494637634176;17587.56031099233;17598.29606815713;17809.46571602854;18104.63790724152;18274.086295684898;19710.310139145062;20148.39554813358;20264.493387664836;20389.69415458799;20537.97310134517;15540.611484712972;15542.30059647296;15568.065916045074;15621.921890390475;15701.136437496047;19191.136398861807;19413.8058619412;19596.706049409557;19712.408627740617;19812.603747925248 10:50:43 INFO - PID 2079 | |3;mootools.html;1378.7449321875451;1443.7545617245066;1446.6961937993021;1464.4947493114878;1465.4065103633025;13911.791323130148;14456.927715361422;16753.581160470978;17197.656046879056;17223.655526889455;15608.063516189008;15944.601384965381;16062.919685401557;16360.672786544292;16410.67178656426;2612.93467663309;2762.958555621662;2834.588984597232;2835.8298502089942;2915.1983204618687;2906.767458603317;2921.868515916789;2930.58971743956;2931.2818359501953;2933.6186295781517;2731.399092199713;2775.6252905857655;2776.1532732516575;2779.7637200837953;2819.126070918022;2775.9722402776015;2776.4585905748386;2797.300674831282;2798.8320700758018;2803.817751846144;2746.5193591121474;2758.600002999574;2766.1563223216913;2769.8753556090023;2770.515159847039;16282.83717162837;16375.263113159936;16485.17574121289;16561.171941403;16572.917135414365;8411.83176336476;8741.475511469333;8750.168733970262;8758.56207189638;8775.517346545937;5605.887882242373;5849.532037436995;5908.6454812710945;5998.850028749316;6001.699915004276;2125.798049185325;2131.861429007125;2137.6900349449397;2218.0794970087395;2229.9888500557554;29866;29873.551896721565;29941.700582994108;29961;30061.398772024655;7144.499885008104;7255.09311336083;7297.416206703451;7401.48189626721;7622.695092196361;19762.20951161966;19780.109895054757;19785.40643780689;19811.60376792456;19838;8433.19884610961;8528.189821966904;8580.828383432421;8585.914140858637;8586.441881277697;6288.402601752826;6753;6825.795226143224;7654.923450765533;7860.253275938777;5687.829365119053;5817.127430885316;5846.356900740915;5860.3260625027815;5978.611390259619;1641.1958140511301;1684.4357140358118;1686.9493915182563;1690.1126908373203;1698.2782317515007;992.3153024413276;996.8255555277798;1008.3899240959261;1029.7477118106112;1031.9896801032044;8555.572221388906;8689.56552172389;8925.509096999727;8953.641854325884;8964.282857371525;805.5327909812295;808.7695006922999;817.5993763056059;818.3453237410048;820.5733018830294;5246.186841039645;5329.520343169133;5368.606491296191;5673.205751194836;5675.914861277084;24908;25425;25497.23508294754;25525.61711574291;25874.870625647127;24110;25260.368490787878;25388.238352849443;25452.49095018126;25467.98128074856;12489.750204996031;12539.122261441611;12551.811722824164;12573.93713031429;12592.055595830348;8909.509976951329;9014.459132452073;9031.593578288861;9042.547872606476;9115.270778337584;20824.791752082285;20884.269050583156;21595.568088638454;21658.67511987353;21872.125114995222;22056.669149963083;22079.116835326407;22131.557368852857;22437.32688019362;22760.658590121493;12475.500979961063;12676.985841132502;12680.11239213283;12685.556005540131;12696.555620553236;15453.227338633249;15640.296186671854;15713.921430392775;15801.051936883823;15885.682286353976;12502.312372819219;12581.308028058545;12801.743965120459;13010.089293749346;13128;11163.49764260594;11281.548738050715;11281.605143820256;11427.771444571228;11585.710357241136;11271.943640281746;11533;11547.538098475967;11553.711157221136;11564.363959981945;8284.627191776504;8411.53736544496;8513.702020429255;8538.957305213435;8605.139486051345;8446.704365347183;8581.098984606526;8610.182032706884;8614.396992210735;8650.826983460169 10:50:43 INFO - PID 2079 | |4;prototype.html;554.4787899374585;561.3824792727999;578.4967078641581;581.7585701933698;585.6837307853759;6235.968820155898;6275.152854364659;6277.403646653572;6344.968275158623;6364.777232796853;6221.129041934133;6223.782167624134;6231.6290416108495;6256.781012664557;6282.623042617446;5071.594272458195;5084.135696931512;5091.770870310845;5093.108705976458;5173.560247378959;5192.740362981855;5205.7397130143345;5221.556167725729;5222.164453687411;5269.920951185735;5160.380754309488;5192.039472697563;5255.237990491377;5261.158214685651;5261.316028916235;5257.474252574751;5260.500252476008;5265.498888028194;5266.8683282917855;5289.788408463657;4956.281339205831;4962.057209130254;4977.278294647256;4988.501149885019;5031.421386540522;6199.597026193283;6309.684515774239;6385.042243663441;6391.58454700443;6443.452306553949;6118.296395914483;6164.229471316085;6195.884740746664;6247.5939063960695;6266.467350275232;6791.966040169767;6818.352256535622;6839.350261725128;6839.452843772536;6871.278515755824;5275.736213189325;5494.972525137388;5569.916451253234;5574.219609254707;5643.661380317194;6804.21751498579;6811.863762724767;6866.931330686679;7092.219855815856;7105.467089968273;5689.459501347365;5729.369769325371;5734.483896449339;5736.139579063174;5747.48272655463;5765.135229715493;5821.243238379068;5849.415058494202;5877.617954832922;5915.438033386908;6191.504679625709;6215.943289640772;6231.813045608639;6250.562460627712;6290.433860952537;6828.385445309847;6838.452923766087;6848.1097457331225;6868.656567171622;6900.654967251618;1992.6512860249397;2004.518915460308;2020.3029954665617;2038.3782946201254;2043.3257025181654;1447.4499690117898;1483.703259348113;1498.2508745627185;1530.3572499550216;1552.192859712943;6126.816195514141;6223.688815559294;6256.687165641791;6325.58883672569;6326.177596912464;6601.636909969901;6655.0682904393425;6777.423918966844;6788.524803263724;6828.965855170792;6134.754609815646;6253.342864141006;6287.622742635456;6312.936870631327;6340.587861788969;3545.71634269263;3549.290141971616;3579.391503444421;3581.462780582933;3615.891523254307;6897.689603967833;6903.101647047002;6927.307269273032;7001.614911179832;7004.404625606779;6861.176658800976;6886.829239029377;6910.930890691129;6940.13248343957;7024.262452442522;7006.369426751617;7012.298770122947;7032.8593428130125;7032.8945065824055;7062.258462861429;6622.304658010839;6699.464042876461;6731.562448440835;6733.326667333227;6814.522983391314;6803.489738269748;6807.183138023469;6819.761308354184;6832.925183667469;6868.416184624363;7020.859582808417;7072.3634872861685;7075.398591119607;7124.964375178091;7132;5650.818394388041;5663.915041274467;5669.177969194526;5704.971475142598;5712.514436272797;6612;6725.865482690221;6819.215790183994;6819.420349270169;7024.1571011478945;6643.833904152435;6660.733570657119;6668.83327916806;6670.499712521678;6674.766383176566;6570.277269500447;6574.408303252731;6580.144581204413;6591.143151390289;6603.283146381879;6239.660127452205;6432.067350234283;6505.9915713062655;6522.934770652233;6559.770408035887;6654.334566543501;6673.899891501728;6694.330566943267;6695.397414232742;6788.796336109925;6434.8391290218115;6466.579672321284;6511.772087976898;6574.178227721535;6581.407673309233 10:50:43 INFO - PID 2079 | |5;yui.html;954.88063992001;973.7322236384994;992.2657233647103;995.6117114325415;998.6205242008036;20733.688994665074;21238.469038274052;21245.57508849822;21275.14899404024;21283.787162128374;19190.42428727137;19391.127399267032;19536.120874560642;19556.41330760076;19680;1040.921930855187;1076.0960792933934;1079.3469950679844;1080.2492267873831;1080.3733834376044;1049.3965969567491;1063.3832377221192;1073.09859717837;1073.5974009746344;1096.0792933935493;1134;1141.7202785317609;1144.3305666185292;1147.23708733692;1147.340279339379;1076.445630500293;1108.3294606762954;1134.0643968725792;1142.90285325747;1146.140394703972;809.5952023988006;819.573821612758;821.650798410679;822.1203312455675;822.8847961285425;21822.127114915384;21851.890740546194;21948.122075116975;21954.121835126574;22045.779542204695;22537.661935070988;22725.77274227253;23073.653895191586;23108;23125.421864453354;17589.912050439794;18154.092295385177;18263.269469221214;18334.174962126737;18461.907690461598;3852.171783066626;3855.3253180693546;3902.1025164212106;3907.5701672815967;3907.960920390788;155139;156670;157783;159891;161226.19386903106;17159.571010724583;17439.302427902996;17558.473245802645;17593.208305626278;17597.47207583749;34046.82976585101;34553.82723086369;34637.13407164791;34654.960351189504;34806.47790283148;8937.597808098652;8979.77550561228;8991.505467199368;9021.503817290111;9050;4792.209285467929;4846.079244943449;4854.320395144682;4863.3434486343895;4894.094592500399;6043.305019922677;6046.788362407295;6088.6042407243385;6090.147379366892;6105.511559075263;1149.1209224942925;1185.0934035462878;1198.688341031338;1200.4597930931116;1203.3020847908192;736.4292673178329;751.1774606805649;755.5844285642875;770.734096736625;773.6131934032984;13025.869741302655;13215.801762973562;13688.247146406844;14234.288285585679;14242.43030278798;728.8870225115115;735.3969744809312;738.4609235258184;745.1133151549747;746.0562388578453;6383.39357761012;6503.349665033459;6556.901646475307;6575.837967195728;6580.80257592273;147242;149599;150278;150896;153295;122560;131890;132676;133165;135173;115135;115940.42029789797;116415;118045.4097729523;118460.40769796095;14733.04235224707;15200.843772698638;15211.239438028275;15465.840061995621;15478.690426191639;52555.47444525506;52742;52998;53107;53581.19628205658;68654;68845.65577172082;68873;69935.6503217501;71669.6416517914;19928;20359;20496.18015279372;20624.896875515526;20629.58740825205;20190;20237.79762202359;20374.18503259912;20408.18367265293;20676.68984965257;21569.24507642225;21815.781842181375;21906.23328183506;21937;22044.559108818055;18191.09044547741;18234.36179733756;18260.634787303912;18444.723329149805;18694.906525467286;18685.719714204028;18746.71879921775;18987.71518427252;19225.711614326076;19304.710429343853;15153;15253.16107614092;15393.153376564396;15732.370705172123;15797.289121989308;13841.653958651113;13848.723025539633;13931.442742290601;13977.371018303997;13995.370208340446 10:50:43 INFO - PID 2079 | __end_tp_report 10:50:43 INFO - PID 2079 | __start_cc_report 10:50:43 INFO - PID 2079 | _x_x_mozilla_cycle_collect,338 10:50:43 INFO - PID 2079 | __end_cc_report 10:50:43 INFO - PID 2079 | __startTimestamp1505411443644__endTimestamp 10:50:43 INFO - PID 2079 | 10:50:43 INFO - PID 2079 | ------- Summary: start ------- 10:50:43 INFO - PID 2079 | Number of tests: 6 10:50:43 INFO - PID 2079 | 10:50:43 INFO - PID 2079 | [#0] dojo.html Cycles:165 Average:6300.23 Median:6553.57 stddev:751.99 (11.5%) stddev-sans-first:729.06 10:50:43 INFO - PID 2079 | Values: 3837.8 3864.3 3903.4 3928.9 3940.6 6244.4 6286.5 6338.7 6361.7 6404.8 6295.8 6366.1 6369.8 6372.1 6383.2 5616.1 5636.5 5644.1 5654.9 5719.0 5682.1 5723.2 5738.2 5766.3 5789.4 5623.8 5632.6 5686.0 5715.9 5719.5 5474.8 5569.2 5574.6 5627.1 5633.0 5529.5 5539.1 5611.0 5611.4 5627.8 6160.8 6216.3 6292.1 6295.3 6298.1 6766.2 6814.1 6820.6 6824.7 6835.2 6878.5 6880.6 6880.7 6886.6 6887.2 6351.0 6380.9 6432.2 6464.7 6471.6 6902.1 7000.9 7071.8 7091.8 7092.4 6707.9 6713.5 6755.2 6799.3 6813.5 6799.4 6857.8 6907.4 6916.0 6949.8 6832.1 6870.7 6881.6 6906.0 6923.2 6801.9 6881.7 6888.0 6896.8 6930.0 4973.1 5004.0 5033.9 5069.9 5074.9 4441.4 4502.8 4508.6 4516.4 4599.9 6353.5 6395.5 6448.7 6454.5 6471.2 6821.5 6844.6 6853.9 6856.0 6952.4 6295.2 6397.6 6418.2 6433.2 6453.2 5542.0 5561.7 5565.2 5571.0 5571.0 7114.5 7122.0 7208.2 7210.5 7244.9 6705.8 6708.2 6798.2 6798.3 6810.0 6978.4 7035.3 7093.1 7127.4 7133.8 6725.9 6766.1 6767.2 6777.5 6799.6 6673.4 6758.6 6771.1 6773.4 6850.7 6611.5 6621.6 6631.4 6658.7 6660.7 6563.2 6573.7 6643.3 6649.4 6656.5 6452.0 6516.9 6530.1 6596.5 6603.3 6622.2 6646.3 6655.1 6680.9 6723.7 6418.5 6465.6 6465.9 6529.6 6553.6 10:50:43 INFO - PID 2079 | 10:50:43 INFO - PID 2079 | [#1] ext.html Cycles:180 Average:43400.52 Median:21287.38 stddev:63795.74 (299.7%) stddev-sans-first:63895.02 10:50:43 INFO - PID 2079 | Values: 937.0 945.8 956.2 991.7 994.5 44358.6 45495.5 45508.1 45573.0 45582.3 46030.5 46873.0 46923.5 46936.8 46967.0 7927.9 8002.5 8004.7 8033.9 8065.0 8373.0 8449.0 8479.7 8500.0 8508.7 8467.7 8498.1 8535.4 8539.4 8545.7 8420.0 8504.4 8508.4 8508.5 8511.5 8289.0 8309.0 8324.8 8351.0 8354.7 41070.0 41470.6 41521.4 41684.6 41775.8 3796.9 3847.2 3854.0 3860.4 3865.1 33901.5 33949.7 33998.5 34028.0 34053.0 5414.3 5546.0 5556.3 5562.8 5612.5 208059.0 208836.0 209454.0 209545.0 209733.0 52571.7 52718.2 52751.7 52839.7 56116.0 58857.0 58951.7 59029.9 59068.0 59086.0 15569.9 15742.7 15750.4 15754.5 15759.7 14104.2 14268.1 14294.8 14299.9 14300.2 16510.0 16603.8 16628.8 16711.9 16753.2 6229.9 6312.8 6327.4 6388.7 6570.7 1098.8 1100.9 1111.8 1114.7 1117.1 26194.7 26218.5 26264.7 26398.2 26513.2 1220.4 1221.6 1235.5 1236.3 1236.8 13570.3 13736.5 13838.4 14154.6 14194.7 275084.0 277440.0 277990.0 278122.0 278237.0 60013.0 64832.4 64949.7 65110.0 65155.0 1533.9 1536.2 1549.6 1553.6 1567.9 30332.5 31249.7 31421.5 31841.7 32176.0 43395.0 43586.0 43590.3 43597.3 43687.8 243522.0 245297.0 245586.0 246145.0 246210.0 38260.8 38709.6 39333.2 39710.6 40024.2 47431.5 49436.5 49590.5 49820.0 50112.7 35513.0 35555.1 35707.0 36136.8 36316.0 35428.3 35494.0 35668.3 35728.5 35821.8 41692.6 42046.0 42152.2 42324.4 42481.8 34229.0 34291.0 34307.7 34319.7 34385.5 25527.5 25717.4 26121.7 26261.3 26394.9 10:50:43 INFO - PID 2079 | 10:50:43 INFO - PID 2079 | [#2] jquery.html Cycles:180 Average:40510.22 Median:12263.55 stddev:106121.82 (865.3%) stddev-sans-first:106377.17 10:50:43 INFO - PID 2079 | Values: 584.1 589.4 598.6 599.4 617.8 23106.5 23633.6 23800.4 23827.6 23885.2 24101.5 25064.2 25237.7 25271.4 25818.4 6338.6 6502.4 6507.3 6508.1 6515.3 6372.6 6413.7 6522.2 6581.8 6591.1 6538.0 6559.8 6560.4 6573.7 6574.8 6447.3 6490.7 6522.9 6534.6 6549.1 6132.8 6140.4 6143.4 6158.0 6165.1 28973.6 29957.9 30084.7 30470.5 30484.8 2193.6 2236.8 2239.3 2242.6 2244.4 19676.7 20045.8 20249.3 20310.7 20333.4 2461.8 2579.8 2590.6 2620.9 2622.2 136375.0 139757.0 151378.0 156279.0 157184.0 15691.6 16061.4 16088.6 16117.7 16384.7 25458.4 25480.7 25577.6 25640.4 25785.7 10698.9 10770.5 10795.0 10908.8 10987.3 9895.9 9967.2 9988.5 10017.8 10072.2 9516.0 9974.5 10047.3 10101.3 10203.8 2832.5 2836.7 2918.6 2926.5 2969.7 1048.8 1053.1 1056.4 1057.2 1067.7 20443.9 21024.0 21036.8 21228.8 21411.9 1126.6 1130.5 1133.7 1143.9 1147.1 11353.3 11515.7 11564.4 11623.5 11658.3 609919.0 617022.0 633076.0 660309.0 663816.0 121914.0 127810.4 127839.0 128119.0 128681.4 1123.4 1173.6 1220.5 1261.1 1278.5 21682.0 21940.2 21966.1 22152.9 22290.3 61580.0 61785.0 62261.0 63682.0 64053.7 79958.2 80393.2 81053.0 81345.0 82050.6 15445.3 15736.8 15772.1 15809.5 15838.8 23836.2 23864.3 24248.4 24390.8 24629.8 19761.0 19818.1 19855.4 19924.2 20214.5 17587.6 17598.3 17809.5 18104.6 18274.1 19710.3 20148.4 20264.5 20389.7 20538.0 15540.6 15542.3 15568.1 15621.9 15701.1 19191.1 19413.8 19596.7 19712.4 19812.6 10:50:43 INFO - PID 2079 | 10:50:43 INFO - PID 2079 | [#3] mootools.html Cycles:180 Average:10384.21 Median:2752.56 stddev:7694.87 (279.6%) stddev-sans-first:7686.71 10:50:43 INFO - PID 2079 | Values: 1378.7 1443.8 1446.7 1464.5 1465.4 13911.8 14456.9 16753.6 17197.7 17223.7 15608.1 15944.6 16062.9 16360.7 16410.7 2612.9 2763.0 2834.6 2835.8 2915.2 2906.8 2921.9 2930.6 2931.3 2933.6 2731.4 2775.6 2776.2 2779.8 2819.1 2776.0 2776.5 2797.3 2798.8 2803.8 2746.5 2758.6 2766.2 2769.9 2770.5 16282.8 16375.3 16485.2 16561.2 16572.9 8411.8 8741.5 8750.2 8758.6 8775.5 5605.9 5849.5 5908.6 5998.9 6001.7 2125.8 2131.9 2137.7 2218.1 2230.0 29866.0 29873.6 29941.7 29961.0 30061.4 7144.5 7255.1 7297.4 7401.5 7622.7 19762.2 19780.1 19785.4 19811.6 19838.0 8433.2 8528.2 8580.8 8585.9 8586.4 6288.4 6753.0 6825.8 7654.9 7860.3 5687.8 5817.1 5846.4 5860.3 5978.6 1641.2 1684.4 1686.9 1690.1 1698.3 992.3 996.8 1008.4 1029.7 1032.0 8555.6 8689.6 8925.5 8953.6 8964.3 805.5 808.8 817.6 818.3 820.6 5246.2 5329.5 5368.6 5673.2 5675.9 24908.0 25425.0 25497.2 25525.6 25874.9 24110.0 25260.4 25388.2 25452.5 25468.0 12489.8 12539.1 12551.8 12573.9 12592.1 8909.5 9014.5 9031.6 9042.5 9115.3 20824.8 20884.3 21595.6 21658.7 21872.1 22056.7 22079.1 22131.6 22437.3 22760.7 12475.5 12677.0 12680.1 12685.6 12696.6 15453.2 15640.3 15713.9 15801.1 15885.7 12502.3 12581.3 12801.7 13010.1 13128.0 11163.5 11281.5 11281.6 11427.8 11585.7 11271.9 11533.0 11547.5 11553.7 11564.4 8284.6 8411.5 8513.7 8539.0 8605.1 8446.7 8581.1 8610.2 8614.4 8650.8 10:50:43 INFO - PID 2079 | 10:50:43 INFO - PID 2079 | [#4] prototype.html Cycles:180 Average:5796.67 Median:6300.06 stddev:1540.65 (24.5%) stddev-sans-first:1493.89 10:50:43 INFO - PID 2079 | Values: 554.5 561.4 578.5 581.8 585.7 6236.0 6275.2 6277.4 6345.0 6364.8 6221.1 6223.8 6231.6 6256.8 6282.6 5071.6 5084.1 5091.8 5093.1 5173.6 5192.7 5205.7 5221.6 5222.2 5269.9 5160.4 5192.0 5255.2 5261.2 5261.3 5257.5 5260.5 5265.5 5266.9 5289.8 4956.3 4962.1 4977.3 4988.5 5031.4 6199.6 6309.7 6385.0 6391.6 6443.5 6118.3 6164.2 6195.9 6247.6 6266.5 6792.0 6818.4 6839.4 6839.5 6871.3 5275.7 5495.0 5569.9 5574.2 5643.7 6804.2 6811.9 6866.9 7092.2 7105.5 5689.5 5729.4 5734.5 5736.1 5747.5 5765.1 5821.2 5849.4 5877.6 5915.4 6191.5 6215.9 6231.8 6250.6 6290.4 6828.4 6838.5 6848.1 6868.7 6900.7 1992.7 2004.5 2020.3 2038.4 2043.3 1447.4 1483.7 1498.3 1530.4 1552.2 6126.8 6223.7 6256.7 6325.6 6326.2 6601.6 6655.1 6777.4 6788.5 6829.0 6134.8 6253.3 6287.6 6312.9 6340.6 3545.7 3549.3 3579.4 3581.5 3615.9 6897.7 6903.1 6927.3 7001.6 7004.4 6861.2 6886.8 6910.9 6940.1 7024.3 7006.4 7012.3 7032.9 7032.9 7062.3 6622.3 6699.5 6731.6 6733.3 6814.5 6803.5 6807.2 6819.8 6832.9 6868.4 7020.9 7072.4 7075.4 7125.0 7132.0 5650.8 5663.9 5669.2 5705.0 5712.5 6612.0 6725.9 6819.2 6819.4 7024.2 6643.8 6660.7 6668.8 6670.5 6674.8 6570.3 6574.4 6580.1 6591.1 6603.3 6239.7 6432.1 6506.0 6522.9 6559.8 6654.3 6673.9 6694.3 6695.4 6788.8 6434.8 6466.6 6511.8 6574.2 6581.4 10:50:43 INFO - PID 2079 | 10:50:43 INFO - PID 2079 | [#5] yui.html Cycles:180 Average:28667.24 Median:20059.00 stddev:42029.90 (209.5%) stddev-sans-first:42096.30 10:50:43 INFO - PID 2079 | Values: 954.9 973.7 992.3 995.6 998.6 20733.7 21238.5 21245.6 21275.1 21283.8 19190.4 19391.1 19536.1 19556.4 19680.0 1040.9 1076.1 1079.3 1080.2 1080.4 1049.4 1063.4 1073.1 1073.6 1096.1 1134.0 1141.7 1144.3 1147.2 1147.3 1076.4 1108.3 1134.1 1142.9 1146.1 809.6 819.6 821.7 822.1 822.9 21822.1 21851.9 21948.1 21954.1 22045.8 22537.7 22725.8 23073.7 23108.0 23125.4 17589.9 18154.1 18263.3 18334.2 18461.9 3852.2 3855.3 3902.1 3907.6 3908.0 155139.0 156670.0 157783.0 159891.0 161226.2 17159.6 17439.3 17558.5 17593.2 17597.5 34046.8 34553.8 34637.1 34655.0 34806.5 8937.6 8979.8 8991.5 9021.5 9050.0 4792.2 4846.1 4854.3 4863.3 4894.1 6043.3 6046.8 6088.6 6090.1 6105.5 1149.1 1185.1 1198.7 1200.5 1203.3 736.4 751.2 755.6 770.7 773.6 13025.9 13215.8 13688.2 14234.3 14242.4 728.9 735.4 738.5 745.1 746.1 6383.4 6503.3 6556.9 6575.8 6580.8 147242.0 149599.0 150278.0 150896.0 153295.0 122560.0 131890.0 132676.0 133165.0 135173.0 115135.0 115940.4 116415.0 118045.4 118460.4 14733.0 15200.8 15211.2 15465.8 15478.7 52555.5 52742.0 52998.0 53107.0 53581.2 68654.0 68845.7 68873.0 69935.7 71669.6 19928.0 20359.0 20496.2 20624.9 20629.6 20190.0 20237.8 20374.2 20408.2 20676.7 21569.2 21815.8 21906.2 21937.0 22044.6 18191.1 18234.4 18260.6 18444.7 18694.9 18685.7 18746.7 18987.7 19225.7 19304.7 15153.0 15253.2 15393.2 15732.4 15797.3 13841.7 13848.7 13931.4 13977.4 13995.4 10:50:43 INFO - PID 2079 | -------- Summary: end -------- 10:50:43 INFO - PID 2079 | 10:50:44 INFO - TEST-INFO | 2079: exit 0 10:50:44 INFO - TEST-OK | dromaeo_css | took 1109577ms 10:50:44 INFO - TEST-START | kraken 10:50:44 INFO - Initialising browser for kraken test... 10:50:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46958/getInfo.html -profile /tmp/tmpwCo4pY/profile 10:50:44 INFO - TEST-INFO | started process 2448 (/builds/slave/test/build/application/firefox/firefox http://localhost:46958/getInfo.html) 10:50:50 INFO - TEST-INFO | 2448: exit 0 10:50:50 INFO - Browser initialized. 10:50:50 INFO - Running cycle 1/1 for kraken test... 10:50:50 INFO - Using env: {'DISPLAY': ':0', 10:50:50 INFO - 'HOME': '/home/cltbld', 10:50:50 INFO - 'JSGC_DISABLE_POISONING': '1', 10:50:50 INFO - 'LANG': 'en_US.UTF-8', 10:50:50 INFO - 'LANGUAGE': 'en_US:en', 10:50:50 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:50:50 INFO - 'LOGNAME': 'cltbld', 10:50:50 INFO - 'MAIL': '/var/mail/cltbld', 10:50:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:50:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:50:50 INFO - 'MOZ_CRASHREPORTER': '1', 10:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:50 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:50:50 INFO - 'MOZ_NO_REMOTE': '1', 10:50:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:50 INFO - 'NO_EM_RESTART': '1', 10:50:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:50 INFO - 'PWD': '/builds/slave/test', 10:50:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:50:50 INFO - 'RUST_BACKTRACE': 'full', 10:50:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:50:50 INFO - 'SHELL': '/bin/bash', 10:50:50 INFO - 'SHLVL': '1', 10:50:50 INFO - 'STYLO_FORCE_DISABLED': '1', 10:50:50 INFO - 'TERM': 'linux', 10:50:50 INFO - 'TMOUT': '86400', 10:50:50 INFO - 'USER': 'cltbld', 10:50:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573', 10:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:50 INFO - '_': '/tools/buildbot/bin/python'} 10:50:50 INFO - TEST-INFO | started process 2776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwCo4pY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:50:51 INFO - PID 2776 | 10:50:51 INFO - PID 2776 | (/builds/slave/test/build/application/firefox/firefox:2826): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:50:51 INFO - PID 2776 | 10:51:01 INFO - PID 2776 | RSS: Main: 163725312 10:51:01 INFO - PID 2776 | 10:51:04 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46958/tests/kraken/driver.html?testName=audio-beat-detection) 10:51:05 INFO - PID 2776 | RSS: Main: 168185856 10:51:05 INFO - PID 2776 | 10:51:07 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46958/tests/kraken/driver.html?testName=audio-dft) 10:51:08 INFO - PID 2776 | RSS: Main: 168943616 10:51:08 INFO - PID 2776 | 10:51:11 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46958/tests/kraken/driver.html?testName=audio-fft) 10:51:11 INFO - PID 2776 | RSS: Main: 164667392 10:51:11 INFO - PID 2776 | 10:51:13 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46958/tests/kraken/driver.html?testName=audio-oscillator) 10:51:14 INFO - PID 2776 | RSS: Main: 165670912 10:51:14 INFO - PID 2776 | 10:51:16 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46958/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:51:17 INFO - PID 2776 | RSS: Main: 165490688 10:51:17 INFO - PID 2776 | 10:51:20 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46958/tests/kraken/driver.html?testName=imaging-darkroom) 10:51:20 INFO - PID 2776 | RSS: Main: 165691392 10:51:20 INFO - PID 2776 | 10:51:24 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46958/tests/kraken/driver.html?testName=imaging-desaturate) 10:51:25 INFO - PID 2776 | RSS: Main: 168726528 10:51:25 INFO - PID 2776 | 10:51:27 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46958/tests/kraken/driver.html?testName=json-parse-financial) 10:51:28 INFO - PID 2776 | RSS: Main: 168730624 10:51:28 INFO - PID 2776 | 10:51:30 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46958/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:51:30 INFO - PID 2776 | RSS: Main: 168943616 10:51:30 INFO - PID 2776 | 10:51:32 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46958/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:51:32 INFO - PID 2776 | RSS: Main: 168681472 10:51:32 INFO - PID 2776 | 10:51:34 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46958/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:51:35 INFO - PID 2776 | RSS: Main: 165371904 10:51:35 INFO - PID 2776 | 10:51:37 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:51:38 INFO - PID 2776 | RSS: Main: 166039552 10:51:38 INFO - PID 2776 | 10:51:41 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:51:41 INFO - PID 2776 | RSS: Main: 166477824 10:51:41 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | Cycle 1(1): loaded http://localhost:46958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46958/tests/kraken/driver.html?testName=ai-astar) 10:51:43 INFO - PID 2776 | RSS: Main: 168001536 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | __start_tp_report 10:51:43 INFO - PID 2776 | _x_x_mozilla_page_load 10:51:43 INFO - PID 2776 | _x_x_mozilla_page_load_details 10:51:43 INFO - PID 2776 | |i|pagename|runs| 10:51:43 INFO - PID 2776 | |0;ai-astar;105;108;104;105;106;105;107;103;106;106 10:51:43 INFO - PID 2776 | |1;audio-beat-detection;118;119;113;112;113;112;115;114;112;111 10:51:43 INFO - PID 2776 | |2;audio-dft;161;161;161;163;161;166;162;161;165;169 10:51:43 INFO - PID 2776 | |3;audio-fft;73;74;77;75;75;75;77;75;73;73 10:51:43 INFO - PID 2776 | |4;audio-oscillator;77;79;88;78;78;78;79;79;79;78 10:51:43 INFO - PID 2776 | |5;imaging-gaussian-blur;114;114;117;114;113;117;114;115;114;111 10:51:43 INFO - PID 2776 | |6;imaging-darkroom;150;150;149;149;150;149;150;149;150;154 10:51:43 INFO - PID 2776 | |7;imaging-desaturate;99;98;93;98;98;94;96;93;94;94 10:51:43 INFO - PID 2776 | |8;json-parse-financial;44;44;44;49;45;47;47;44;46;45 10:51:43 INFO - PID 2776 | |9;json-stringify-tinderbox;38;38;38;38;38;37;38;38;38;38 10:51:43 INFO - PID 2776 | |10;stanford-crypto-aes;72;71;72;75;72;72;88;72;72;72 10:51:43 INFO - PID 2776 | |11;stanford-crypto-ccm;106;104;105;104;105;104;105;103;109;104 10:51:43 INFO - PID 2776 | |12;stanford-crypto-pbkdf2;161;155;155;163;161;154;159;156;151;153 10:51:43 INFO - PID 2776 | |13;stanford-crypto-sha256-iterative;64;61;58;60;58;62;58;61;58;61 10:51:43 INFO - PID 2776 | __end_tp_report 10:51:43 INFO - PID 2776 | __start_cc_report 10:51:43 INFO - PID 2776 | _x_x_mozilla_cycle_collect,888 10:51:43 INFO - PID 2776 | __end_cc_report 10:51:43 INFO - PID 2776 | __startTimestamp1505411503896__endTimestamp 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | ------- Summary: start ------- 10:51:43 INFO - PID 2776 | Number of tests: 14 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#0] ai-astar Cycles:10 Average:105.50 Median:106.00 stddev:1.43 (1.4%) stddev-sans-first:1.51 10:51:43 INFO - PID 2776 | Values: 105.0 108.0 104.0 105.0 106.0 105.0 107.0 103.0 106.0 106.0 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#1] audio-beat-detection Cycles:10 Average:113.90 Median:113.50 stddev:2.69 (2.4%) stddev-sans-first:2.40 10:51:43 INFO - PID 2776 | Values: 118.0 119.0 113.0 112.0 113.0 112.0 115.0 114.0 112.0 111.0 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.79 (1.7%) stddev-sans-first:2.86 10:51:43 INFO - PID 2776 | Values: 161.0 161.0 161.0 163.0 161.0 166.0 162.0 161.0 165.0 169.0 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#3] audio-fft Cycles:10 Average:74.70 Median:75.00 stddev:1.49 (2.0%) stddev-sans-first:1.45 10:51:43 INFO - PID 2776 | Values: 73.0 74.0 77.0 75.0 75.0 75.0 77.0 75.0 73.0 73.0 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:79.00 stddev:3.13 (4.0%) stddev-sans-first:3.21 10:51:43 INFO - PID 2776 | Values: 77.0 79.0 88.0 78.0 78.0 78.0 79.0 79.0 79.0 78.0 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.77 (1.5%) stddev-sans-first:1.87 10:51:43 INFO - PID 2776 | Values: 114.0 114.0 117.0 114.0 113.0 117.0 114.0 115.0 114.0 111.0 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:1.49 (1.0%) stddev-sans-first:1.58 10:51:43 INFO - PID 2776 | Values: 150.0 150.0 149.0 149.0 150.0 149.0 150.0 149.0 150.0 154.0 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:97.00 stddev:2.36 (2.4%) stddev-sans-first:2.18 10:51:43 INFO - PID 2776 | Values: 99.0 98.0 93.0 98.0 98.0 94.0 96.0 93.0 94.0 94.0 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#8] json-parse-financial Cycles:10 Average:45.50 Median:45.50 stddev:1.72 (3.8%) stddev-sans-first:1.73 10:51:43 INFO - PID 2776 | Values: 44.0 44.0 44.0 49.0 45.0 47.0 47.0 44.0 46.0 45.0 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#9] json-stringify-tinderbox Cycles:10 Average:37.90 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 10:51:43 INFO - PID 2776 | Values: 38.0 38.0 38.0 38.0 38.0 37.0 38.0 38.0 38.0 38.0 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:72.00 stddev:5.09 (7.1%) stddev-sans-first:5.36 10:51:43 INFO - PID 2776 | Values: 72.0 71.0 72.0 75.0 72.0 72.0 88.0 72.0 72.0 72.0 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#11] stanford-crypto-ccm Cycles:10 Average:104.90 Median:105.00 stddev:1.66 (1.6%) stddev-sans-first:1.72 10:51:43 INFO - PID 2776 | Values: 106.0 104.0 105.0 104.0 105.0 104.0 105.0 103.0 109.0 104.0 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:157.50 stddev:3.97 (2.5%) stddev-sans-first:3.91 10:51:43 INFO - PID 2776 | Values: 161.0 155.0 155.0 163.0 161.0 154.0 159.0 156.0 151.0 153.0 10:51:43 INFO - PID 2776 | 10:51:43 INFO - PID 2776 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:61.00 stddev:2.08 (3.4%) stddev-sans-first:1.66 10:51:43 INFO - PID 2776 | Values: 64.0 61.0 58.0 60.0 58.0 62.0 58.0 61.0 58.0 61.0 10:51:43 INFO - PID 2776 | -------- Summary: end -------- 10:51:43 INFO - PID 2776 | 10:51:44 INFO - PID 2776 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:51:44 INFO - TEST-INFO | 2776: exit 0 10:51:44 INFO - TEST-OK | kraken | took 60301ms 10:51:44 INFO - SUITE-END | took 1169s 10:51:45 INFO - Completed test suite (00:19:30) 10:51:45 INFO - javascript benchmark 10:51:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9215.44621113441, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3837.80810959452, 3864.343061679514, 3903.4340020697, 3928.901777455563, 3940.5665376808547, 6244.375562443754, 6286.497080233582, 6338.714757835897, 6361.650109243989, 6404.839879003027, 6295.779647712331, 6366.108744775735, 6369.840753981152, 6372.139761132245, 6383.170187875581, 5616.101423772197, 5636.549076073904, 5644.068728659766, 5654.9151762723595, 5719.027765279912, 5682.147677848335, 5723.198752174699, 5738.196652468637, 5766.336871259796, 5789.39211382805, 5623.80316688916, 5632.605717599769, 5686.0, 5715.914261286084, 5719.513841323493, 5474.835754927359, 5569.192467092289, 5574.60977731559, 5627.127795191752, 5632.971835140839, 5529.502344788948, 5539.113741801333, 5610.971945140289, 5611.3546942101775, 5627.831165065055, 6160.815175544741, 6216.347283535209, 6292.056191571255, 6295.276043254993, 6298.086777417295, 6766.15423072116, 6814.1482314710665, 6820.556663816886, 6824.727010919557, 6835.213950395719, 6878.484113691443, 6880.552764070369, 6880.65596720162, 6886.552374095718, 6887.242403335679, 6351.0, 6380.872382552323, 6432.228132624068, 6464.709088091, 6471.579347342407, 6902.137232845895, 7000.894986575206, 7071.752488662872, 7091.751788687371, 7092.397146242524, 6707.899381509281, 6713.496487763339, 6755.1556055493065, 6799.3200679931615, 6813.523053386314, 6799.388055075067, 6857.759978400732, 6907.447404207652, 6915.962605609199, 6949.826254343682, 6832.145981752281, 6870.690818913161, 6881.587104773729, 6906.0, 6923.169219693669, 6801.897971530431, 6881.690323935435, 6888.0, 6896.827579310558, 6930.029795828588, 4973.079980203674, 5003.974980125149, 5033.874153146201, 5069.923951140736, 5074.873128171751, 4441.422615060022, 4502.819887204475, 4508.639308855284, 4516.36770852081, 4599.862004139881, 6353.459955903708, 6395.488360931115, 6448.677566121769, 6454.483641308684, 6471.2234531856475, 6821.4542836572955, 6844.589324640538, 6853.862922741518, 6856.0, 6952.409045231111, 6295.150154729145, 6397.584157029778, 6418.19772528434, 6433.195850518685, 6453.193350831146, 5542.0301447247375, 5561.749721262553, 5565.16522521625, 5571.0, 5571.025070612626, 7114.537555058904, 7122.03852479919, 7208.207097219407, 7210.531315464478, 7244.855102897913, 6705.798826035227, 6708.22855371619, 6798.184217893884, 6798.286179951034, 6809.965950170217, 6978.441724661913, 7035.296470352924, 7093.077899872984, 7127.394171495481, 7133.750318738819, 6725.932740672531, 6766.120404347404, 6767.1879374475375, 6777.457803375817, 6799.626020568916, 6673.366030227121, 6758.594484330956, 6771.052052712723, 6773.356531129535, 6850.6574671267235, 6611.537192396486, 6621.569597976116, 6631.403173714389, 6658.667066646552, 6660.733570657119, 6563.245226798788, 6573.737050517926, 6643.335666433318, 6649.434798042027, 6656.5340426169705, 6452.0, 6516.934830651633, 6530.118434011348, 6596.472282217315, 6603.339666033358, 6622.205335359788, 6646.302138275411, 6655.068290439245, 6680.866382672417, 6723.697433615401, 6418.486521078209, 6465.612063276219, 6465.903011454738, 6529.608223506605, 6553.574017688835], "value": 6248.77039771599, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [936.9999999999998, 945.763559110222, 956.1872408452814, 991.6777047459568, 994.4828689081673, 44358.55641443584, 45495.545044549624, 45508.0898382033, 45573.0, 45582.316265256006, 46030.539694603045, 46873.0, 46923.53076469234, 46936.765316173456, 46967.0, 7927.8810817837775, 8002.479838810488, 8004.719834805783, 8033.919660803404, 8064.959675201616, 8373.0, 8448.957755211215, 8479.703210387637, 8500.0, 8508.659653613848, 8467.703630372938, 8498.107698691641, 8535.402521823475, 8539.444936079135, 8545.74362769118, 8420.0, 8504.404691671616, 8508.36187285953, 8508.489490630582, 8511.489310641382, 8289.04675962266, 8309.044459887129, 8324.83350332996, 8350.958245208734, 8354.665813367457, 41070.0, 41470.58529414728, 41521.37717934234, 41684.58315416837, 41775.7911210445, 3796.9430458543143, 3847.2305538892333, 3854.0, 3860.4209368594657, 3865.1496670732677, 33901.49147762785, 33949.660503394894, 33998.49002264968, 34028.0, 34053.0, 5414.3232095988005, 5546.029444847136, 5556.305461817273, 5562.7774889004395, 5612.466815652507, 208058.9999999985, 208836.0, 209454.0, 209545.0, 209733.0, 52571.737141314814, 52718.209226861625, 52751.73624131932, 52839.73580132152, 56116.0, 58857.0, 58951.705241473515, 59029.93395231146, 59068.0, 59086.0, 15569.922150389402, 15742.685146297239, 15750.369985200692, 15754.527364178864, 15759.68480630381, 14104.224267665377, 14268.072575282573, 14294.785578216335, 14299.857001429853, 14300.213488258038, 16510.0, 16603.83396166047, 16628.750568741478, 16711.91644041772, 16753.246103925354, 6229.937700623026, 6312.842178945563, 6327.3988971047675, 6388.744450221939, 6570.704318305688, 1098.758273179899, 1100.9284396514201, 1111.8499002634703, 1114.7157474843864, 1117.100733909211, 26194.73805261961, 26218.475630487665, 26264.737352626613, 26398.20805375842, 26513.204603861916, 1220.3776074202221, 1221.6151912147823, 1235.4502246500401, 1236.3262022197923, 1236.783562876511, 13570.253636049914, 13736.519221827188, 13838.377273022737, 14154.646133846736, 14194.716105677828, 275084.0, 277440.0, 277990.0, 278122.0, 278237.0, 60013.0, 64832.35167648357, 64949.67525162344, 65110.0, 65155.0, 1533.9002964807476, 1536.247238852954, 1549.5816129644932, 1553.642662187703, 1567.9294431750598, 30332.545011824397, 31249.68755311557, 31421.528677069404, 31841.681583183872, 32176.0, 43395.0, 43586.0, 43590.346144808485, 43597.346039810065, 43687.78156109199, 243522.0, 245297.0, 245586.0, 246145.0, 246210.0, 38260.80869595746, 38709.6129038706, 39333.21333573255, 39710.60289397069, 40024.199516008935, 47431.52568474271, 49436.50563494319, 49590.50409495859, 49820.0071997116, 50112.74943625258, 35513.0, 35555.11112222215, 35707.0, 36136.81931590325, 36316.0, 35428.29143417066, 35494.0, 35668.28663426665, 35728.464073038405, 35821.82089089538, 41692.583074170085, 42046.0, 42152.156956860075, 42324.36513452362, 42481.787591061846, 34229.0, 34291.0, 34307.65692343045, 34319.656803431644, 34385.484217737256, 25527.489450211262, 25717.3570660735, 26121.73878261269, 26261.34346641349, 26394.86802566052], "value": 19231.817384687656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.1092334190356, 589.3870374810198, 598.5929567893833, 599.3916175082293, 617.7837756785125, 23106.537869242606, 23633.64549531754, 23800.40498987522, 23827.642585361235, 23885.16401925933, 24101.51796964064, 25064.248072557853, 25237.74762252377, 25271.368215794613, 25818.35454113648, 6338.619682819034, 6502.447291980164, 6507.251666058393, 6508.088867558534, 6515.31589183136, 6372.617642941415, 6413.6793160341795, 6522.217333919936, 6581.835454113638, 6591.143151390313, 6537.967310163443, 6559.836004099888, 6560.376764207416, 6573.737050517973, 6574.835629109262, 6447.2907980122145, 6490.675466226669, 6522.869542609169, 6534.575252608565, 6549.148610680629, 6132.846678833021, 6140.355262697397, 6143.354947730469, 6157.969210153965, 6165.136880836686, 28973.56539651907, 29957.850210749024, 30084.69915300841, 30470.542941855667, 30484.8475757622, 2193.5722534105857, 2236.7651396603446, 2239.3393948784983, 2242.551489702066, 2244.4276709438986, 19676.70484942727, 20045.79954200454, 20249.29127480546, 20310.695339569917, 20333.389998300074, 2461.8399804012683, 2579.7678208961097, 2590.559604867158, 2620.9475810483873, 2622.1740151852296, 136375.0, 139757.0, 151378.0, 156279.0, 157184.0, 15691.607709807118, 16061.437849675205, 16088.597785055466, 16117.67764644724, 16384.67230655404, 25458.363540911625, 25480.74519254821, 25577.616335754978, 25640.358991025, 25785.742142578332, 10698.946505267424, 10770.515326810313, 10795.0, 10908.781824363468, 10987.285826421257, 9895.851562226573, 9967.152792012615, 9988.450635215133, 10017.849732254022, 10072.23735846224, 9516.003278622857, 9974.451405172786, 10047.346922450017, 10101.292909496266, 10203.795924081476, 2832.4759919414564, 2836.716328367188, 2918.5768063630653, 2926.4978443430987, 2969.693943781482, 1048.7954848804563, 1053.0575135254057, 1056.3609016545033, 1057.1965306367217, 1067.7010437077631, 20443.8977805113, 21024.0, 21036.789632103788, 21228.78771212299, 21411.8929405352, 1126.5775334249656, 1130.4856290387854, 1133.6712353417581, 1143.937083460401, 1147.0708725932022, 11353.26203796767, 11515.654530364103, 11564.363959982113, 11623.476943537562, 11658.300501969909, 609919.0, 617022.0, 633076.0, 660309.0, 663816.0, 121914.0, 127810.36094819652, 127839.0, 128119.0, 128681.35659321831, 1123.393367581497, 1173.5775120956448, 1220.4507971412722, 1261.0920137500984, 1278.4886045581657, 21682.024308906453, 21940.232091876707, 21966.121355146253, 22152.889235554365, 22290.331290061324, 61580.0, 61785.0, 62261.0, 63682.0, 64053.67973160104, 79958.20041799507, 80393.19606803857, 81053.0, 81345.0, 82050.58974705088, 15445.304961276544, 15736.763948540553, 15772.132532710812, 15809.525714228592, 15838.841611583737, 23836.16573419922, 23864.284071477883, 24248.393790155387, 24390.75609243956, 24629.753702462745, 19761.0, 19818.108185131416, 19855.411567074887, 19924.203031878562, 20214.494637634176, 17587.56031099233, 17598.29606815713, 17809.46571602854, 18104.63790724152, 18274.086295684898, 19710.310139145062, 20148.39554813358, 20264.493387664836, 20389.69415458799, 20537.97310134517, 15540.611484712972, 15542.30059647296, 15568.065916045074, 15621.921890390475, 15701.136437496047, 19191.136398861807, 19413.8058619412, 19596.706049409557, 19712.408627740617, 19812.603747925248], "value": 12783.354717167556, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.7449321875451, 1443.7545617245066, 1446.6961937993021, 1464.4947493114878, 1465.4065103633025, 13911.791323130148, 14456.927715361422, 16753.581160470978, 17197.656046879056, 17223.655526889455, 15608.063516189008, 15944.601384965381, 16062.919685401557, 16360.672786544292, 16410.67178656426, 2612.93467663309, 2762.958555621662, 2834.588984597232, 2835.8298502089942, 2915.1983204618687, 2906.767458603317, 2921.868515916789, 2930.58971743956, 2931.2818359501953, 2933.6186295781517, 2731.399092199713, 2775.6252905857655, 2776.1532732516575, 2779.7637200837953, 2819.126070918022, 2775.9722402776015, 2776.4585905748386, 2797.300674831282, 2798.8320700758018, 2803.817751846144, 2746.5193591121474, 2758.600002999574, 2766.1563223216913, 2769.8753556090023, 2770.515159847039, 16282.83717162837, 16375.263113159936, 16485.17574121289, 16561.171941403, 16572.917135414365, 8411.83176336476, 8741.475511469333, 8750.168733970262, 8758.56207189638, 8775.517346545937, 5605.887882242373, 5849.532037436995, 5908.6454812710945, 5998.850028749316, 6001.699915004276, 2125.798049185325, 2131.861429007125, 2137.6900349449397, 2218.0794970087395, 2229.9888500557554, 29866.0, 29873.551896721565, 29941.700582994108, 29961.0, 30061.398772024655, 7144.499885008104, 7255.09311336083, 7297.416206703451, 7401.48189626721, 7622.695092196361, 19762.20951161966, 19780.109895054757, 19785.40643780689, 19811.60376792456, 19838.0, 8433.19884610961, 8528.189821966904, 8580.828383432421, 8585.914140858637, 8586.441881277697, 6288.402601752826, 6753.0, 6825.795226143224, 7654.923450765533, 7860.253275938777, 5687.829365119053, 5817.127430885316, 5846.356900740915, 5860.3260625027815, 5978.611390259619, 1641.1958140511301, 1684.4357140358118, 1686.9493915182563, 1690.1126908373203, 1698.2782317515007, 992.3153024413276, 996.8255555277798, 1008.3899240959261, 1029.7477118106112, 1031.9896801032044, 8555.572221388906, 8689.56552172389, 8925.509096999727, 8953.641854325884, 8964.282857371525, 805.5327909812295, 808.7695006922999, 817.5993763056059, 818.3453237410048, 820.5733018830294, 5246.186841039645, 5329.520343169133, 5368.606491296191, 5673.205751194836, 5675.914861277084, 24908.0, 25425.0, 25497.23508294754, 25525.61711574291, 25874.870625647127, 24110.0, 25260.368490787878, 25388.238352849443, 25452.49095018126, 25467.98128074856, 12489.750204996031, 12539.122261441611, 12551.811722824164, 12573.93713031429, 12592.055595830348, 8909.509976951329, 9014.459132452073, 9031.593578288861, 9042.547872606476, 9115.270778337584, 20824.791752082285, 20884.269050583156, 21595.568088638454, 21658.67511987353, 21872.125114995222, 22056.669149963083, 22079.116835326407, 22131.557368852857, 22437.32688019362, 22760.658590121493, 12475.500979961063, 12676.985841132502, 12680.11239213283, 12685.556005540131, 12696.555620553236, 15453.227338633249, 15640.296186671854, 15713.921430392775, 15801.051936883823, 15885.682286353976, 12502.312372819219, 12581.308028058545, 12801.743965120459, 13010.089293749346, 13128.0, 11163.49764260594, 11281.548738050715, 11281.605143820256, 11427.771444571228, 11585.710357241136, 11271.943640281746, 11533.0, 11547.538098475967, 11553.711157221136, 11564.363959981945, 8284.627191776504, 8411.53736544496, 8513.702020429255, 8538.957305213435, 8605.139486051345, 8446.704365347183, 8581.098984606526, 8610.182032706884, 8614.396992210735, 8650.826983460169], "value": 7262.970721338587, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.4787899374585, 561.3824792727999, 578.4967078641581, 581.7585701933698, 585.6837307853759, 6235.968820155898, 6275.152854364659, 6277.403646653572, 6344.968275158623, 6364.777232796853, 6221.129041934133, 6223.782167624134, 6231.6290416108495, 6256.781012664557, 6282.623042617446, 5071.594272458195, 5084.135696931512, 5091.770870310845, 5093.108705976458, 5173.560247378959, 5192.740362981855, 5205.7397130143345, 5221.556167725729, 5222.164453687411, 5269.920951185735, 5160.380754309488, 5192.039472697563, 5255.237990491377, 5261.158214685651, 5261.316028916235, 5257.474252574751, 5260.500252476008, 5265.498888028194, 5266.8683282917855, 5289.788408463657, 4956.281339205831, 4962.057209130254, 4977.278294647256, 4988.501149885019, 5031.421386540522, 6199.597026193283, 6309.684515774239, 6385.042243663441, 6391.58454700443, 6443.452306553949, 6118.296395914483, 6164.229471316085, 6195.884740746664, 6247.5939063960695, 6266.467350275232, 6791.966040169767, 6818.352256535622, 6839.350261725128, 6839.452843772536, 6871.278515755824, 5275.736213189325, 5494.972525137388, 5569.916451253234, 5574.219609254707, 5643.661380317194, 6804.21751498579, 6811.863762724767, 6866.931330686679, 7092.219855815856, 7105.467089968273, 5689.459501347365, 5729.369769325371, 5734.483896449339, 5736.139579063174, 5747.48272655463, 5765.135229715493, 5821.243238379068, 5849.415058494202, 5877.617954832922, 5915.438033386908, 6191.504679625709, 6215.943289640772, 6231.813045608639, 6250.562460627712, 6290.433860952537, 6828.385445309847, 6838.452923766087, 6848.1097457331225, 6868.656567171622, 6900.654967251618, 1992.6512860249397, 2004.518915460308, 2020.3029954665617, 2038.3782946201254, 2043.3257025181654, 1447.4499690117898, 1483.703259348113, 1498.2508745627185, 1530.3572499550216, 1552.192859712943, 6126.816195514141, 6223.688815559294, 6256.687165641791, 6325.58883672569, 6326.177596912464, 6601.636909969901, 6655.0682904393425, 6777.423918966844, 6788.524803263724, 6828.965855170792, 6134.754609815646, 6253.342864141006, 6287.622742635456, 6312.936870631327, 6340.587861788969, 3545.71634269263, 3549.290141971616, 3579.391503444421, 3581.462780582933, 3615.891523254307, 6897.689603967833, 6903.101647047002, 6927.307269273032, 7001.614911179832, 7004.404625606779, 6861.176658800976, 6886.829239029377, 6910.930890691129, 6940.13248343957, 7024.262452442522, 7006.369426751617, 7012.298770122947, 7032.8593428130125, 7032.8945065824055, 7062.258462861429, 6622.304658010839, 6699.464042876461, 6731.562448440835, 6733.326667333227, 6814.522983391314, 6803.489738269748, 6807.183138023469, 6819.761308354184, 6832.925183667469, 6868.416184624363, 7020.859582808417, 7072.3634872861685, 7075.398591119607, 7124.964375178091, 7132.0, 5650.818394388041, 5663.915041274467, 5669.177969194526, 5704.971475142598, 5712.514436272797, 6612.0, 6725.865482690221, 6819.215790183994, 6819.420349270169, 7024.1571011478945, 6643.833904152435, 6660.733570657119, 6668.83327916806, 6670.499712521678, 6674.766383176566, 6570.277269500447, 6574.408303252731, 6580.144581204413, 6591.143151390289, 6603.283146381879, 6239.660127452205, 6432.067350234283, 6505.9915713062655, 6522.934770652233, 6559.770408035887, 6654.334566543501, 6673.899891501728, 6694.330566943267, 6695.397414232742, 6788.796336109925, 6434.8391290218115, 6466.579672321284, 6511.772087976898, 6574.178227721535, 6581.407673309233], "value": 5363.377862762259, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [954.88063992001, 973.7322236384994, 992.2657233647103, 995.6117114325415, 998.6205242008036, 20733.688994665074, 21238.469038274052, 21245.57508849822, 21275.14899404024, 21283.787162128374, 19190.42428727137, 19391.127399267032, 19536.120874560642, 19556.41330760076, 19680.0, 1040.921930855187, 1076.0960792933934, 1079.3469950679844, 1080.2492267873831, 1080.3733834376044, 1049.3965969567491, 1063.3832377221192, 1073.09859717837, 1073.5974009746344, 1096.0792933935493, 1134.0, 1141.7202785317609, 1144.3305666185292, 1147.23708733692, 1147.340279339379, 1076.445630500293, 1108.3294606762954, 1134.0643968725792, 1142.90285325747, 1146.140394703972, 809.5952023988006, 819.573821612758, 821.650798410679, 822.1203312455675, 822.8847961285425, 21822.127114915384, 21851.890740546194, 21948.122075116975, 21954.121835126574, 22045.779542204695, 22537.661935070988, 22725.77274227253, 23073.653895191586, 23108.0, 23125.421864453354, 17589.912050439794, 18154.092295385177, 18263.269469221214, 18334.174962126737, 18461.907690461598, 3852.171783066626, 3855.3253180693546, 3902.1025164212106, 3907.5701672815967, 3907.960920390788, 155139.0, 156670.0, 157783.0, 159891.0, 161226.19386903106, 17159.571010724583, 17439.302427902996, 17558.473245802645, 17593.208305626278, 17597.47207583749, 34046.82976585101, 34553.82723086369, 34637.13407164791, 34654.960351189504, 34806.47790283148, 8937.597808098652, 8979.77550561228, 8991.505467199368, 9021.503817290111, 9050.0, 4792.209285467929, 4846.079244943449, 4854.320395144682, 4863.3434486343895, 4894.094592500399, 6043.305019922677, 6046.788362407295, 6088.6042407243385, 6090.147379366892, 6105.511559075263, 1149.1209224942925, 1185.0934035462878, 1198.688341031338, 1200.4597930931116, 1203.3020847908192, 736.4292673178329, 751.1774606805649, 755.5844285642875, 770.734096736625, 773.6131934032984, 13025.869741302655, 13215.801762973562, 13688.247146406844, 14234.288285585679, 14242.43030278798, 728.8870225115115, 735.3969744809312, 738.4609235258184, 745.1133151549747, 746.0562388578453, 6383.39357761012, 6503.349665033459, 6556.901646475307, 6575.837967195728, 6580.80257592273, 147242.0, 149599.0, 150278.0, 150896.0, 153295.0, 122560.0, 131890.0, 132676.0, 133165.0, 135173.0, 115135.0, 115940.42029789797, 116415.0, 118045.4097729523, 118460.40769796095, 14733.04235224707, 15200.843772698638, 15211.239438028275, 15465.840061995621, 15478.690426191639, 52555.47444525506, 52742.0, 52998.0, 53107.0, 53581.19628205658, 68654.0, 68845.65577172082, 68873.0, 69935.6503217501, 71669.6416517914, 19928.0, 20359.0, 20496.18015279372, 20624.896875515526, 20629.58740825205, 20190.0, 20237.79762202359, 20374.18503259912, 20408.18367265293, 20676.68984965257, 21569.24507642225, 21815.781842181375, 21906.23328183506, 21937.0, 22044.559108818055, 18191.09044547741, 18234.36179733756, 18260.634787303912, 18444.723329149805, 18694.906525467286, 18685.719714204028, 18746.71879921775, 18987.71518427252, 19225.711614326076, 19304.710429343853, 15153.0, 15253.16107614092, 15393.153376564396, 15732.370705172123, 15797.289121989308, 13841.653958651113, 13848.723025539633, 13931.442742290601, 13977.371018303997, 13995.370208340446], "value": 10234.327123843823, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1375.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 108.0, 104.0, 105.0, 106.0, 105.0, 107.0, 103.0, 106.0, 106.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 113.0, 112.0, 113.0, 112.0, 115.0, 114.0, 112.0, 111.0], "value": 113.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 161.0, 166.0, 162.0, 161.0, 165.0, 169.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 77.0, 75.0, 75.0, 75.0, 77.0, 75.0, 73.0, 73.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 88.0, 78.0, 78.0, 78.0, 79.0, 79.0, 79.0, 78.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 117.0, 114.0, 113.0, 117.0, 114.0, 115.0, 114.0, 111.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 149.0, 150.0, 149.0, 150.0, 149.0, 150.0, 154.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 98.0, 93.0, 98.0, 98.0, 94.0, 96.0, 93.0, 94.0, 94.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 44.0, 49.0, 45.0, 47.0, 47.0, 44.0, 46.0, 45.0], "value": 45.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0], "value": 37.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 75.0, 72.0, 72.0, 88.0, 72.0, 72.0, 72.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 105.0, 104.0, 105.0, 104.0, 105.0, 103.0, 109.0, 104.0], "value": 104.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 155.0, 155.0, 163.0, 161.0, 154.0, 159.0, 156.0, 151.0, 153.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 58.0, 60.0, 58.0, 62.0, 58.0, 61.0, 58.0, 61.0], "value": 60.1, "unit": "score"}]}]} 10:51:45 INFO - Return code: 0 10:51:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:51:45 INFO - # TBPL SUCCESS # 10:51:45 INFO - Running post-action listener: _package_coverage_data 10:51:45 INFO - Running post-action listener: _resource_record_post_action 10:51:45 INFO - [mozharness: 2017-09-14 17:51:45.184266Z] Finished run-tests step (success) 10:51:45 INFO - Running post-run listener: _resource_record_post_run 10:51:45 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 337182720; Read time: 12; Write time: 304744 10:51:45 INFO - TinderboxPrint: CPU usage
13.1% 10:51:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:51:45 INFO - TinderboxPrint: I/O write bytes / time
337,182,720 / 304,744 10:51:45 INFO - TinderboxPrint: CPU idle
8,231.3 (86.9%) 10:51:45 INFO - TinderboxPrint: CPU user
1,188.3 (12.5%) 10:51:45 INFO - TinderboxPrint: Swap in / out
0 / 0 10:51:45 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10719232; Read time: 0; Write time: 820 10:51:45 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:51:45 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326463488; Read time: 12; Write time: 303924 10:51:45 INFO - Running post-run listener: _upload_blobber_files 10:51:45 INFO - Blob upload gear active. 10:51:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:51:45 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 10:51:45 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'] 10:51:45 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 10:51:46 INFO - (blobuploader) - INFO - Open directory for files ... 10:51:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 10:51:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 10:51:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:47 INFO - (blobuploader) - INFO - Done attempting. 10:51:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 10:51:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 10:51:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:48 INFO - (blobuploader) - INFO - Done attempting. 10:51:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:51:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:51:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:55 INFO - (blobuploader) - INFO - Done attempting. 10:51:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:51:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:51:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:56 INFO - (blobuploader) - INFO - Done attempting. 10:51:56 INFO - (blobuploader) - INFO - Iteration through files over. 10:51:56 INFO - Return code: 0 10:51:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:51:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:51:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/134934ba79f537a54ae6a56cc38897a761f1384451da9efb40077c2defa1ef661838b262dc23ac92b5875dea71c86cd10f955cf9a9713b45ef0af3712f679236", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41251871dd310e8fe2cb13cb4a7b1a4a77b1e135eb46953718bd4d671e0432c6ebf5f0b842044b08ed1f86f9d0bf5761676515c20b7c7335e8ffc285948c72f6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc14dcfa828dc474dc3e721cceef8293c7c59269b076d707c33de631e7372aee0e309cc40f9a8c2f8114f620431cac9088f3d610483ceb4f0f27811499d07e92", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e44f4b385807d41c845ff5cdf8d6694fbb03a9b58d515d6e2bccdf639d3da874253687962a7860ec02dd64718ab5020fd498a72fc4360415b5a6f8c879655a63"} 10:51:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:51:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:51:56 INFO - Contents: 10:51:56 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/134934ba79f537a54ae6a56cc38897a761f1384451da9efb40077c2defa1ef661838b262dc23ac92b5875dea71c86cd10f955cf9a9713b45ef0af3712f679236", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41251871dd310e8fe2cb13cb4a7b1a4a77b1e135eb46953718bd4d671e0432c6ebf5f0b842044b08ed1f86f9d0bf5761676515c20b7c7335e8ffc285948c72f6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc14dcfa828dc474dc3e721cceef8293c7c59269b076d707c33de631e7372aee0e309cc40f9a8c2f8114f620431cac9088f3d610483ceb4f0f27811499d07e92", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e44f4b385807d41c845ff5cdf8d6694fbb03a9b58d515d6e2bccdf639d3da874253687962a7860ec02dd64718ab5020fd498a72fc4360415b5a6f8c879655a63"} 10:51:56 INFO - Running post-run listener: copy_logs_to_upload_dir 10:51:56 INFO - Copying logs to upload dir... 10:51:56 INFO - mkdir: /builds/slave/test/build/upload/logs 10:51:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.368768 ========= master_lag: -0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-14 10:51:55.733755) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 10:51:55.741250) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573 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/134934ba79f537a54ae6a56cc38897a761f1384451da9efb40077c2defa1ef661838b262dc23ac92b5875dea71c86cd10f955cf9a9713b45ef0af3712f679236", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41251871dd310e8fe2cb13cb4a7b1a4a77b1e135eb46953718bd4d671e0432c6ebf5f0b842044b08ed1f86f9d0bf5761676515c20b7c7335e8ffc285948c72f6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc14dcfa828dc474dc3e721cceef8293c7c59269b076d707c33de631e7372aee0e309cc40f9a8c2f8114f620431cac9088f3d610483ceb4f0f27811499d07e92", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e44f4b385807d41c845ff5cdf8d6694fbb03a9b58d515d6e2bccdf639d3da874253687962a7860ec02dd64718ab5020fd498a72fc4360415b5a6f8c879655a63"} build_url:https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/134934ba79f537a54ae6a56cc38897a761f1384451da9efb40077c2defa1ef661838b262dc23ac92b5875dea71c86cd10f955cf9a9713b45ef0af3712f679236", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41251871dd310e8fe2cb13cb4a7b1a4a77b1e135eb46953718bd4d671e0432c6ebf5f0b842044b08ed1f86f9d0bf5761676515c20b7c7335e8ffc285948c72f6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc14dcfa828dc474dc3e721cceef8293c7c59269b076d707c33de631e7372aee0e309cc40f9a8c2f8114f620431cac9088f3d610483ceb4f0f27811499d07e92", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e44f4b385807d41c845ff5cdf8d6694fbb03a9b58d515d6e2bccdf639d3da874253687962a7860ec02dd64718ab5020fd498a72fc4360415b5a6f8c879655a63"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 10:51:55.772007) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:51:55.772339) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505410272.679598-1311805573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:51:55.854763) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 10:51:55.858085) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 10:51:55.858388) ========= ========= Total master_lag: -0.06 =========