builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-013 starttime: 1506224485.77 results: success (0) revision: 42aa84eec339c29bf3d21178ae6e5c138d50e82b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:25.765505) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:25.765886) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:25.766409) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:25.817829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:25.818099) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 20:41:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2017-09-23 20:41:26 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122322 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:25.956592) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:25.959900) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021381 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:26.027519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:26.027808) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42aa84eec339c29bf3d21178ae6e5c138d50e82b --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 42aa84eec339c29bf3d21178ae6e5c138d50e82b --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=9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 20:41:26,472 truncating revision to first 12 chars 2017-09-23 20:41:26,472 Setting DEBUG logging. 2017-09-23 20:41:26,472 attempt 1/10 2017-09-23 20:41:26,473 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42aa84eec339?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-23 20:41:26,835 unpacking tar archive at: mozilla-central-42aa84eec339/testing/mozharness/ program finished with exit code 0 elapsedTime=0.690201 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:26.737943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:26.738213) ========= script_repo_revision: 42aa84eec339c29bf3d21178ae6e5c138d50e82b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:26.738561) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:26.738819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 20:41:26.761706) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-23 20:41:26.761992) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:41:27 INFO - MultiFileLogger online at 20170923 20:41:27 in /builds/slave/test 20:41:27 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 20:41:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:41:27 INFO - {'append_to_log': False, 20:41:27 INFO - 'base_work_dir': '/builds/slave/test', 20:41:27 INFO - 'blob_upload_branch': 'Firefox', 20:41:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:41:27 INFO - 'branch': 'Firefox', 20:41:27 INFO - 'buildbot_json_path': 'buildprops.json', 20:41:27 INFO - 'code_coverage': False, 20:41:27 INFO - 'config_files': ('talos/linux_config.py',), 20:41:27 INFO - 'default_actions': ('clobber', 20:41:27 INFO - 'read-buildbot-config', 20:41:27 INFO - 'download-and-extract', 20:41:27 INFO - 'populate-webroot', 20:41:27 INFO - 'create-virtualenv', 20:41:27 INFO - 'install', 20:41:27 INFO - 'setup-mitmproxy', 20:41:27 INFO - 'run-tests'), 20:41:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:41:27 INFO - 'disable_ccov_upload': False, 20:41:27 INFO - 'disable_stylo': False, 20:41:27 INFO - 'download_minidump_stackwalk': True, 20:41:27 INFO - 'download_symbols': 'ondemand', 20:41:27 INFO - 'enable_stylo': False, 20:41:27 INFO - 'enable_webrender': False, 20:41:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 20:41:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:41:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:41:27 INFO - 'gecko_profile': False, 20:41:27 INFO - 'gecko_profile_interval': 0, 20:41:27 INFO - 'installer_path': 'installer.exe', 20:41:27 INFO - 'log_level': 'info', 20:41:27 INFO - 'log_name': 'talos', 20:41:27 INFO - 'log_to_console': True, 20:41:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:41:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:41:27 INFO - 'opt_config_files': (), 20:41:27 INFO - 'pip_index': False, 20:41:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 20:41:27 INFO - 'system_bits': '32', 20:41:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:41:27 INFO - 'title': 'talos-linux64-ix-013', 20:41:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:41:27 INFO - 'use_talos_json': True, 20:41:27 INFO - 'verify': 'False', 20:41:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:41:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:41:27 INFO - 'work_dir': 'build'} 20:41:27 INFO - [mozharness: 2017-09-24 03:41:27.349518Z] Running clobber step. 20:41:27 INFO - Running pre-action listener: _resource_record_pre_action 20:41:27 INFO - Running main action method: clobber 20:41:27 INFO - rmtree: /builds/slave/test/build 20:41:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:41:28 INFO - Running post-action listener: _resource_record_post_action 20:41:28 INFO - [mozharness: 2017-09-24 03:41:28.848854Z] Finished clobber step (success) 20:41:28 INFO - [mozharness: 2017-09-24 03:41:28.848952Z] Running read-buildbot-config step. 20:41:28 INFO - Running pre-action listener: _resource_record_pre_action 20:41:28 INFO - Running main action method: read_buildbot_config 20:41:28 INFO - Using buildbot properties: 20:41:28 INFO - { 20:41:28 INFO - "project": "", 20:41:28 INFO - "product": "firefox", 20:41:28 INFO - "who": "philringnalda@gmail.com", 20:41:28 INFO - "installer_path": "public/build/target.tar.bz2", 20:41:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 20:41:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 20:41:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 20:41:28 INFO - "stage_platform": "linux64-pgo", 20:41:28 INFO - "basedir": "/builds/slave/test", 20:41:28 INFO - "buildnumber": 52, 20:41:28 INFO - "platform": "ubuntu64_hw", 20:41:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:41:28 INFO - "slavebuilddir": "test", 20:41:28 INFO - "taskId": "TF8oL1P-SgOHjBhoyN_bBQ", 20:41:28 INFO - "branch": "mozilla-central", 20:41:28 INFO - "script_repo_revision": "production", 20:41:28 INFO - "revision": "42aa84eec339c29bf3d21178ae6e5c138d50e82b", 20:41:28 INFO - "slavename": "talos-linux64-ix-013", 20:41:28 INFO - "repo_path": "mozilla-central" 20:41:28 INFO - } 20:41:28 INFO - Finding installer, test and symbols from parent task. 20:41:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TF8oL1P-SgOHjBhoyN_bBQ'}, attempt #1 20:41:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TF8oL1P-SgOHjBhoyN_bBQ'}, attempt #1 20:41:29 INFO - Task dependencies: Q4ywgNwcTHaso13_WBPeKA 20:41:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA'}, attempt #1 20:41:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.tar.bz2 20:41:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.test_packages.json 20:41:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.crashreporter-symbols.zip 20:41:30 INFO - Running post-action listener: _resource_record_post_action 20:41:30 INFO - [mozharness: 2017-09-24 03:41:30.203212Z] Finished read-buildbot-config step (success) 20:41:30 INFO - [mozharness: 2017-09-24 03:41:30.203461Z] Running download-and-extract step. 20:41:30 INFO - Running pre-action listener: _resource_record_pre_action 20:41:30 INFO - Running main action method: download_and_extract 20:41:30 INFO - mkdir: /builds/slave/test/build/tests 20:41:30 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')]} 20:41:30 INFO - trying https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.test_packages.json 20:41:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:41:30 INFO - Downloaded 989 bytes. 20:41:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:41:30 INFO - Using the following test package requirements: 20:41:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:41:30 INFO - u'common': [u'target.common.tests.zip'], 20:41:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:41:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:41:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:41:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:41:30 INFO - u'mozbase': [u'target.common.tests.zip'], 20:41:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:41:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:41:30 INFO - u'web-platform': [u'target.common.tests.zip', 20:41:30 INFO - u'target.web-platform.tests.tar.gz'], 20:41:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:41:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 20:41:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.common.tests.zip 20:41:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:41:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.common.tests.zip into memory 20:41:32 INFO - Content-Length response header: 55347281 20:41:32 INFO - Bytes received: 55347281 20:41:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.talos.tests.zip 20:41:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:41:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.talos.tests.zip into memory 20:41:44 INFO - Content-Length response header: 14513823 20:41:44 INFO - Bytes received: 14513823 20:41:45 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')]} 20:41:45 INFO - trying https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.tar.bz2 20:41:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:41:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:41:48 INFO - Downloaded 62395661 bytes. 20:41:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.tar.bz2 20:41:48 INFO - mkdir: /builds/slave/test/properties 20:41:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:41:48 INFO - Writing to file /builds/slave/test/properties/build_url 20:41:48 INFO - Contents: 20:41:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.tar.bz2 20:41:48 INFO - Running post-action listener: _resource_record_post_action 20:41:48 INFO - Running post-action listener: find_tests_for_verification 20:41:48 INFO - Running post-action listener: set_extra_try_arguments 20:41:48 INFO - [mozharness: 2017-09-24 03:41:48.457086Z] Finished download-and-extract step (success) 20:41:48 INFO - [mozharness: 2017-09-24 03:41:48.457184Z] Running populate-webroot step. 20:41:48 INFO - Running pre-action listener: _resource_record_pre_action 20:41:48 INFO - Running main action method: populate_webroot 20:41:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:41:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:41:48 INFO - 'tests': ['tresize', 20:41:48 INFO - 'tcanvasmark']}, 20:41:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:41:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:41:48 INFO - 'tests': ['dromaeo_css', 20:41:48 INFO - 'kraken']}, 20:41:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:41:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:41:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:41:48 INFO - 'talos_options': ['--disable-stylo'], 20:41:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:41:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:41:48 INFO - 'tests': ['damp', 'tps']}, 20:41:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:41:48 INFO - 'talos_options': ['--disable-stylo'], 20:41:48 INFO - 'tests': ['damp', 'tps']}, 20:41:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:41:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:41:48 INFO - 'tests': ['dromaeo_dom']}, 20:41:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:41:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:41:48 INFO - 'tests': ['basic_compositor_video', 20:41:48 INFO - 'glvideo']}, 20:41:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:41:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:41:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:41:48 INFO - 'talos_options': ['--disable-stylo'], 20:41:48 INFO - 'tests': ['ts_paint_webext', 20:41:48 INFO - 'tp5o_webext']}, 20:41:48 INFO - 'other-e10s': {'tests': ['a11yr', 20:41:48 INFO - 'ts_paint', 20:41:48 INFO - 'tpaint', 20:41:48 INFO - 'sessionrestore', 20:41:48 INFO - 'sessionrestore_many_windows', 20:41:48 INFO - 'sessionrestore_no_auto_restore', 20:41:48 INFO - 'tabpaint']}, 20:41:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:41:48 INFO - 'tests': ['a11yr', 20:41:48 INFO - 'ts_paint', 20:41:48 INFO - 'tpaint', 20:41:48 INFO - 'sessionrestore', 20:41:48 INFO - 'sessionrestore_many_windows', 20:41:48 INFO - 'sessionrestore_no_auto_restore', 20:41:48 INFO - 'tabpaint']}, 20:41:48 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 20:41:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 20:41:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:41:48 INFO - 'tests': ['perf_reftest_singletons']}, 20:41:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:41:48 INFO - 'tests': ['perf_reftest']}, 20:41:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:41:48 INFO - 'tsvgr_opacity', 20:41:48 INFO - 'tart', 20:41:48 INFO - 'tscrollx', 20:41:48 INFO - 'tsvg_static']}, 20:41:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:41:48 INFO - 'tests': ['tsvgx', 20:41:48 INFO - 'tsvgr_opacity', 20:41:48 INFO - 'tart', 20:41:48 INFO - 'tscrollx', 20:41:48 INFO - 'tsvg_static']}, 20:41:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:41:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:41:48 INFO - 'talos_options': ['--disable-stylo'], 20:41:48 INFO - 'tests': ['tp5o']}, 20:41:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:41:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:41:48 INFO - 'talos_options': ['--mitmproxy', 20:41:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:41:48 INFO - '--firstNonBlankPaint'], 20:41:48 INFO - 'tests': ['tp6_google', 20:41:48 INFO - 'tp6_youtube', 20:41:48 INFO - 'tp6_amazon', 20:41:48 INFO - 'tp6_facebook']}, 20:41:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:41:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:41:48 INFO - 'talos_options': ['--disable-stylo', 20:41:48 INFO - '--mitmproxy', 20:41:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:41:48 INFO - '--firstNonBlankPaint'], 20:41:48 INFO - 'tests': ['tp6_google', 20:41:48 INFO - 'tp6_youtube', 20:41:48 INFO - 'tp6_amazon', 20:41:48 INFO - 'tp6_facebook']}, 20:41:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:41:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:41:48 INFO - 'talos_options': ['--stylo-threads=1', 20:41:48 INFO - '--mitmproxy', 20:41:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:41:48 INFO - '--firstNonBlankPaint'], 20:41:48 INFO - 'tests': ['tp6_google', 20:41:48 INFO - 'tp6_youtube', 20:41:48 INFO - 'tp6_amazon', 20:41:48 INFO - 'tp6_facebook']}, 20:41:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:41:48 INFO - 'talos_options': ['--xperf_path', 20:41:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:41:48 INFO - 'tests': ['tp5n']}, 20:41:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:41:48 INFO - 'talos_options': ['--disable-stylo', 20:41:48 INFO - '--xperf_path', 20:41:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:41:48 INFO - 'tests': ['tp5n']}}} 20:41:48 INFO - Running post-action listener: _resource_record_post_action 20:41:48 INFO - [mozharness: 2017-09-24 03:41:48.472512Z] Finished populate-webroot step (success) 20:41:48 INFO - [mozharness: 2017-09-24 03:41:48.472602Z] Running create-virtualenv step. 20:41:48 INFO - Running pre-action listener: _resource_record_pre_action 20:41:48 INFO - Running main action method: create_virtualenv 20:41:48 INFO - Creating virtualenv /builds/slave/test/build/venv 20:41:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:41:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 20:41:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:41:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:41:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:41:49 INFO - Installing distribute.............................................................................................................................................................................................done. 20:41:49 INFO - Installing pip...............done. 20:41:49 INFO - Return code: 0 20:41:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:41:49 INFO - Reading from file tmpfile_stdout 20:41:49 INFO - Output received: 20:41:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 20:41:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:41: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')]} 20:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41: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')]} 20:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aad60>, '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 0x20aba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20abef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', '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 20:41:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:41:49 INFO - Using env: {'DISPLAY': ':0', 20:41:49 INFO - 'HOME': '/home/cltbld', 20:41:49 INFO - 'LANG': 'en_US.UTF-8', 20:41:49 INFO - 'LANGUAGE': 'en_US:en', 20:41:49 INFO - 'LOGNAME': 'cltbld', 20:41:49 INFO - 'MAIL': '/var/mail/cltbld', 20:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:49 INFO - 'MOZ_NO_REMOTE': '1', 20:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:49 INFO - 'NO_EM_RESTART': '1', 20:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:49 INFO - 'PWD': '/builds/slave/test', 20:41:49 INFO - 'SHELL': '/bin/bash', 20:41:49 INFO - 'SHLVL': '1', 20:41:49 INFO - 'TERM': 'linux', 20:41:49 INFO - 'TMOUT': '86400', 20:41:49 INFO - 'USER': 'cltbld', 20:41:49 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', 20:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:49 INFO - '_': '/tools/buildbot/bin/python'} 20:41:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 20:41:50 INFO - Downloading/unpacking pip>=1.5 20:41:50 INFO - Running setup.py egg_info for package pip 20:41:50 INFO - warning: no files found matching 'pip/cacert.pem' 20:41:50 INFO - warning: no files found matching '*.html' under directory 'docs' 20:41:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:41:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:41:50 INFO - Installing collected packages: pip 20:41:50 INFO - Found existing installation: pip 1.1 20:41:50 INFO - Uninstalling pip: 20:41:50 INFO - Successfully uninstalled pip 20:41:50 INFO - Running setup.py install for pip 20:41:50 INFO - warning: no files found matching 'pip/cacert.pem' 20:41:50 INFO - warning: no files found matching '*.html' under directory 'docs' 20:41:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:41:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:41:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 20:41:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 20:41:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 20:41:50 INFO - Successfully installed pip 20:41:50 INFO - Cleaning up... 20:41:50 INFO - Return code: 0 20:41:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aad60>, '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 0x20aba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20abef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', '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 20:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:41:50 INFO - Using env: {'DISPLAY': ':0', 20:41:50 INFO - 'HOME': '/home/cltbld', 20:41:50 INFO - 'LANG': 'en_US.UTF-8', 20:41:50 INFO - 'LANGUAGE': 'en_US:en', 20:41:50 INFO - 'LOGNAME': 'cltbld', 20:41:50 INFO - 'MAIL': '/var/mail/cltbld', 20:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:50 INFO - 'MOZ_NO_REMOTE': '1', 20:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:50 INFO - 'NO_EM_RESTART': '1', 20:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:50 INFO - 'PWD': '/builds/slave/test', 20:41:50 INFO - 'SHELL': '/bin/bash', 20:41:50 INFO - 'SHLVL': '1', 20:41:50 INFO - 'TERM': 'linux', 20:41:50 INFO - 'TMOUT': '86400', 20:41:50 INFO - 'USER': 'cltbld', 20:41:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', 20:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:50 INFO - '_': '/tools/buildbot/bin/python'} 20:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:50 INFO - Downloading/unpacking psutil>=3.1.1 20:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:41:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:41:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:41:52 INFO - Installing collected packages: psutil 20:41:52 INFO - Running setup.py install for psutil 20:41:52 INFO - building 'psutil._psutil_linux' extension 20:41:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:41:52 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 20:41:52 INFO - building 'psutil._psutil_posix' extension 20:41:52 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 20:41:52 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 20:41:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:41:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:41:52 INFO - Successfully installed psutil 20:41:52 INFO - Cleaning up... 20:41:53 INFO - Return code: 0 20:41:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:41:53 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')]} 20:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:53 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')]} 20:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:53 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aad60>, '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 0x20aba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20abef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', '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 20:41:53 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 20:41:53 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 20:41:53 INFO - Using env: {'DISPLAY': ':0', 20:41:53 INFO - 'HOME': '/home/cltbld', 20:41:53 INFO - 'LANG': 'en_US.UTF-8', 20:41:53 INFO - 'LANGUAGE': 'en_US:en', 20:41:53 INFO - 'LOGNAME': 'cltbld', 20:41:53 INFO - 'MAIL': '/var/mail/cltbld', 20:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:53 INFO - 'MOZ_NO_REMOTE': '1', 20:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:53 INFO - 'NO_EM_RESTART': '1', 20:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:53 INFO - 'PWD': '/builds/slave/test', 20:41:53 INFO - 'SHELL': '/bin/bash', 20:41:53 INFO - 'SHLVL': '1', 20:41:53 INFO - 'TERM': 'linux', 20:41:53 INFO - 'TMOUT': '86400', 20:41:53 INFO - 'USER': 'cltbld', 20:41:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', 20:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:53 INFO - '_': '/tools/buildbot/bin/python'} 20:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:41: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 20:41: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 20:41: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 20:41: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 20:41:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:41:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:41:54 INFO - Installing collected packages: mozsystemmonitor 20:41:54 INFO - Running setup.py install for mozsystemmonitor 20:41:55 INFO - Successfully installed mozsystemmonitor 20:41:55 INFO - Cleaning up... 20:41:55 INFO - Return code: 0 20:41:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aad60>, '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 0x20aba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20abef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', '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 20:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:41:55 INFO - Using env: {'DISPLAY': ':0', 20:41:55 INFO - 'HOME': '/home/cltbld', 20:41:55 INFO - 'LANG': 'en_US.UTF-8', 20:41:55 INFO - 'LANGUAGE': 'en_US:en', 20:41:55 INFO - 'LOGNAME': 'cltbld', 20:41:55 INFO - 'MAIL': '/var/mail/cltbld', 20:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:55 INFO - 'MOZ_NO_REMOTE': '1', 20:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:55 INFO - 'NO_EM_RESTART': '1', 20:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:55 INFO - 'PWD': '/builds/slave/test', 20:41:55 INFO - 'SHELL': '/bin/bash', 20:41:55 INFO - 'SHLVL': '1', 20:41:55 INFO - 'TERM': 'linux', 20:41:55 INFO - 'TMOUT': '86400', 20:41:55 INFO - 'USER': 'cltbld', 20:41:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', 20:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:55 INFO - '_': '/tools/buildbot/bin/python'} 20:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:55 INFO - Downloading/unpacking jsonschema==2.5.1 20:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:41:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:41:56 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 20:41:56 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 20:41:56 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 20:41:56 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 20:41:56 INFO - Downloading functools32-3.2.3-2.tar.gz 20:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:41:56 INFO - warning: no files found matching '*.txt' 20:41:56 INFO - no previously-included directories found matching 'build' 20:41:56 INFO - no previously-included directories found matching 'dist' 20:41:56 INFO - no previously-included directories found matching '.git*' 20:41:56 INFO - Installing collected packages: jsonschema, functools32 20:41:56 INFO - Running setup.py install for functools32 20:41:56 INFO - warning: no files found matching '*.txt' 20:41:56 INFO - no previously-included directories found matching 'build' 20:41:56 INFO - no previously-included directories found matching 'dist' 20:41:56 INFO - no previously-included directories found matching '.git*' 20:41:56 INFO - Successfully installed jsonschema functools32 20:41:56 INFO - Cleaning up... 20:41:56 INFO - Return code: 0 20:41:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:41: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')]} 20:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41: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')]} 20:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41: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', '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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aad60>, '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 0x20aba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20abef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', '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 20:41: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:41: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 functools32==3.2.3-2 20:41:56 INFO - Using env: {'DISPLAY': ':0', 20:41:56 INFO - 'HOME': '/home/cltbld', 20:41:56 INFO - 'LANG': 'en_US.UTF-8', 20:41:56 INFO - 'LANGUAGE': 'en_US:en', 20:41:56 INFO - 'LOGNAME': 'cltbld', 20:41:56 INFO - 'MAIL': '/var/mail/cltbld', 20:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:56 INFO - 'MOZ_NO_REMOTE': '1', 20:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:56 INFO - 'NO_EM_RESTART': '1', 20:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:56 INFO - 'PWD': '/builds/slave/test', 20:41:56 INFO - 'SHELL': '/bin/bash', 20:41:56 INFO - 'SHLVL': '1', 20:41:56 INFO - 'TERM': 'linux', 20:41:56 INFO - 'TMOUT': '86400', 20:41:56 INFO - 'USER': 'cltbld', 20:41:56 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', 20:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:56 INFO - '_': '/tools/buildbot/bin/python'} 20:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:41:56 INFO - Cleaning up... 20:41:56 INFO - Return code: 0 20:41:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:41: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')]} 20:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41: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')]} 20:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41: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', '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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aad60>, '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 0x20aba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20abef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', '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 20:41: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:41: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 blobuploader==1.2.4 20:41:56 INFO - Using env: {'DISPLAY': ':0', 20:41:56 INFO - 'HOME': '/home/cltbld', 20:41:56 INFO - 'LANG': 'en_US.UTF-8', 20:41:56 INFO - 'LANGUAGE': 'en_US:en', 20:41:56 INFO - 'LOGNAME': 'cltbld', 20:41:56 INFO - 'MAIL': '/var/mail/cltbld', 20:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:56 INFO - 'MOZ_NO_REMOTE': '1', 20:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:56 INFO - 'NO_EM_RESTART': '1', 20:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:56 INFO - 'PWD': '/builds/slave/test', 20:41:56 INFO - 'SHELL': '/bin/bash', 20:41:56 INFO - 'SHLVL': '1', 20:41:56 INFO - 'TERM': 'linux', 20:41:56 INFO - 'TMOUT': '86400', 20:41:56 INFO - 'USER': 'cltbld', 20:41:56 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', 20:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:56 INFO - '_': '/tools/buildbot/bin/python'} 20:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:57 INFO - Downloading/unpacking blobuploader==1.2.4 20:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:58 INFO - Downloading blobuploader-1.2.4.tar.gz 20:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:41:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:41:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:58 INFO - Downloading docopt-0.6.1.tar.gz 20:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:41:58 INFO - Installing collected packages: blobuploader, requests, docopt 20:41:58 INFO - Running setup.py install for blobuploader 20:41:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:41:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:41:59 INFO - Running setup.py install for requests 20:41:59 INFO - Running setup.py install for docopt 20:41:59 INFO - Successfully installed blobuploader requests docopt 20:41:59 INFO - Cleaning up... 20:41:59 INFO - Return code: 0 20:41:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:41:59 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')]} 20:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:59 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')]} 20:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:59 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aad60>, '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 0x20aba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20abef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', '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 20:41:59 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 20:41:59 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 20:41:59 INFO - Using env: {'DISPLAY': ':0', 20:41:59 INFO - 'HOME': '/home/cltbld', 20:41:59 INFO - 'LANG': 'en_US.UTF-8', 20:41:59 INFO - 'LANGUAGE': 'en_US:en', 20:41:59 INFO - 'LOGNAME': 'cltbld', 20:41:59 INFO - 'MAIL': '/var/mail/cltbld', 20:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:59 INFO - 'MOZ_NO_REMOTE': '1', 20:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:59 INFO - 'NO_EM_RESTART': '1', 20:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:59 INFO - 'PWD': '/builds/slave/test', 20:41:59 INFO - 'SHELL': '/bin/bash', 20:41:59 INFO - 'SHLVL': '1', 20:41:59 INFO - 'TERM': 'linux', 20:41:59 INFO - 'TMOUT': '86400', 20:41:59 INFO - 'USER': 'cltbld', 20:41:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', 20:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:59 INFO - '_': '/tools/buildbot/bin/python'} 20:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:41:59 INFO - Running setup.py (path:/tmp/pip-vtW6KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:41:59 INFO - Running setup.py (path:/tmp/pip-M8c7eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:41:59 INFO - Running setup.py (path:/tmp/pip-3kPY02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:41:59 INFO - Running setup.py (path:/tmp/pip-AVFCZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:42:00 INFO - Running setup.py (path:/tmp/pip-y3p23r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:42:00 INFO - Running setup.py (path:/tmp/pip-2BflDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:42:00 INFO - Running setup.py (path:/tmp/pip-XUDh5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:42:00 INFO - Running setup.py (path:/tmp/pip-Vq9QXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:42:00 INFO - Running setup.py (path:/tmp/pip-y5BgYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:42:00 INFO - Running setup.py (path:/tmp/pip-vT8Bar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:42:00 INFO - Running setup.py (path:/tmp/pip-oirqIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:42:00 INFO - Running setup.py (path:/tmp/pip-0oSDLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:42:00 INFO - Running setup.py (path:/tmp/pip-wjRRSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:42:00 INFO - Running setup.py (path:/tmp/pip-oz5Fbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:42:00 INFO - Running setup.py (path:/tmp/pip-rC49bZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:42:00 INFO - Running setup.py (path:/tmp/pip-Y5Nc8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:42:00 INFO - Running setup.py (path:/tmp/pip-z2DWd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:42:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:42:00 INFO - Running setup.py install for manifestparser 20:42:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:42:01 INFO - Running setup.py install for mozcrash 20:42:01 INFO - Running setup.py install for mozdebug 20:42:01 INFO - Running setup.py install for mozdevice 20:42:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:42:01 INFO - Running setup.py install for mozfile 20:42:01 INFO - Running setup.py install for mozhttpd 20:42:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:42:01 INFO - Running setup.py install for mozinfo 20:42:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:42:01 INFO - Running setup.py install for mozInstall 20:42:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:42:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:42:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:42:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:42:01 INFO - Running setup.py install for mozleak 20:42:01 INFO - Running setup.py install for mozlog 20:42:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:42:01 INFO - Running setup.py install for moznetwork 20:42:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:42:02 INFO - Running setup.py install for mozprocess 20:42:02 INFO - Running setup.py install for mozprofile 20:42:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:42:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:42:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:42:02 INFO - Running setup.py install for mozrunner 20:42:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:42:02 INFO - Running setup.py install for mozscreenshot 20:42:02 INFO - Running setup.py install for moztest 20:42:02 INFO - Running setup.py install for mozversion 20:42:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:42:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:42:02 INFO - Cleaning up... 20:42:02 INFO - Return code: 0 20:42:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:02 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aad60>, '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 0x20aba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20abef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', '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 20:42:02 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 20:42:02 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 20:42:02 INFO - Using env: {'DISPLAY': ':0', 20:42:02 INFO - 'HOME': '/home/cltbld', 20:42:02 INFO - 'LANG': 'en_US.UTF-8', 20:42:02 INFO - 'LANGUAGE': 'en_US:en', 20:42:02 INFO - 'LOGNAME': 'cltbld', 20:42:02 INFO - 'MAIL': '/var/mail/cltbld', 20:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:02 INFO - 'MOZ_NO_REMOTE': '1', 20:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:02 INFO - 'NO_EM_RESTART': '1', 20:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:02 INFO - 'PWD': '/builds/slave/test', 20:42:02 INFO - 'SHELL': '/bin/bash', 20:42:02 INFO - 'SHLVL': '1', 20:42:02 INFO - 'TERM': 'linux', 20:42:02 INFO - 'TMOUT': '86400', 20:42:02 INFO - 'USER': 'cltbld', 20:42:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', 20:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:02 INFO - '_': '/tools/buildbot/bin/python'} 20:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:42:02 INFO - Running setup.py (path:/tmp/pip-yChZPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:42:03 INFO - Running setup.py (path:/tmp/pip-FEyG8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:42:03 INFO - Running setup.py (path:/tmp/pip-wmkdyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:42:03 INFO - Running setup.py (path:/tmp/pip-RwA5rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:42:03 INFO - Running setup.py (path:/tmp/pip-XXZK1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:42:03 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)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:42:03 INFO - Running setup.py (path:/tmp/pip-LVb4lL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:42:03 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)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:42:03 INFO - Running setup.py (path:/tmp/pip-rrrQjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:42:03 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)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:42:03 INFO - Running setup.py (path:/tmp/pip-MCtFU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:42:03 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)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:42:03 INFO - Running setup.py (path:/tmp/pip-PWy5AN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:42:03 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)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:42:03 INFO - Running setup.py (path:/tmp/pip-sdJ3tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:42:03 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)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:42:03 INFO - Running setup.py (path:/tmp/pip-kblRYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:42:03 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)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:42:03 INFO - Running setup.py (path:/tmp/pip-IP9qqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:42:03 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)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:42:03 INFO - Running setup.py (path:/tmp/pip-lhRFKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:42:03 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)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:42:03 INFO - Running setup.py (path:/tmp/pip-SCud3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:42:03 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)) 20:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:42:03 INFO - Running setup.py (path:/tmp/pip-jtIVow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:42:04 INFO - Running setup.py (path:/tmp/pip-2fm8fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:42:04 INFO - Running setup.py (path:/tmp/pip-WtOZ3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:42:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:05 INFO - Downloading blessings-1.6.tar.gz 20:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:42:05 INFO - Installing collected packages: blessings 20:42:05 INFO - Running setup.py install for blessings 20:42:05 INFO - Successfully installed blessings 20:42:05 INFO - Cleaning up... 20:42:05 INFO - Return code: 0 20:42:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:42:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:42:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:42:05 INFO - Reading from file tmpfile_stdout 20:42:05 INFO - Current package versions: 20:42:05 INFO - argparse == 1.2.1 20:42:05 INFO - blessings == 1.6 20:42:05 INFO - blobuploader == 1.2.4 20:42:05 INFO - docopt == 0.6.1 20:42:05 INFO - functools32 == 3.2.3-2 20:42:05 INFO - jsonschema == 2.5.1 20:42:05 INFO - manifestparser == 1.1 20:42:05 INFO - mozInstall == 1.13 20:42:05 INFO - mozcrash == 1.0 20:42:05 INFO - mozdebug == 0.1 20:42:05 INFO - mozdevice == 0.51 20:42:05 INFO - mozfile == 1.2 20:42:05 INFO - mozhttpd == 0.7 20:42:05 INFO - mozinfo == 0.10 20:42:05 INFO - mozleak == 0.1 20:42:05 INFO - mozlog == 3.5 20:42:05 INFO - moznetwork == 0.27 20:42:05 INFO - mozprocess == 0.25 20:42:05 INFO - mozprofile == 0.28 20:42:05 INFO - mozrunner == 6.13 20:42:05 INFO - mozscreenshot == 0.1 20:42:05 INFO - mozsystemmonitor == 0.3 20:42:05 INFO - moztest == 0.8 20:42:05 INFO - mozversion == 1.4 20:42:05 INFO - psutil == 3.1.1 20:42:05 INFO - requests == 1.2.3 20:42:05 INFO - wsgiref == 0.1.2 20:42:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:05 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aad60>, '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 0x20aba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20abef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', '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 20:42:05 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 20:42:05 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 20:42:05 INFO - Using env: {'DISPLAY': ':0', 20:42:05 INFO - 'HOME': '/home/cltbld', 20:42:05 INFO - 'LANG': 'en_US.UTF-8', 20:42:05 INFO - 'LANGUAGE': 'en_US:en', 20:42:05 INFO - 'LOGNAME': 'cltbld', 20:42:05 INFO - 'MAIL': '/var/mail/cltbld', 20:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:05 INFO - 'MOZ_NO_REMOTE': '1', 20:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:05 INFO - 'NO_EM_RESTART': '1', 20:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:05 INFO - 'PWD': '/builds/slave/test', 20:42:05 INFO - 'SHELL': '/bin/bash', 20:42:05 INFO - 'SHLVL': '1', 20:42:05 INFO - 'TERM': 'linux', 20:42:05 INFO - 'TMOUT': '86400', 20:42:05 INFO - 'USER': 'cltbld', 20:42:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', 20:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:05 INFO - '_': '/tools/buildbot/bin/python'} 20:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:05 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)) 20:42:05 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)) 20:42:05 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)) 20:42:05 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)) 20:42:05 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)) 20:42:05 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)) 20:42:05 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)) 20:42:05 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)) 20:42:05 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)) 20:42:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20:42:05 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 20:42:05 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 20:42:05 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 20:42:05 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 20:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 20:42:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:42:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:42:07 INFO - Installing collected packages: simplejson 20:42:07 INFO - Running setup.py install for simplejson 20:42:07 INFO - building 'simplejson._speedups' extension 20:42:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 20:42:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 20:42:08 INFO - Successfully installed simplejson 20:42:08 INFO - Cleaning up... 20:42:08 INFO - Return code: 0 20:42:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aad60>, '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 0x20aba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20abef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', '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 20:42:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:42:08 INFO - Using env: {'DISPLAY': ':0', 20:42:08 INFO - 'HOME': '/home/cltbld', 20:42:08 INFO - 'LANG': 'en_US.UTF-8', 20:42:08 INFO - 'LANGUAGE': 'en_US:en', 20:42:08 INFO - 'LOGNAME': 'cltbld', 20:42:08 INFO - 'MAIL': '/var/mail/cltbld', 20:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:08 INFO - 'MOZ_NO_REMOTE': '1', 20:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:08 INFO - 'NO_EM_RESTART': '1', 20:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:08 INFO - 'PWD': '/builds/slave/test', 20:42:08 INFO - 'SHELL': '/bin/bash', 20:42:08 INFO - 'SHLVL': '1', 20:42:08 INFO - 'TERM': 'linux', 20:42:08 INFO - 'TMOUT': '86400', 20:42:08 INFO - 'USER': 'cltbld', 20:42:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', 20:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:08 INFO - '_': '/tools/buildbot/bin/python'} 20:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:42:08 INFO - Cleaning up... 20:42:08 INFO - Return code: 0 20:42:08 INFO - Running post-action listener: _resource_record_post_action 20:42:08 INFO - Running post-action listener: _start_resource_monitoring 20:42:08 INFO - Starting resource monitoring. 20:42:08 INFO - [mozharness: 2017-09-24 03:42:08.416018Z] Finished create-virtualenv step (success) 20:42:08 INFO - [mozharness: 2017-09-24 03:42:08.416495Z] Running install step. 20:42:08 INFO - Running pre-action listener: _resource_record_pre_action 20:42:08 INFO - Running main action method: install 20:42:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:42:08 INFO - Reading from file tmpfile_stdout 20:42:08 INFO - Detecting whether we're running mozinstall >=1.0... 20:42:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:42:08 INFO - Reading from file tmpfile_stdout 20:42:08 INFO - Output received: 20:42:08 INFO - Usage: mozinstall [options] installer 20:42:08 INFO - Options: 20:42:08 INFO - -h, --help show this help message and exit 20:42:08 INFO - -d DEST, --destination=DEST 20:42:08 INFO - Directory to install application into. [default: 20:42:08 INFO - "/builds/slave/test"] 20:42:08 INFO - --app=APP Application being installed. [default: firefox] 20:42:08 INFO - mkdir: /builds/slave/test/build/application 20:42:08 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'] 20:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:42:26 INFO - Reading from file tmpfile_stdout 20:42:26 INFO - Output received: 20:42:26 INFO - /builds/slave/test/build/application/firefox/firefox 20:42:26 INFO - Running post-action listener: _resource_record_post_action 20:42:26 INFO - [mozharness: 2017-09-24 03:42:26.407695Z] Finished install step (success) 20:42:26 INFO - [mozharness: 2017-09-24 03:42:26.407949Z] Running setup-mitmproxy step. 20:42:26 INFO - Running pre-action listener: _resource_record_pre_action 20:42:26 INFO - Running main action method: setup_mitmproxy 20:42:26 INFO - Skipping: mitmproxy is not required 20:42:26 INFO - Running post-action listener: _resource_record_post_action 20:42:26 INFO - [mozharness: 2017-09-24 03:42:26.409079Z] Finished setup-mitmproxy step (success) 20:42:26 INFO - [mozharness: 2017-09-24 03:42:26.409299Z] Running run-tests step. 20:42:26 INFO - Running pre-action listener: _resource_record_pre_action 20:42:26 INFO - Running pre-action listener: _set_gcov_prefix 20:42:26 INFO - Running main action method: run_tests 20:42:26 WARNING - Try message not found. 20:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:42:26 INFO - Python 2.7.3 20:42:26 INFO - Return code: 0 20:42:26 INFO - grabbing minidump binary from tooltool 20:42:26 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')]} 20:42:26 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 0x20aad60>, '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 0x20aba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20abef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:42:26 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 20:42:26 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 20:42:26 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 20:42:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:42:26 INFO - Return code: 0 20:42:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:42:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:42:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:42:26 INFO - ENV: RUST_BACKTRACE is now full 20:42:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:42:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:42:26 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/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 20:42:26 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/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 20:42:26 INFO - Using env: {'DISPLAY': ':0', 20:42:26 INFO - 'HOME': '/home/cltbld', 20:42:26 INFO - 'LANG': 'en_US.UTF-8', 20:42:26 INFO - 'LANGUAGE': 'en_US:en', 20:42:26 INFO - 'LOGNAME': 'cltbld', 20:42:26 INFO - 'MAIL': '/var/mail/cltbld', 20:42:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:42:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:26 INFO - 'MOZ_NO_REMOTE': '1', 20:42:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:26 INFO - 'NO_EM_RESTART': '1', 20:42:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:26 INFO - 'PWD': '/builds/slave/test', 20:42:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:42:26 INFO - 'RUST_BACKTRACE': 'full', 20:42:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:42:26 INFO - 'SHELL': '/bin/bash', 20:42:26 INFO - 'SHLVL': '1', 20:42:26 INFO - 'TERM': 'linux', 20:42:26 INFO - 'TMOUT': '86400', 20:42:26 INFO - 'USER': 'cltbld', 20:42:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', 20:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:26 INFO - '_': '/tools/buildbot/bin/python'} 20:42:26 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/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 20:42:26 INFO - mozversion application_buildid: 20170924021622 20:42:26 INFO - mozversion application_changeset: 42aa84eec339c29bf3d21178ae6e5c138d50e82b 20:42:26 INFO - mozversion application_display_name: Nightly 20:42:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:42:26 INFO - mozversion application_name: Firefox 20:42:26 INFO - mozversion application_remotingname: firefox 20:42:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:42:26 INFO - mozversion application_vendor: Mozilla 20:42:26 INFO - mozversion application_version: 58.0a1 20:42:26 INFO - mozversion platform_buildid: 20170924021622 20:42:26 INFO - mozversion platform_changeset: 42aa84eec339c29bf3d21178ae6e5c138d50e82b 20:42:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:42:26 INFO - mozversion platform_version: 58.0a1 20:42:26 INFO - using testdate: 1506224546 20:42:26 INFO - actual date: 1506224546 20:42:26 INFO - starting webserver on 'localhost:33480' 20:42:26 INFO - SUITE-START | Running 2 tests 20:42:26 INFO - TEST-START | dromaeo_css 20:42:26 INFO - Initialising browser for dromaeo_css test... 20:42:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33480/getInfo.html -profile /tmp/tmpxXjsLY/profile 20:42:26 INFO - TEST-INFO | started process 13305 (/builds/slave/test/build/application/firefox/firefox http://localhost:33480/getInfo.html) 20:42:32 INFO - TEST-INFO | 13305: exit 0 20:42:32 INFO - Browser initialized. 20:42:32 INFO - Running cycle 1/1 for dromaeo_css test... 20:42:32 INFO - Using env: {'DISPLAY': ':0', 20:42:32 INFO - 'HOME': '/home/cltbld', 20:42:32 INFO - 'JSGC_DISABLE_POISONING': '1', 20:42:32 INFO - 'LANG': 'en_US.UTF-8', 20:42:32 INFO - 'LANGUAGE': 'en_US:en', 20:42:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 20:42:32 INFO - 'LOGNAME': 'cltbld', 20:42:32 INFO - 'MAIL': '/var/mail/cltbld', 20:42:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:42:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:42:32 INFO - 'MOZ_CRASHREPORTER': '1', 20:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 20:42:32 INFO - 'MOZ_NO_REMOTE': '1', 20:42:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:32 INFO - 'NO_EM_RESTART': '1', 20:42:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:32 INFO - 'PWD': '/builds/slave/test', 20:42:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:42:32 INFO - 'RUST_BACKTRACE': 'full', 20:42:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:42:32 INFO - 'SHELL': '/bin/bash', 20:42:32 INFO - 'SHLVL': '1', 20:42:32 INFO - 'STYLO_FORCE_DISABLED': '1', 20:42:32 INFO - 'TERM': 'linux', 20:42:32 INFO - 'TMOUT': '86400', 20:42:32 INFO - 'USER': 'cltbld', 20:42:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', 20:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:32 INFO - '_': '/tools/buildbot/bin/python'} 20:42:32 INFO - TEST-INFO | started process 13540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxXjsLY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:42:33 INFO - PID 13540 | 20:42:33 INFO - PID 13540 | (/builds/slave/test/build/application/firefox/firefox:13589): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:42:33 INFO - PID 13540 | 20:42:44 INFO - PID 13540 | RSS: Main: 140857344 20:42:44 INFO - PID 13540 | 20:45:40 INFO - PID 13540 | Cycle 1(1): loaded http://localhost:33480/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33480/tests/dromaeo/cssquery-ext.html) 20:45:41 INFO - PID 13540 | RSS: Main: 146649088 20:45:41 INFO - PID 13540 | 20:48:43 INFO - PID 13540 | Cycle 1(1): loaded http://localhost:33480/tests/dromaeo/cssquery-ext.html (next: http://localhost:33480/tests/dromaeo/cssquery-jquery.html) 20:48:43 INFO - PID 13540 | RSS: Main: 145031168 20:48:43 INFO - PID 13540 | 20:51:45 INFO - PID 13540 | Cycle 1(1): loaded http://localhost:33480/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33480/tests/dromaeo/cssquery-mootools.html) 20:51:46 INFO - PID 13540 | RSS: Main: 148492288 20:51:46 INFO - PID 13540 | 20:54:47 INFO - PID 13540 | Cycle 1(1): loaded http://localhost:33480/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33480/tests/dromaeo/cssquery-prototype.html) 20:54:48 INFO - PID 13540 | RSS: Main: 145252352 20:54:48 INFO - PID 13540 | 20:57:51 INFO - PID 13540 | Cycle 1(1): loaded http://localhost:33480/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33480/tests/dromaeo/cssquery-yui.html) 20:57:51 INFO - PID 13540 | RSS: Main: 148029440 20:57:51 INFO - PID 13540 | 21:00:53 INFO - PID 13540 | Cycle 1(1): loaded http://localhost:33480/tests/dromaeo/cssquery-yui.html (next: http://localhost:33480/tests/dromaeo/cssquery-dojo.html) 21:00:53 INFO - PID 13540 | RSS: Main: 150147072 21:00:53 INFO - PID 13540 | 21:00:53 INFO - PID 13540 | __start_tp_report 21:00:53 INFO - PID 13540 | _x_x_mozilla_page_load 21:00:53 INFO - PID 13540 | _x_x_mozilla_page_load_details 21:00:53 INFO - PID 13540 | |i|pagename|runs| 21:00:53 INFO - PID 13540 | |0;dojo.html;3910.0811309342307;3916.9412458813104;3928.450016997619;3931.960680393197;3949.3286141355966;6286.779962701306;6291.1821463209835;6293.807032969216;6427.807165785022;6451.9999400093;6348.555601107924;6380.3300653431415;6382.7446902123975;6503.252126005511;6520.478361731062;5695.373508914016;5791.82624521265;5798.420157984189;5828.446297601721;5829.213056237418;116.44160355318853;5456.372517160537;5696.401877802812;5816.360200377955;5823.06830907055;5706.743196556165;5727.34135574408;5745.712714364265;5785.566082543826;5792.71036448178;5715.971420142872;5716.971415142939;5785.334686511021;5790.218320526717;5797.594168408213;5638.182463542805;5691.4877661010705;5749.798757043483;5765.682887441189;5776.913346299809;6199.039148931878;6301.590396624205;6316.368363163693;6354.968225158845;6363.5863668861375;6741.831454213635;6821.488388370892;6825.931740682579;6837.213720422165;6843.486738494633;6873.140857392826;6888.448924086111;6890.44876409891;6896.137982752156;7010.614416207107;6365.458935990447;6458.741650334028;6465.644389558573;6480.6435646039445;6484.902726459107;7066.258042905421;7068.3991860691385;7082.256363081905;7158.785236442915;7160.283971602902;6710.127683401127;6740.595564266159;6806.93193068063;6826.52214345001;6863.828404289933;6806.18325800907;6877.6217308048535;6878.243393226741;6969.686364113627;6995.965020174866;6822.863542729117;6829.487788415889;6929.237783843773;6933.895991560131;6937.375636192767;6847.760328388483;6854.177498700188;6933.306669333027;6945.687444065029;6959.791206263821;4978.751062446863;5023.547880690755;5075.086484432763;5077.568406685473;5080.263361812516;4569.1547063793305;4595.425571803525;4644.605208557243;4646.721196728207;4684.578387945101;6273.435390814849;6366.872662546723;6378.075179099004;6449.935500645028;6458.806235812933;6703.396694297537;6849.965750171217;6864.622445765431;6939.583624982517;6952.791416257521;6270.6864656766975;6370.968145159337;6394.776182833579;6397.072424498421;6410.166678331787;5487.42382049887;5544.500994910397;5592.3009623797025;5624.831255062355;5643.294588176478;7097.82255443618;7103.6093014883645;7104.502684812117;7248.0939882514685;7249.492535522569;6895.069165662671;6902.171739391104;6957.965210174018;6979.092717946634;6986.54587451814;7134.85730285381;7160.641967901688;7231.963840180976;7237;7244.275572442924;6727.125473688585;6747.595144291358;6772.7290908365085;6834.1457317835275;6841.589504629738;6882.965585172042;6914.0320355149315;6916.654167291515;6917.965410172917;6956.721731130698;6651.434628056476;6661.16735408074;6662.766803161866;6737.191537015589;6750.25747167821;6594.10979517759;6614.801555953329;6677.632730199885;6684.63234522106;6686.06395104676;6466.967665161644;6604.603723776589;6605.9009114864275;6608.603483790988;6609.801705948829;6574.408303252731;6678.3989440950545;6707.128073350628;6707.295733947865;6794.320567943166;6520.608763474017;6596.538242322991;6612.371824676648;6616.437602803623;6618.503612229006 21:00:53 INFO - PID 13540 | |1;ext.html;976.5556671714367;1000.6897861662885;1013.3717095400852;1016.0804471952883;1023.6417253961115;43077.35383969243;43990;44034.119317613666;44064.77967610158;44065.339019914645;41508;44161.779191104;44445;44478.55521444784;44483.11033779322;8301.667933282677;8373.665053397857;8381.119982401851;8389.07720150783;8435.24082832545;8275.462094963808;8396.874046889301;8430.78923026923;8431;8435.620397082146;8395.244428001479;8515.105913879046;8515.914840851574;8522.062573116953;8526.87209691855;8347.248747612683;8384.790380240482;8417.326613870875;8444.775507551401;8447.02859171197;8188.385871059635;8259.545724985124;8260.545669988149;8271.751847444586;8277.255047045735;38861.22277554433;39164.60835391638;39511.60488395108;39553;39589.60410395888;3727.254549090193;3740.1397678533817;3752.6810221130963;3755.605661405568;3755.8497660093562;32268.838655806572;32477;32585.511217331758;32585.674143258737;32617;5385.246065550826;5390.865228369283;5415.296011518517;5449.536789372908;5489.890202195974;212965;216816;217617;218193;230403.9999999983;51917.48082519126;52278.47721522736;52377;52393.7380313096;52437.475625243256;54774.72612636991;54788.726056369465;54805;54815;55000.449995500334;14957.476488322856;15119.16844573559;15199.468018619295;15261.847381526264;15414.845851541566;12235.021198304114;12313.44589493475;12323.568675096329;12372.257664540157;12419;13582.660433489242;13754.518591849237;13769;13789.724205515833;13974.58076257714;5233.764480598306;5269.341332333458;5346;5362.624616276901;5386.057439947994;1068.8450174724621;1083.496174278964;1086.9402182880017;1092.7268182954263;1100.0264765682268;24974.750252497244;25141.497170056497;25297.87351063233;25322.873385632953;25346.493070138862;1177.3053898200103;1189.2567145534042;1192.0761409907218;1197.1799317467562;1199.1306302930307;13461.730765384638;13464.730705386033;13516.053876228569;13518.324083795771;13546.864531354757;285395;286286;287386;287581;287635;55307.44692553103;55493.44506554963;55594.72202639042;55680.88638227294;55885;1491.9776203356957;1501.924903754808;1530.6402995296096;1536.8155821301516;1551.67414842882;24699.516831050565;24857.87571062133;24907.62638560459;24957.876895539383;24984.625230621918;35334.64665353416;38981.8050909755;39335.60664393319;39369.212615746954;39413;233190;234259;234709;234810;235287;32241.51637725483;32557.18607034843;35488.290234194654;35722.10694732652;35759.64240357667;45084.54915450804;45500.772496138634;45565.54434455613;45652;45850.77074614605;33567;34063;34066.489002664486;34074;34373.312533748685;33669.49495757517;33811.323773524884;34157.829210853786;34210.82894585511;34265;39170.80414597909;39192;39207.80396098001;39520.60479395284;39646.60353396429;33072.50391244181;33085.66914330922;33244;33282.83358583192;33668.326633466706;24410.633840492053;24663.753362466145;25182.244532664048;25264.873675631505;25341.239762807145 21:00:53 INFO - PID 13540 | |2;jquery.html;625.4589779840439;629.5844742469969;633.7211626884168;634.5589815078522;647.0876064748705;22285.108595656173;22905.31284061481;23038.308850734484;23061;23178.88410557949;22982.19562315315;23401.18095866645;23418.88290558549;23426.180083697072;23493.647595286042;6370.2355717313985;6536.803895883131;6557.245916719567;6560.737570497175;6561.311062338457;6651.733930642768;6874.106366172416;6927.134108236471;6941.444684425234;6950.582965022089;6846.7945961621235;6857.622830744307;6862.073620061277;6875.724971001154;6888.517803753739;6598.175228096488;6884.449244060464;6885.724571017154;6897.827554311158;6909.447244220451;6423.87152256957;6433.035044743279;6437.774677886298;6440.677966101723;6460.741570337181;30177.396452070836;30720.53919191214;30726.692733072607;30740.69259307423;30742.38515229705;2287.6797248385237;2301.8158547316343;2328.5342931413616;2330.172788660035;2331.5453486570127;20244;20954.16183352664;21159.894200529052;21162.682559761615;21174.894125529274;2480.379905023744;2523.873806309677;2566.217303722364;2595.4160313929406;2603.075908052652;126203;131208;131279;145965;153522.23238883846;15225.847741522442;15783.842161578466;15800.762988555181;16300.184990750415;17020.404285850185;26298.21105366842;26372.8681356592;26373.208803735917;26412.603810942852;26469.411835289946;10242.795144097225;10285.794284114276;10345.896541034645;10521.053105220566;10524.26330156897;9251.861222081674;9298;9310.953445232866;9366.578503967337;9458.43249405038;9570.425774453555;9613;9722.854157187649;9951.507273908972;10009.549570269355;2890.7398334150025;2901.839264294299;2904.941901162007;2921.7954743168198;2941.352902361477;1051.3376572759112;1059.5073290919759;1078.4984981983416;1084.2843723142687;1086.652271273185;21583.784162158492;21802.672959905613;21859.234926777488;21897.343079707633;21919.780802192094;1115.5649296774266;1122.5509796081633;1127.2729089737074;1127.5095333529778;1135.73310272086;11966.341851198267;12046.819297710541;12062.276263424223;12127.603216568543;12207.633770986884;582466.3506729841;588627;589579;593246;601988;128487;129892;130023;130900;131279.34360328328;1208.4501551793912;1211.7758214730127;1225.375058720059;1225.9141860069888;1229.2194456520174;19277.22891084341;19326.226950921806;19629.80370196337;20082.196712131936;20083.09626066801;56133;58141;58589.4141058584;58888.70555647194;60309.19072427834;74569;74651;74885.25114748783;75132.62433687797;75268.62365688136;14981.850181498046;16182.271797768894;16202.918985404998;16231.918840405722;16456.83543164553;24158.87920560386;24477.143299984415;24832.255032349058;24866.875665621556;24892.62661060122;19716.21135154635;20055.59888802245;20452;20583.176672933514;20659.276925307542;16809;17540;17716.64566708633;17723.911380443533;17864.285428583233;20609.58780824405;20620.58758824845;20643.4839129023;20764.79235207689;20963.26628567993;14894.180820055;16035.438759643823;16146.273417696466;16177.67644647124;16205.59486012859;20226.39320820378;20383.286584969454;20388;20411.081501332177;20424.18303267912 21:00:53 INFO - PID 13540 | |3;mootools.html;1200.8619008813987;1438.8417274099847;1451.804006459129;1493.2459108150383;1500.122428379398;16603.667926641476;17222.22499987499;17237.310507579714;17248.827511724878;17258.309667613295;16873.493795186132;16880.746788798177;16954.491365259062;16968.915155424238;16990.575235619115;2870.5550639650887;2894.799952036457;2921.693222211669;2934.1490967619366;2953.3354995126033;2921.2258751430886;2928.0337488628807;2935.4716151092794;2938.4563855686765;2940.1326608650393;2867.8996235131776;2911.8689658965395;2932.4868148074;2981.105668299512;2981.493146165157;2908.694587068359;2934.3251052257992;2941.5440606705993;2946.2928897064767;2960.1119664100793;2874.798764086515;3001.444732724431;3001.504751715986;3004.7145521175453;3014.5779590857296;16583.751243731353;16761.7485737714;16817.747733784003;16827.579310517212;16884.83115168845;8359.122292159358;8566.957165214197;8608.827823443558;8635.740927772176;8639.481631102153;5654.688992105433;5895.970520147414;6065;6102.908456373158;6109.297430795471;2143.689165071056;2145.174107968428;2169.858959167649;2201.746799118106;2216.0581752755015;30918.38163236745;31181.376372472423;31197.688023119706;31213;31249.687503124904;7172.892406613905;7418.591977441185;7490.325870671557;7610.733624323233;7623.504472209289;19836;19966.50083747918;19996.50008749793;20003.199872005247;20013.299534516224;8118.634661440249;8278.793030174294;8303.95848020768;8309.709160179485;8313.916860831436;7414.406847452191;7466.141393739681;7523.172451030382;7709.6530656119485;7713.382929365637;5743.10981797822;5842.328132264844;5921.73352199152;5968.731407086691;5982.0727787193055;1680.23549285075;1709.7948246210285;1722.2163915418455;1755.6752000879878;1757.9033153176697;955.0926619711302;963.8939716631165;982.4547376206132;985.3348989432104;987.8863930648067;8292.37807164453;8326.70856520019;8356.247937685515;8359.540225287546;8398.076211616717;745.9962700186464;759.6201899050475;767.7504810936356;781.2304879693497;813.5606772342987;5055.747212639353;5808.361080281165;5871.823845284648;5979.19280897082;6024.518038556905;24914.252572422494;25774.613380799303;25848.8707556461;26004.08985685492;26102.34744131412;24509.754902450746;25210;25504.362390940005;25652.102176423734;25655.10207142741;12495.875041249654;12711.745765084646;12772.872271277169;12786.232826030653;12787.488500459878;9385.249180065715;9409;9477.810443790948;9500.239980801382;9541.522923853641;21331.78668213298;21547;21645.242416515346;21692.45768855791;21945.341639750834;21950.45123871916;22368.328950131523;22395;22482.5503489926;22522.32433026946;12591.181573197713;12758.425870835648;12762.553310634083;12843.35783210817;12894;15577.688446230784;15920.761188582412;15925.761113583074;15969.361225550847;15984.600384990468;12584.244945303311;12732.172408793398;12740.4266807992;12880.098393112392;13024.11150383208;12215.877841221474;12406.379681015733;12424.937875310565;12460.376981151088;12529.93735031319;10810.45947702596;11136.777264454828;11143;11144.33134011962;11148.498317575566;8330.875036874573;8425.410221284452;8433.915660843313;8535.658573656985;8578.699745508877;8170;8195.67217311301;8238.546879921661;8259.256666900008;8280.848729648047 21:00:53 INFO - PID 13540 | |4;prototype.html;537.7929497143601;563.2480638347805;576.6453631016926;582.7115577788995;591.2550186764676;6143.81568552943;6221.813345599639;6274.717637706302;6300.401461861122;6361.395667411594;6135.969320153393;6167.845803854894;6191.380861913806;6219.191505104342;6297.3387794281625;4954.7274899880495;5076.832328564433;5082.415522214947;5126.846194614168;5150.665206761567;5046.142155833517;5064.645474816764;5069.594432445396;5080.390353157626;5089.083964886319;4947.901041979158;4956.529129732688;4961.3798275215595;4971.651984361096;5030.723310217936;4962.724601762838;5035.320231768719;5040.84877453677;5051.646384753069;5064.873378165576;4515.61617262533;4606.746628935407;4608.101420223058;4614.353990441341;4634.2121839287065;6094.573379863411;6137.508999280047;6174.567780255384;6280.120783090371;6327.145835312266;5837.299524057098;5857.47282744555;5868.41315868414;5878.412828536271;5932.228810254639;6694.966525167391;6700.39696427319;6724.125863637744;6726.663666816639;6730.1923769147525;4845.927311090337;5093.872653183663;5097.337346145015;5097.668651537638;5106.693598384109;6789.796306110825;6794.218664853555;6881.759138430181;6889.448844092461;6944.930550694479;5144.768485418165;5153.098207813618;5156.484351564888;5169.612279079084;5203.739813009334;5198.298229738937;5247.399543139379;5258.342707161605;5263.6315457918345;5278.81524146653;5825.786201243501;5840.240768700041;5865.88268234633;5902.8819423611285;5904.7342869570975;6609.521429463951;6680.3987641112535;6685.526355248492;6773.830654233683;6793.9385158056575;1788.5691446842734;1805.9819401806076;1810.8008119106887;1822.17091223493;1836.7336736173181;1220.5300959130798;1256.4848412150975;1268.7589358021946;1270.4219580091037;1280.5966120671958;6204.410580994799;6234.812955611339;6237.4758261582065;6241.531885108635;6268.4671802896355;6708.865822683519;6770.966145169243;6791.966040169767;6838.418734407532;6851.246362900077;6050.727717252734;6102.786402475981;6184.783532576338;6255.374462553799;6283.560150789493;3518.20840310928;3520.876769313113;3524.22467057247;3543.8459770804006;3607.2424790794225;6908.618276344751;6988.790336289818;7020.719171233196;7051.89422158668;7166.820829479305;6822;6942.826429339206;6948.305169483011;6984.79045628632;7051.1186101737285;6941.826454338682;6994.125734283316;7096.361327480551;7121.323474269936;7129.714811407589;6667.966660166668;6732.394084532416;6772.796816095328;6799.5920244785475;6802.693878775368;6680.665966701548;6698.196216454056;6702.832429189114;6709.597424154371;6734.8653026940165;7039.577625342496;7047.7180912762915;7061.894071589033;7090.242171649034;7113.181984071691;5233.947660523346;5248.553872920692;5250.527452529291;5255.710935898409;5261.947380526146;6513.511486638616;6713.328667133248;6827.829304267433;6853.760118395832;6886.24251332343;6275.37246275387;6538.934610653832;6595.340465953366;6610.702518386588;6611.2727599963;6447.484201263794;6562.934370656232;6566.277709451861;6586.868262634624;6655.800325990228;6296.968515157395;6339.207599050119;6461.8061458156335;6503.934960650522;6542.443892269211;6508.219013718384;6538;6720.1599800025;6748;6754.290799465985;6400.903986440114;6422.678866056772;6427.164468619049;6467.126937863328;6501.44737697301 21:00:53 INFO - PID 13540 | |5;yui.html;934.5374039850275;939.267371450269;950.3632566180659;976.3604838830565;1005.0954141272852;19056.809431905676;20487.48781280465;20546.794532054675;20578.176872925083;20583.897080514595;18708.906455467702;19038;19078.141483633237;19116.33092841751;19144.13851376688;1066.7599790047236;1085.7665601895592;1087.2823936202108;1088.17298852872;1089.1341383600056;1091.3724608350192;1092.6012005617931;1092.6066616018227;1092.819684752015;1093.8577984861956;1090.4220762995626;1114.83834843948;1129.3449799116493;1132.3092913322866;1133.8696049954237;1118.7650593375402;1120.7646394257215;1123.1183520936027;1124.2973141786342;1125.2741981421977;802.257911431929;811.0065170166557;812.9349652027823;827.1893544326533;833.8874251976027;21177.8941105295;21277.25529606472;21294.148234070773;21350.679739803916;21438.464038399008;20891.37325880226;21146.365609031753;21912.89043554772;22064;22065.889670551704;18732.719009214874;18759.43721688338;18998.24007039717;19180.13689383981;19255.90372048145;3940.7241493095494;3958.34687276599;3965.7422267552806;3970.622790834895;3972.404139379087;131050;156629;156986;161092.19453902656;161172.38827611692;18729.25082996692;18925.14836832346;18935.43193704191;19274.132664030152;19286.903565482084;34717;35088.64911350905;35120.824395877855;35435.645643543234;35566.46650300248;9840.557174927146;9858.30991830565;9876.703698889045;9921.206303495703;9935.552900119512;4447.488538818077;4504.909901801946;4533.025399539115;4549.909001819945;4572.268437050123;5847.064469684915;5942.1978032965;5952.523798096228;5959.523238140939;5963.896679114378;1136.3522792008475;1158.223989926751;1173.2198088271375;1177.9469923853446;1186.104491109207;684.0560027162484;689.1110467496973;698.8357735932052;707.745211723779;710.0662628643317;12544.372781361079;12810.871891281155;13147.211167329991;13860.58418247434;13969.371378288002;663.6947004377944;664.3987191591617;666.3935818405228;674.7166190200128;681.1485642946317;5533.972330138324;5591.9720401397735;5623.887522249532;5655.971720141373;5767.423257674199;148266;149059;152340.23829881;153783;158493;126422;127569;127793;130716;136405.3179734095;107595.46202268939;113236;113761.43119284516;116542;119184;13531;13862.861371386158;13889.861101388857;13966.371513281723;13977.161370317814;53639.19541206963;53872;54568.72715636555;54723.72638136784;54970.175447367525;73555;73659;74448.62775686303;75994.24005760092;76085;17787.73318400199;17953.461396158134;18433.26266949307;18520;18584.81415185885;21277.574448510633;21331.57336853223;21432.357029289145;21449.24927627588;21675.566488670454;19208;19626.411207663794;19751.111199995747;19919.60160796805;20094.19623215055;18524.81475185285;18700.81299186991;18731.06344682733;18821.435356939313;18928.52678683044;19385.321513746952;19447.416577502696;19615.70576441326;19678;19919.502012449804;14237.430502779773;14313.141211527342;14420.134791912518;14472.276386180438;14552;14824.925875370554;14849.257537122885;14865.925670371578;14959.40162393492;14963.102213867203 21:00:53 INFO - PID 13540 | __end_tp_report 21:00:53 INFO - PID 13540 | __start_cc_report 21:00:53 INFO - PID 13540 | _x_x_mozilla_cycle_collect,277 21:00:53 INFO - PID 13540 | __end_cc_report 21:00:53 INFO - PID 13540 | __startTimestamp1506225653567__endTimestamp 21:00:53 INFO - PID 13540 | 21:00:53 INFO - PID 13540 | ------- Summary: start ------- 21:00:53 INFO - PID 13540 | Number of tests: 6 21:00:53 INFO - PID 13540 | 21:00:53 INFO - PID 13540 | [#0] dojo.html Cycles:165 Average:6317.71 Median:6608.60 stddev:888.55 (13.4%) stddev-sans-first:870.97 21:00:53 INFO - PID 13540 | Values: 3910.1 3916.9 3928.5 3932.0 3949.3 6286.8 6291.2 6293.8 6427.8 6452.0 6348.6 6380.3 6382.7 6503.3 6520.5 5695.4 5791.8 5798.4 5828.4 5829.2 116.4 5456.4 5696.4 5816.4 5823.1 5706.7 5727.3 5745.7 5785.6 5792.7 5716.0 5717.0 5785.3 5790.2 5797.6 5638.2 5691.5 5749.8 5765.7 5776.9 6199.0 6301.6 6316.4 6355.0 6363.6 6741.8 6821.5 6825.9 6837.2 6843.5 6873.1 6888.4 6890.4 6896.1 7010.6 6365.5 6458.7 6465.6 6480.6 6484.9 7066.3 7068.4 7082.3 7158.8 7160.3 6710.1 6740.6 6806.9 6826.5 6863.8 6806.2 6877.6 6878.2 6969.7 6996.0 6822.9 6829.5 6929.2 6933.9 6937.4 6847.8 6854.2 6933.3 6945.7 6959.8 4978.8 5023.5 5075.1 5077.6 5080.3 4569.2 4595.4 4644.6 4646.7 4684.6 6273.4 6366.9 6378.1 6449.9 6458.8 6703.4 6850.0 6864.6 6939.6 6952.8 6270.7 6371.0 6394.8 6397.1 6410.2 5487.4 5544.5 5592.3 5624.8 5643.3 7097.8 7103.6 7104.5 7248.1 7249.5 6895.1 6902.2 6958.0 6979.1 6986.5 7134.9 7160.6 7232.0 7237.0 7244.3 6727.1 6747.6 6772.7 6834.1 6841.6 6883.0 6914.0 6916.7 6918.0 6956.7 6651.4 6661.2 6662.8 6737.2 6750.3 6594.1 6614.8 6677.6 6684.6 6686.1 6467.0 6604.6 6605.9 6608.6 6609.8 6574.4 6678.4 6707.1 6707.3 6794.3 6520.6 6596.5 6612.4 6616.4 6618.5 21:00:53 INFO - PID 13540 | 21:00:53 INFO - PID 13540 | [#1] ext.html Cycles:180 Average:42023.74 Median:34853.98 stddev:64689.77 (185.6%) stddev-sans-first:64797.82 21:00:53 INFO - PID 13540 | Values: 976.6 1000.7 1013.4 1016.1 1023.6 43077.4 43990.0 44034.1 44064.8 44065.3 41508.0 44161.8 44445.0 44478.6 44483.1 8301.7 8373.7 8381.1 8389.1 8435.2 8275.5 8396.9 8430.8 8431.0 8435.6 8395.2 8515.1 8515.9 8522.1 8526.9 8347.2 8384.8 8417.3 8444.8 8447.0 8188.4 8259.5 8260.5 8271.8 8277.3 38861.2 39164.6 39511.6 39553.0 39589.6 3727.3 3740.1 3752.7 3755.6 3755.8 32268.8 32477.0 32585.5 32585.7 32617.0 5385.2 5390.9 5415.3 5449.5 5489.9 212965.0 216816.0 217617.0 218193.0 230404.0 51917.5 52278.5 52377.0 52393.7 52437.5 54774.7 54788.7 54805.0 54815.0 55000.4 14957.5 15119.2 15199.5 15261.8 15414.8 12235.0 12313.4 12323.6 12372.3 12419.0 13582.7 13754.5 13769.0 13789.7 13974.6 5233.8 5269.3 5346.0 5362.6 5386.1 1068.8 1083.5 1086.9 1092.7 1100.0 24974.8 25141.5 25297.9 25322.9 25346.5 1177.3 1189.3 1192.1 1197.2 1199.1 13461.7 13464.7 13516.1 13518.3 13546.9 285395.0 286286.0 287386.0 287581.0 287635.0 55307.4 55493.4 55594.7 55680.9 55885.0 1492.0 1501.9 1530.6 1536.8 1551.7 24699.5 24857.9 24907.6 24957.9 24984.6 35334.6 38981.8 39335.6 39369.2 39413.0 233190.0 234259.0 234709.0 234810.0 235287.0 32241.5 32557.2 35488.3 35722.1 35759.6 45084.5 45500.8 45565.5 45652.0 45850.8 33567.0 34063.0 34066.5 34074.0 34373.3 33669.5 33811.3 34157.8 34210.8 34265.0 39170.8 39192.0 39207.8 39520.6 39646.6 33072.5 33085.7 33244.0 33282.8 33668.3 24410.6 24663.8 25182.2 25264.9 25341.2 21:00:53 INFO - PID 13540 | 21:00:53 INFO - PID 13540 | [#2] jquery.html Cycles:180 Average:38787.39 Median:12670.06 stddev:98594.93 (778.2%) stddev-sans-first:98829.88 21:00:53 INFO - PID 13540 | Values: 625.5 629.6 633.7 634.6 647.1 22285.1 22905.3 23038.3 23061.0 23178.9 22982.2 23401.2 23418.9 23426.2 23493.6 6370.2 6536.8 6557.2 6560.7 6561.3 6651.7 6874.1 6927.1 6941.4 6950.6 6846.8 6857.6 6862.1 6875.7 6888.5 6598.2 6884.4 6885.7 6897.8 6909.4 6423.9 6433.0 6437.8 6440.7 6460.7 30177.4 30720.5 30726.7 30740.7 30742.4 2287.7 2301.8 2328.5 2330.2 2331.5 20244.0 20954.2 21159.9 21162.7 21174.9 2480.4 2523.9 2566.2 2595.4 2603.1 126203.0 131208.0 131279.0 145965.0 153522.2 15225.8 15783.8 15800.8 16300.2 17020.4 26298.2 26372.9 26373.2 26412.6 26469.4 10242.8 10285.8 10345.9 10521.1 10524.3 9251.9 9298.0 9311.0 9366.6 9458.4 9570.4 9613.0 9722.9 9951.5 10009.5 2890.7 2901.8 2904.9 2921.8 2941.4 1051.3 1059.5 1078.5 1084.3 1086.7 21583.8 21802.7 21859.2 21897.3 21919.8 1115.6 1122.6 1127.3 1127.5 1135.7 11966.3 12046.8 12062.3 12127.6 12207.6 582466.4 588627.0 589579.0 593246.0 601988.0 128487.0 129892.0 130023.0 130900.0 131279.3 1208.5 1211.8 1225.4 1225.9 1229.2 19277.2 19326.2 19629.8 20082.2 20083.1 56133.0 58141.0 58589.4 58888.7 60309.2 74569.0 74651.0 74885.3 75132.6 75268.6 14981.9 16182.3 16202.9 16231.9 16456.8 24158.9 24477.1 24832.3 24866.9 24892.6 19716.2 20055.6 20452.0 20583.2 20659.3 16809.0 17540.0 17716.6 17723.9 17864.3 20609.6 20620.6 20643.5 20764.8 20963.3 14894.2 16035.4 16146.3 16177.7 16205.6 20226.4 20383.3 20388.0 20411.1 20424.2 21:00:53 INFO - PID 13540 | 21:00:53 INFO - PID 13540 | [#3] mootools.html Cycles:180 Average:10564.11 Median:2916.55 stddev:7858.24 (269.4%) stddev-sans-first:7848.80 21:00:53 INFO - PID 13540 | Values: 1200.9 1438.8 1451.8 1493.2 1500.1 16603.7 17222.2 17237.3 17248.8 17258.3 16873.5 16880.7 16954.5 16968.9 16990.6 2870.6 2894.8 2921.7 2934.1 2953.3 2921.2 2928.0 2935.5 2938.5 2940.1 2867.9 2911.9 2932.5 2981.1 2981.5 2908.7 2934.3 2941.5 2946.3 2960.1 2874.8 3001.4 3001.5 3004.7 3014.6 16583.8 16761.7 16817.7 16827.6 16884.8 8359.1 8567.0 8608.8 8635.7 8639.5 5654.7 5896.0 6065.0 6102.9 6109.3 2143.7 2145.2 2169.9 2201.7 2216.1 30918.4 31181.4 31197.7 31213.0 31249.7 7172.9 7418.6 7490.3 7610.7 7623.5 19836.0 19966.5 19996.5 20003.2 20013.3 8118.6 8278.8 8304.0 8309.7 8313.9 7414.4 7466.1 7523.2 7709.7 7713.4 5743.1 5842.3 5921.7 5968.7 5982.1 1680.2 1709.8 1722.2 1755.7 1757.9 955.1 963.9 982.5 985.3 987.9 8292.4 8326.7 8356.2 8359.5 8398.1 746.0 759.6 767.8 781.2 813.6 5055.7 5808.4 5871.8 5979.2 6024.5 24914.3 25774.6 25848.9 26004.1 26102.3 24509.8 25210.0 25504.4 25652.1 25655.1 12495.9 12711.7 12772.9 12786.2 12787.5 9385.2 9409.0 9477.8 9500.2 9541.5 21331.8 21547.0 21645.2 21692.5 21945.3 21950.5 22368.3 22395.0 22482.6 22522.3 12591.2 12758.4 12762.6 12843.4 12894.0 15577.7 15920.8 15925.8 15969.4 15984.6 12584.2 12732.2 12740.4 12880.1 13024.1 12215.9 12406.4 12424.9 12460.4 12529.9 10810.5 11136.8 11143.0 11144.3 11148.5 8330.9 8425.4 8433.9 8535.7 8578.7 8170.0 8195.7 8238.5 8259.3 8280.8 21:00:53 INFO - PID 13540 | 21:00:53 INFO - PID 13540 | [#4] prototype.html Cycles:180 Average:5652.36 Median:6248.45 stddev:1582.39 (25.3%) stddev-sans-first:1539.56 21:00:53 INFO - PID 13540 | Values: 537.8 563.2 576.6 582.7 591.3 6143.8 6221.8 6274.7 6300.4 6361.4 6136.0 6167.8 6191.4 6219.2 6297.3 4954.7 5076.8 5082.4 5126.8 5150.7 5046.1 5064.6 5069.6 5080.4 5089.1 4947.9 4956.5 4961.4 4971.7 5030.7 4962.7 5035.3 5040.8 5051.6 5064.9 4515.6 4606.7 4608.1 4614.4 4634.2 6094.6 6137.5 6174.6 6280.1 6327.1 5837.3 5857.5 5868.4 5878.4 5932.2 6695.0 6700.4 6724.1 6726.7 6730.2 4845.9 5093.9 5097.3 5097.7 5106.7 6789.8 6794.2 6881.8 6889.4 6944.9 5144.8 5153.1 5156.5 5169.6 5203.7 5198.3 5247.4 5258.3 5263.6 5278.8 5825.8 5840.2 5865.9 5902.9 5904.7 6609.5 6680.4 6685.5 6773.8 6793.9 1788.6 1806.0 1810.8 1822.2 1836.7 1220.5 1256.5 1268.8 1270.4 1280.6 6204.4 6234.8 6237.5 6241.5 6268.5 6708.9 6771.0 6792.0 6838.4 6851.2 6050.7 6102.8 6184.8 6255.4 6283.6 3518.2 3520.9 3524.2 3543.8 3607.2 6908.6 6988.8 7020.7 7051.9 7166.8 6822.0 6942.8 6948.3 6984.8 7051.1 6941.8 6994.1 7096.4 7121.3 7129.7 6668.0 6732.4 6772.8 6799.6 6802.7 6680.7 6698.2 6702.8 6709.6 6734.9 7039.6 7047.7 7061.9 7090.2 7113.2 5233.9 5248.6 5250.5 5255.7 5261.9 6513.5 6713.3 6827.8 6853.8 6886.2 6275.4 6538.9 6595.3 6610.7 6611.3 6447.5 6562.9 6566.3 6586.9 6655.8 6297.0 6339.2 6461.8 6503.9 6542.4 6508.2 6538.0 6720.2 6748.0 6754.3 6400.9 6422.7 6427.2 6467.1 6501.4 21:00:53 INFO - PID 13540 | 21:00:53 INFO - PID 13540 | [#5] yui.html Cycles:180 Average:28526.30 Median:19265.02 stddev:41816.32 (217.1%) stddev-sans-first:41882.30 21:00:53 INFO - PID 13540 | Values: 934.5 939.3 950.4 976.4 1005.1 19056.8 20487.5 20546.8 20578.2 20583.9 18708.9 19038.0 19078.1 19116.3 19144.1 1066.8 1085.8 1087.3 1088.2 1089.1 1091.4 1092.6 1092.6 1092.8 1093.9 1090.4 1114.8 1129.3 1132.3 1133.9 1118.8 1120.8 1123.1 1124.3 1125.3 802.3 811.0 812.9 827.2 833.9 21177.9 21277.3 21294.1 21350.7 21438.5 20891.4 21146.4 21912.9 22064.0 22065.9 18732.7 18759.4 18998.2 19180.1 19255.9 3940.7 3958.3 3965.7 3970.6 3972.4 131050.0 156629.0 156986.0 161092.2 161172.4 18729.3 18925.1 18935.4 19274.1 19286.9 34717.0 35088.6 35120.8 35435.6 35566.5 9840.6 9858.3 9876.7 9921.2 9935.6 4447.5 4504.9 4533.0 4549.9 4572.3 5847.1 5942.2 5952.5 5959.5 5963.9 1136.4 1158.2 1173.2 1177.9 1186.1 684.1 689.1 698.8 707.7 710.1 12544.4 12810.9 13147.2 13860.6 13969.4 663.7 664.4 666.4 674.7 681.1 5534.0 5592.0 5623.9 5656.0 5767.4 148266.0 149059.0 152340.2 153783.0 158493.0 126422.0 127569.0 127793.0 130716.0 136405.3 107595.5 113236.0 113761.4 116542.0 119184.0 13531.0 13862.9 13889.9 13966.4 13977.2 53639.2 53872.0 54568.7 54723.7 54970.2 73555.0 73659.0 74448.6 75994.2 76085.0 17787.7 17953.5 18433.3 18520.0 18584.8 21277.6 21331.6 21432.4 21449.2 21675.6 19208.0 19626.4 19751.1 19919.6 20094.2 18524.8 18700.8 18731.1 18821.4 18928.5 19385.3 19447.4 19615.7 19678.0 19919.5 14237.4 14313.1 14420.1 14472.3 14552.0 14824.9 14849.3 14865.9 14959.4 14963.1 21:00:53 INFO - PID 13540 | -------- Summary: end -------- 21:00:53 INFO - PID 13540 | 21:00:54 INFO - TEST-INFO | 13540: exit 0 21:00:54 INFO - TEST-OK | dromaeo_css | took 1107477ms 21:00:54 INFO - TEST-START | kraken 21:00:54 INFO - Initialising browser for kraken test... 21:00:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33480/getInfo.html -profile /tmp/tmpSjcBzU/profile 21:00:54 INFO - TEST-INFO | started process 13906 (/builds/slave/test/build/application/firefox/firefox http://localhost:33480/getInfo.html) 21:00:59 INFO - TEST-INFO | 13906: exit 0 21:00:59 INFO - Browser initialized. 21:00:59 INFO - Running cycle 1/1 for kraken test... 21:00:59 INFO - Using env: {'DISPLAY': ':0', 21:00:59 INFO - 'HOME': '/home/cltbld', 21:00:59 INFO - 'JSGC_DISABLE_POISONING': '1', 21:00:59 INFO - 'LANG': 'en_US.UTF-8', 21:00:59 INFO - 'LANGUAGE': 'en_US:en', 21:00:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:00:59 INFO - 'LOGNAME': 'cltbld', 21:00:59 INFO - 'MAIL': '/var/mail/cltbld', 21:00:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:00:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:00:59 INFO - 'MOZ_CRASHREPORTER': '1', 21:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:00:59 INFO - 'MOZ_NO_REMOTE': '1', 21:00:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:59 INFO - 'NO_EM_RESTART': '1', 21:00:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:59 INFO - 'PWD': '/builds/slave/test', 21:00:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:00:59 INFO - 'RUST_BACKTRACE': 'full', 21:00:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:00:59 INFO - 'SHELL': '/bin/bash', 21:00:59 INFO - 'SHLVL': '1', 21:00:59 INFO - 'STYLO_FORCE_DISABLED': '1', 21:00:59 INFO - 'TERM': 'linux', 21:00:59 INFO - 'TMOUT': '86400', 21:00:59 INFO - 'USER': 'cltbld', 21:00:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534', 21:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:59 INFO - '_': '/tools/buildbot/bin/python'} 21:00:59 INFO - TEST-INFO | started process 14142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSjcBzU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:01:00 INFO - PID 14142 | 21:01:00 INFO - PID 14142 | (/builds/slave/test/build/application/firefox/firefox:14192): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:01:00 INFO - PID 14142 | 21:01:10 INFO - PID 14142 | RSS: Main: 144859136 21:01:10 INFO - PID 14142 | 21:01:13 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33480/tests/kraken/driver.html?testName=audio-beat-detection) 21:01:14 INFO - PID 14142 | RSS: Main: 150622208 21:01:14 INFO - PID 14142 | 21:01:16 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33480/tests/kraken/driver.html?testName=audio-dft) 21:01:17 INFO - PID 14142 | RSS: Main: 150917120 21:01:17 INFO - PID 14142 | 21:01:20 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33480/tests/kraken/driver.html?testName=audio-fft) 21:01:20 INFO - PID 14142 | RSS: Main: 147390464 21:01:20 INFO - PID 14142 | 21:01:22 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33480/tests/kraken/driver.html?testName=audio-oscillator) 21:01:23 INFO - PID 14142 | RSS: Main: 149024768 21:01:23 INFO - PID 14142 | 21:01:25 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33480/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:01:26 INFO - PID 14142 | RSS: Main: 148406272 21:01:26 INFO - PID 14142 | 21:01:29 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33480/tests/kraken/driver.html?testName=imaging-darkroom) 21:01:29 INFO - PID 14142 | RSS: Main: 148267008 21:01:29 INFO - PID 14142 | 21:01:33 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33480/tests/kraken/driver.html?testName=imaging-desaturate) 21:01:34 INFO - PID 14142 | RSS: Main: 149962752 21:01:34 INFO - PID 14142 | 21:01:36 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33480/tests/kraken/driver.html?testName=json-parse-financial) 21:01:37 INFO - PID 14142 | RSS: Main: 152129536 21:01:37 INFO - PID 14142 | 21:01:39 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33480/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:01:39 INFO - PID 14142 | RSS: Main: 151236608 21:01:39 INFO - PID 14142 | 21:01:41 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33480/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:01:41 INFO - PID 14142 | RSS: Main: 151252992 21:01:41 INFO - PID 14142 | 21:01:43 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33480/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:01:44 INFO - PID 14142 | RSS: Main: 148271104 21:01:44 INFO - PID 14142 | 21:01:46 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:01:47 INFO - PID 14142 | RSS: Main: 148455424 21:01:47 INFO - PID 14142 | 21:01:50 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:01:50 INFO - PID 14142 | RSS: Main: 149049344 21:01:50 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | Cycle 1(1): loaded http://localhost:33480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33480/tests/kraken/driver.html?testName=ai-astar) 21:01:52 INFO - PID 14142 | RSS: Main: 150261760 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | __start_tp_report 21:01:52 INFO - PID 14142 | _x_x_mozilla_page_load 21:01:52 INFO - PID 14142 | _x_x_mozilla_page_load_details 21:01:52 INFO - PID 14142 | |i|pagename|runs| 21:01:52 INFO - PID 14142 | |0;ai-astar;105;105;104;106;104;108;106;104;105;104 21:01:52 INFO - PID 14142 | |1;audio-beat-detection;114;114;111;110;111;115;114;118;112;116 21:01:52 INFO - PID 14142 | |2;audio-dft;163;163;159;162;160;161;162;162;163;162 21:01:52 INFO - PID 14142 | |3;audio-fft;74;74;73;73;71;73;73;74;73;73 21:01:52 INFO - PID 14142 | |4;audio-oscillator;83;80;78;77;77;78;77;76;77;78 21:01:52 INFO - PID 14142 | |5;imaging-gaussian-blur;116;113;110;113;115;114;114;114;113;114 21:01:52 INFO - PID 14142 | |6;imaging-darkroom;152;148;149;150;148;152;149;149;149;151 21:01:52 INFO - PID 14142 | |7;imaging-desaturate;99;97;95;96;94;94;94;94;94;94 21:01:52 INFO - PID 14142 | |8;json-parse-financial;45;44;46;45;45;45;51;42;43;43 21:01:52 INFO - PID 14142 | |9;json-stringify-tinderbox;35;35;35;35;36;35;36;36;35;36 21:01:52 INFO - PID 14142 | |10;stanford-crypto-aes;78;74;75;73;74;73;77;73;74;72 21:01:52 INFO - PID 14142 | |11;stanford-crypto-ccm;105;109;108;108;112;105;112;112;108;119 21:01:52 INFO - PID 14142 | |12;stanford-crypto-pbkdf2;152;151;159;151;159;149;151;150;148;149 21:01:52 INFO - PID 14142 | |13;stanford-crypto-sha256-iterative;58;62;60;60;59;62;63;61;61;59 21:01:52 INFO - PID 14142 | __end_tp_report 21:01:52 INFO - PID 14142 | __start_cc_report 21:01:52 INFO - PID 14142 | _x_x_mozilla_cycle_collect,706 21:01:52 INFO - PID 14142 | __end_cc_report 21:01:52 INFO - PID 14142 | __startTimestamp1506225712781__endTimestamp 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | ------- Summary: start ------- 21:01:52 INFO - PID 14142 | Number of tests: 14 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#0] ai-astar Cycles:10 Average:105.10 Median:105.00 stddev:1.29 (1.2%) stddev-sans-first:1.36 21:01:52 INFO - PID 14142 | Values: 105.0 105.0 104.0 106.0 104.0 108.0 106.0 104.0 105.0 104.0 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#1] audio-beat-detection Cycles:10 Average:113.50 Median:114.00 stddev:2.51 (2.2%) stddev-sans-first:2.65 21:01:52 INFO - PID 14142 | Values: 114.0 114.0 111.0 110.0 111.0 115.0 114.0 118.0 112.0 116.0 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 21:01:52 INFO - PID 14142 | Values: 163.0 163.0 159.0 162.0 160.0 161.0 162.0 162.0 163.0 162.0 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#3] audio-fft Cycles:10 Average:73.10 Median:73.00 stddev:0.88 (1.2%) stddev-sans-first:0.87 21:01:52 INFO - PID 14142 | Values: 74.0 74.0 73.0 73.0 71.0 73.0 73.0 74.0 73.0 73.0 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.00 stddev:2.02 (2.6%) stddev-sans-first:1.13 21:01:52 INFO - PID 14142 | Values: 83.0 80.0 78.0 77.0 77.0 78.0 77.0 76.0 77.0 78.0 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:1.58 (1.4%) stddev-sans-first:1.41 21:01:52 INFO - PID 14142 | Values: 116.0 113.0 110.0 113.0 115.0 114.0 114.0 114.0 113.0 114.0 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:149.50 stddev:1.49 (1.0%) stddev-sans-first:1.33 21:01:52 INFO - PID 14142 | Values: 152.0 148.0 149.0 150.0 148.0 152.0 149.0 149.0 149.0 151.0 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:1.73 (1.8%) stddev-sans-first:1.12 21:01:52 INFO - PID 14142 | Values: 99.0 97.0 95.0 96.0 94.0 94.0 94.0 94.0 94.0 94.0 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#8] json-parse-financial Cycles:10 Average:44.90 Median:45.00 stddev:2.47 (5.5%) stddev-sans-first:2.62 21:01:52 INFO - PID 14142 | Values: 45.0 44.0 46.0 45.0 45.0 45.0 51.0 42.0 43.0 43.0 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#9] json-stringify-tinderbox Cycles:10 Average:35.40 Median:35.50 stddev:0.52 (1.5%) stddev-sans-first:0.53 21:01:52 INFO - PID 14142 | Values: 35.0 35.0 35.0 35.0 36.0 35.0 36.0 36.0 35.0 36.0 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:74.00 stddev:1.89 (2.6%) stddev-sans-first:1.45 21:01:52 INFO - PID 14142 | Values: 78.0 74.0 75.0 73.0 74.0 73.0 77.0 73.0 74.0 72.0 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#11] stanford-crypto-ccm Cycles:10 Average:109.80 Median:110.50 stddev:4.16 (3.8%) stddev-sans-first:4.03 21:01:52 INFO - PID 14142 | Values: 105.0 109.0 108.0 108.0 112.0 105.0 112.0 112.0 108.0 119.0 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:151.00 stddev:3.93 (2.6%) stddev-sans-first:4.17 21:01:52 INFO - PID 14142 | Values: 152.0 151.0 159.0 151.0 159.0 149.0 151.0 150.0 148.0 149.0 21:01:52 INFO - PID 14142 | 21:01:52 INFO - PID 14142 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:61.00 stddev:1.58 (2.6%) stddev-sans-first:1.39 21:01:52 INFO - PID 14142 | Values: 58.0 62.0 60.0 60.0 59.0 62.0 63.0 61.0 61.0 59.0 21:01:52 INFO - PID 14142 | -------- Summary: end -------- 21:01:52 INFO - PID 14142 | 21:01:53 INFO - PID 14142 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 21:01:53 INFO - TEST-INFO | 14142: exit 0 21:01:53 INFO - TEST-OK | kraken | took 59225ms 21:01:53 INFO - SUITE-END | took 1166s 21:01:53 INFO - Completed test suite (00:19:27) 21:01:53 INFO - javascript benchmark 21:01:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9089.059449987275, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3910.0811309342307, 3916.9412458813104, 3928.450016997619, 3931.960680393197, 3949.3286141355966, 6286.779962701306, 6291.1821463209835, 6293.807032969216, 6427.807165785022, 6451.9999400093, 6348.555601107924, 6380.3300653431415, 6382.7446902123975, 6503.252126005511, 6520.478361731062, 5695.373508914016, 5791.82624521265, 5798.420157984189, 5828.446297601721, 5829.213056237418, 116.44160355318853, 5456.372517160537, 5696.401877802812, 5816.360200377955, 5823.06830907055, 5706.743196556165, 5727.34135574408, 5745.712714364265, 5785.566082543826, 5792.71036448178, 5715.971420142872, 5716.971415142939, 5785.334686511021, 5790.218320526717, 5797.594168408213, 5638.182463542805, 5691.4877661010705, 5749.798757043483, 5765.682887441189, 5776.913346299809, 6199.039148931878, 6301.590396624205, 6316.368363163693, 6354.968225158845, 6363.5863668861375, 6741.831454213635, 6821.488388370892, 6825.931740682579, 6837.213720422165, 6843.486738494633, 6873.140857392826, 6888.448924086111, 6890.44876409891, 6896.137982752156, 7010.614416207107, 6365.458935990447, 6458.741650334028, 6465.644389558573, 6480.6435646039445, 6484.902726459107, 7066.258042905421, 7068.3991860691385, 7082.256363081905, 7158.785236442915, 7160.283971602902, 6710.127683401127, 6740.595564266159, 6806.93193068063, 6826.52214345001, 6863.828404289933, 6806.18325800907, 6877.6217308048535, 6878.243393226741, 6969.686364113627, 6995.965020174866, 6822.863542729117, 6829.487788415889, 6929.237783843773, 6933.895991560131, 6937.375636192767, 6847.760328388483, 6854.177498700188, 6933.306669333027, 6945.687444065029, 6959.791206263821, 4978.751062446863, 5023.547880690755, 5075.086484432763, 5077.568406685473, 5080.263361812516, 4569.1547063793305, 4595.425571803525, 4644.605208557243, 4646.721196728207, 4684.578387945101, 6273.435390814849, 6366.872662546723, 6378.075179099004, 6449.935500645028, 6458.806235812933, 6703.396694297537, 6849.965750171217, 6864.622445765431, 6939.583624982517, 6952.791416257521, 6270.6864656766975, 6370.968145159337, 6394.776182833579, 6397.072424498421, 6410.166678331787, 5487.42382049887, 5544.500994910397, 5592.3009623797025, 5624.831255062355, 5643.294588176478, 7097.82255443618, 7103.6093014883645, 7104.502684812117, 7248.0939882514685, 7249.492535522569, 6895.069165662671, 6902.171739391104, 6957.965210174018, 6979.092717946634, 6986.54587451814, 7134.85730285381, 7160.641967901688, 7231.963840180976, 7237.0, 7244.275572442924, 6727.125473688585, 6747.595144291358, 6772.7290908365085, 6834.1457317835275, 6841.589504629738, 6882.965585172042, 6914.0320355149315, 6916.654167291515, 6917.965410172917, 6956.721731130698, 6651.434628056476, 6661.16735408074, 6662.766803161866, 6737.191537015589, 6750.25747167821, 6594.10979517759, 6614.801555953329, 6677.632730199885, 6684.63234522106, 6686.06395104676, 6466.967665161644, 6604.603723776589, 6605.9009114864275, 6608.603483790988, 6609.801705948829, 6574.408303252731, 6678.3989440950545, 6707.128073350628, 6707.295733947865, 6794.320567943166, 6520.608763474017, 6596.538242322991, 6612.371824676648, 6616.437602803623, 6618.503612229006], "value": 6259.963869110118, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [976.5556671714367, 1000.6897861662885, 1013.3717095400852, 1016.0804471952883, 1023.6417253961115, 43077.35383969243, 43990.0, 44034.119317613666, 44064.77967610158, 44065.339019914645, 41508.0, 44161.779191104, 44445.0, 44478.55521444784, 44483.11033779322, 8301.667933282677, 8373.665053397857, 8381.119982401851, 8389.07720150783, 8435.24082832545, 8275.462094963808, 8396.874046889301, 8430.78923026923, 8431.0, 8435.620397082146, 8395.244428001479, 8515.105913879046, 8515.914840851574, 8522.062573116953, 8526.87209691855, 8347.248747612683, 8384.790380240482, 8417.326613870875, 8444.775507551401, 8447.02859171197, 8188.385871059635, 8259.545724985124, 8260.545669988149, 8271.751847444586, 8277.255047045735, 38861.22277554433, 39164.60835391638, 39511.60488395108, 39553.0, 39589.60410395888, 3727.254549090193, 3740.1397678533817, 3752.6810221130963, 3755.605661405568, 3755.8497660093562, 32268.838655806572, 32477.0, 32585.511217331758, 32585.674143258737, 32617.0, 5385.246065550826, 5390.865228369283, 5415.296011518517, 5449.536789372908, 5489.890202195974, 212965.0, 216816.0, 217617.0, 218193.0, 230403.9999999983, 51917.48082519126, 52278.47721522736, 52377.0, 52393.7380313096, 52437.475625243256, 54774.72612636991, 54788.726056369465, 54805.0, 54815.0, 55000.449995500334, 14957.476488322856, 15119.16844573559, 15199.468018619295, 15261.847381526264, 15414.845851541566, 12235.021198304114, 12313.44589493475, 12323.568675096329, 12372.257664540157, 12419.0, 13582.660433489242, 13754.518591849237, 13769.0, 13789.724205515833, 13974.58076257714, 5233.764480598306, 5269.341332333458, 5346.0, 5362.624616276901, 5386.057439947994, 1068.8450174724621, 1083.496174278964, 1086.9402182880017, 1092.7268182954263, 1100.0264765682268, 24974.750252497244, 25141.497170056497, 25297.87351063233, 25322.873385632953, 25346.493070138862, 1177.3053898200103, 1189.2567145534042, 1192.0761409907218, 1197.1799317467562, 1199.1306302930307, 13461.730765384638, 13464.730705386033, 13516.053876228569, 13518.324083795771, 13546.864531354757, 285395.0, 286286.0, 287386.0, 287581.0, 287635.0, 55307.44692553103, 55493.44506554963, 55594.72202639042, 55680.88638227294, 55885.0, 1491.9776203356957, 1501.924903754808, 1530.6402995296096, 1536.8155821301516, 1551.67414842882, 24699.516831050565, 24857.87571062133, 24907.62638560459, 24957.876895539383, 24984.625230621918, 35334.64665353416, 38981.8050909755, 39335.60664393319, 39369.212615746954, 39413.0, 233190.0, 234259.0, 234709.0, 234810.0, 235287.0, 32241.51637725483, 32557.18607034843, 35488.290234194654, 35722.10694732652, 35759.64240357667, 45084.54915450804, 45500.772496138634, 45565.54434455613, 45652.0, 45850.77074614605, 33567.0, 34063.0, 34066.489002664486, 34074.0, 34373.312533748685, 33669.49495757517, 33811.323773524884, 34157.829210853786, 34210.82894585511, 34265.0, 39170.80414597909, 39192.0, 39207.80396098001, 39520.60479395284, 39646.60353396429, 33072.50391244181, 33085.66914330922, 33244.0, 33282.83358583192, 33668.326633466706, 24410.633840492053, 24663.753362466145, 25182.244532664048, 25264.873675631505, 25341.239762807145], "value": 18253.66056958241, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.4589779840439, 629.5844742469969, 633.7211626884168, 634.5589815078522, 647.0876064748705, 22285.108595656173, 22905.31284061481, 23038.308850734484, 23061.0, 23178.88410557949, 22982.19562315315, 23401.18095866645, 23418.88290558549, 23426.180083697072, 23493.647595286042, 6370.2355717313985, 6536.803895883131, 6557.245916719567, 6560.737570497175, 6561.311062338457, 6651.733930642768, 6874.106366172416, 6927.134108236471, 6941.444684425234, 6950.582965022089, 6846.7945961621235, 6857.622830744307, 6862.073620061277, 6875.724971001154, 6888.517803753739, 6598.175228096488, 6884.449244060464, 6885.724571017154, 6897.827554311158, 6909.447244220451, 6423.87152256957, 6433.035044743279, 6437.774677886298, 6440.677966101723, 6460.741570337181, 30177.396452070836, 30720.53919191214, 30726.692733072607, 30740.69259307423, 30742.38515229705, 2287.6797248385237, 2301.8158547316343, 2328.5342931413616, 2330.172788660035, 2331.5453486570127, 20244.0, 20954.16183352664, 21159.894200529052, 21162.682559761615, 21174.894125529274, 2480.379905023744, 2523.873806309677, 2566.217303722364, 2595.4160313929406, 2603.075908052652, 126203.0, 131208.0, 131279.0, 145965.0, 153522.23238883846, 15225.847741522442, 15783.842161578466, 15800.762988555181, 16300.184990750415, 17020.404285850185, 26298.21105366842, 26372.8681356592, 26373.208803735917, 26412.603810942852, 26469.411835289946, 10242.795144097225, 10285.794284114276, 10345.896541034645, 10521.053105220566, 10524.26330156897, 9251.861222081674, 9298.0, 9310.953445232866, 9366.578503967337, 9458.43249405038, 9570.425774453555, 9613.0, 9722.854157187649, 9951.507273908972, 10009.549570269355, 2890.7398334150025, 2901.839264294299, 2904.941901162007, 2921.7954743168198, 2941.352902361477, 1051.3376572759112, 1059.5073290919759, 1078.4984981983416, 1084.2843723142687, 1086.652271273185, 21583.784162158492, 21802.672959905613, 21859.234926777488, 21897.343079707633, 21919.780802192094, 1115.5649296774266, 1122.5509796081633, 1127.2729089737074, 1127.5095333529778, 1135.73310272086, 11966.341851198267, 12046.819297710541, 12062.276263424223, 12127.603216568543, 12207.633770986884, 582466.3506729841, 588627.0, 589579.0, 593246.0, 601988.0, 128487.0, 129892.0, 130023.0, 130900.0, 131279.34360328328, 1208.4501551793912, 1211.7758214730127, 1225.375058720059, 1225.9141860069888, 1229.2194456520174, 19277.22891084341, 19326.226950921806, 19629.80370196337, 20082.196712131936, 20083.09626066801, 56133.0, 58141.0, 58589.4141058584, 58888.70555647194, 60309.19072427834, 74569.0, 74651.0, 74885.25114748783, 75132.62433687797, 75268.62365688136, 14981.850181498046, 16182.271797768894, 16202.918985404998, 16231.918840405722, 16456.83543164553, 24158.87920560386, 24477.143299984415, 24832.255032349058, 24866.875665621556, 24892.62661060122, 19716.21135154635, 20055.59888802245, 20452.0, 20583.176672933514, 20659.276925307542, 16809.0, 17540.0, 17716.64566708633, 17723.911380443533, 17864.285428583233, 20609.58780824405, 20620.58758824845, 20643.4839129023, 20764.79235207689, 20963.26628567993, 14894.180820055, 16035.438759643823, 16146.273417696466, 16177.67644647124, 16205.59486012859, 20226.39320820378, 20383.286584969454, 20388.0, 20411.081501332177, 20424.18303267912], "value": 12777.198999054212, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1200.8619008813987, 1438.8417274099847, 1451.804006459129, 1493.2459108150383, 1500.122428379398, 16603.667926641476, 17222.22499987499, 17237.310507579714, 17248.827511724878, 17258.309667613295, 16873.493795186132, 16880.746788798177, 16954.491365259062, 16968.915155424238, 16990.575235619115, 2870.5550639650887, 2894.799952036457, 2921.693222211669, 2934.1490967619366, 2953.3354995126033, 2921.2258751430886, 2928.0337488628807, 2935.4716151092794, 2938.4563855686765, 2940.1326608650393, 2867.8996235131776, 2911.8689658965395, 2932.4868148074, 2981.105668299512, 2981.493146165157, 2908.694587068359, 2934.3251052257992, 2941.5440606705993, 2946.2928897064767, 2960.1119664100793, 2874.798764086515, 3001.444732724431, 3001.504751715986, 3004.7145521175453, 3014.5779590857296, 16583.751243731353, 16761.7485737714, 16817.747733784003, 16827.579310517212, 16884.83115168845, 8359.122292159358, 8566.957165214197, 8608.827823443558, 8635.740927772176, 8639.481631102153, 5654.688992105433, 5895.970520147414, 6065.0, 6102.908456373158, 6109.297430795471, 2143.689165071056, 2145.174107968428, 2169.858959167649, 2201.746799118106, 2216.0581752755015, 30918.38163236745, 31181.376372472423, 31197.688023119706, 31213.0, 31249.687503124904, 7172.892406613905, 7418.591977441185, 7490.325870671557, 7610.733624323233, 7623.504472209289, 19836.0, 19966.50083747918, 19996.50008749793, 20003.199872005247, 20013.299534516224, 8118.634661440249, 8278.793030174294, 8303.95848020768, 8309.709160179485, 8313.916860831436, 7414.406847452191, 7466.141393739681, 7523.172451030382, 7709.6530656119485, 7713.382929365637, 5743.10981797822, 5842.328132264844, 5921.73352199152, 5968.731407086691, 5982.0727787193055, 1680.23549285075, 1709.7948246210285, 1722.2163915418455, 1755.6752000879878, 1757.9033153176697, 955.0926619711302, 963.8939716631165, 982.4547376206132, 985.3348989432104, 987.8863930648067, 8292.37807164453, 8326.70856520019, 8356.247937685515, 8359.540225287546, 8398.076211616717, 745.9962700186464, 759.6201899050475, 767.7504810936356, 781.2304879693497, 813.5606772342987, 5055.747212639353, 5808.361080281165, 5871.823845284648, 5979.19280897082, 6024.518038556905, 24914.252572422494, 25774.613380799303, 25848.8707556461, 26004.08985685492, 26102.34744131412, 24509.754902450746, 25210.0, 25504.362390940005, 25652.102176423734, 25655.10207142741, 12495.875041249654, 12711.745765084646, 12772.872271277169, 12786.232826030653, 12787.488500459878, 9385.249180065715, 9409.0, 9477.810443790948, 9500.239980801382, 9541.522923853641, 21331.78668213298, 21547.0, 21645.242416515346, 21692.45768855791, 21945.341639750834, 21950.45123871916, 22368.328950131523, 22395.0, 22482.5503489926, 22522.32433026946, 12591.181573197713, 12758.425870835648, 12762.553310634083, 12843.35783210817, 12894.0, 15577.688446230784, 15920.761188582412, 15925.761113583074, 15969.361225550847, 15984.600384990468, 12584.244945303311, 12732.172408793398, 12740.4266807992, 12880.098393112392, 13024.11150383208, 12215.877841221474, 12406.379681015733, 12424.937875310565, 12460.376981151088, 12529.93735031319, 10810.45947702596, 11136.777264454828, 11143.0, 11144.33134011962, 11148.498317575566, 8330.875036874573, 8425.410221284452, 8433.915660843313, 8535.658573656985, 8578.699745508877, 8170.0, 8195.67217311301, 8238.546879921661, 8259.256666900008, 8280.848729648047], "value": 7369.662535884308, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.7929497143601, 563.2480638347805, 576.6453631016926, 582.7115577788995, 591.2550186764676, 6143.81568552943, 6221.813345599639, 6274.717637706302, 6300.401461861122, 6361.395667411594, 6135.969320153393, 6167.845803854894, 6191.380861913806, 6219.191505104342, 6297.3387794281625, 4954.7274899880495, 5076.832328564433, 5082.415522214947, 5126.846194614168, 5150.665206761567, 5046.142155833517, 5064.645474816764, 5069.594432445396, 5080.390353157626, 5089.083964886319, 4947.901041979158, 4956.529129732688, 4961.3798275215595, 4971.651984361096, 5030.723310217936, 4962.724601762838, 5035.320231768719, 5040.84877453677, 5051.646384753069, 5064.873378165576, 4515.61617262533, 4606.746628935407, 4608.101420223058, 4614.353990441341, 4634.2121839287065, 6094.573379863411, 6137.508999280047, 6174.567780255384, 6280.120783090371, 6327.145835312266, 5837.299524057098, 5857.47282744555, 5868.41315868414, 5878.412828536271, 5932.228810254639, 6694.966525167391, 6700.39696427319, 6724.125863637744, 6726.663666816639, 6730.1923769147525, 4845.927311090337, 5093.872653183663, 5097.337346145015, 5097.668651537638, 5106.693598384109, 6789.796306110825, 6794.218664853555, 6881.759138430181, 6889.448844092461, 6944.930550694479, 5144.768485418165, 5153.098207813618, 5156.484351564888, 5169.612279079084, 5203.739813009334, 5198.298229738937, 5247.399543139379, 5258.342707161605, 5263.6315457918345, 5278.81524146653, 5825.786201243501, 5840.240768700041, 5865.88268234633, 5902.8819423611285, 5904.7342869570975, 6609.521429463951, 6680.3987641112535, 6685.526355248492, 6773.830654233683, 6793.9385158056575, 1788.5691446842734, 1805.9819401806076, 1810.8008119106887, 1822.17091223493, 1836.7336736173181, 1220.5300959130798, 1256.4848412150975, 1268.7589358021946, 1270.4219580091037, 1280.5966120671958, 6204.410580994799, 6234.812955611339, 6237.4758261582065, 6241.531885108635, 6268.4671802896355, 6708.865822683519, 6770.966145169243, 6791.966040169767, 6838.418734407532, 6851.246362900077, 6050.727717252734, 6102.786402475981, 6184.783532576338, 6255.374462553799, 6283.560150789493, 3518.20840310928, 3520.876769313113, 3524.22467057247, 3543.8459770804006, 3607.2424790794225, 6908.618276344751, 6988.790336289818, 7020.719171233196, 7051.89422158668, 7166.820829479305, 6822.0, 6942.826429339206, 6948.305169483011, 6984.79045628632, 7051.1186101737285, 6941.826454338682, 6994.125734283316, 7096.361327480551, 7121.323474269936, 7129.714811407589, 6667.966660166668, 6732.394084532416, 6772.796816095328, 6799.5920244785475, 6802.693878775368, 6680.665966701548, 6698.196216454056, 6702.832429189114, 6709.597424154371, 6734.8653026940165, 7039.577625342496, 7047.7180912762915, 7061.894071589033, 7090.242171649034, 7113.181984071691, 5233.947660523346, 5248.553872920692, 5250.527452529291, 5255.710935898409, 5261.947380526146, 6513.511486638616, 6713.328667133248, 6827.829304267433, 6853.760118395832, 6886.24251332343, 6275.37246275387, 6538.934610653832, 6595.340465953366, 6610.702518386588, 6611.2727599963, 6447.484201263794, 6562.934370656232, 6566.277709451861, 6586.868262634624, 6655.800325990228, 6296.968515157395, 6339.207599050119, 6461.8061458156335, 6503.934960650522, 6542.443892269211, 6508.219013718384, 6538.0, 6720.1599800025, 6748.0, 6754.290799465985, 6400.903986440114, 6422.678866056772, 6427.164468619049, 6467.126937863328, 6501.44737697301], "value": 5196.1542975662705, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [934.5374039850275, 939.267371450269, 950.3632566180659, 976.3604838830565, 1005.0954141272852, 19056.809431905676, 20487.48781280465, 20546.794532054675, 20578.176872925083, 20583.897080514595, 18708.906455467702, 19038.0, 19078.141483633237, 19116.33092841751, 19144.13851376688, 1066.7599790047236, 1085.7665601895592, 1087.2823936202108, 1088.17298852872, 1089.1341383600056, 1091.3724608350192, 1092.6012005617931, 1092.6066616018227, 1092.819684752015, 1093.8577984861956, 1090.4220762995626, 1114.83834843948, 1129.3449799116493, 1132.3092913322866, 1133.8696049954237, 1118.7650593375402, 1120.7646394257215, 1123.1183520936027, 1124.2973141786342, 1125.2741981421977, 802.257911431929, 811.0065170166557, 812.9349652027823, 827.1893544326533, 833.8874251976027, 21177.8941105295, 21277.25529606472, 21294.148234070773, 21350.679739803916, 21438.464038399008, 20891.37325880226, 21146.365609031753, 21912.89043554772, 22064.0, 22065.889670551704, 18732.719009214874, 18759.43721688338, 18998.24007039717, 19180.13689383981, 19255.90372048145, 3940.7241493095494, 3958.34687276599, 3965.7422267552806, 3970.622790834895, 3972.404139379087, 131050.0, 156629.0, 156986.0, 161092.19453902656, 161172.38827611692, 18729.25082996692, 18925.14836832346, 18935.43193704191, 19274.132664030152, 19286.903565482084, 34717.0, 35088.64911350905, 35120.824395877855, 35435.645643543234, 35566.46650300248, 9840.557174927146, 9858.30991830565, 9876.703698889045, 9921.206303495703, 9935.552900119512, 4447.488538818077, 4504.909901801946, 4533.025399539115, 4549.909001819945, 4572.268437050123, 5847.064469684915, 5942.1978032965, 5952.523798096228, 5959.523238140939, 5963.896679114378, 1136.3522792008475, 1158.223989926751, 1173.2198088271375, 1177.9469923853446, 1186.104491109207, 684.0560027162484, 689.1110467496973, 698.8357735932052, 707.745211723779, 710.0662628643317, 12544.372781361079, 12810.871891281155, 13147.211167329991, 13860.58418247434, 13969.371378288002, 663.6947004377944, 664.3987191591617, 666.3935818405228, 674.7166190200128, 681.1485642946317, 5533.972330138324, 5591.9720401397735, 5623.887522249532, 5655.971720141373, 5767.423257674199, 148266.0, 149059.0, 152340.23829881, 153783.0, 158493.0, 126422.0, 127569.0, 127793.0, 130716.0, 136405.3179734095, 107595.46202268939, 113236.0, 113761.43119284516, 116542.0, 119184.0, 13531.0, 13862.861371386158, 13889.861101388857, 13966.371513281723, 13977.161370317814, 53639.19541206963, 53872.0, 54568.72715636555, 54723.72638136784, 54970.175447367525, 73555.0, 73659.0, 74448.62775686303, 75994.24005760092, 76085.0, 17787.73318400199, 17953.461396158134, 18433.26266949307, 18520.0, 18584.81415185885, 21277.574448510633, 21331.57336853223, 21432.357029289145, 21449.24927627588, 21675.566488670454, 19208.0, 19626.411207663794, 19751.111199995747, 19919.60160796805, 20094.19623215055, 18524.81475185285, 18700.81299186991, 18731.06344682733, 18821.435356939313, 18928.52678683044, 19385.321513746952, 19447.416577502696, 19615.70576441326, 19678.0, 19919.502012449804, 14237.430502779773, 14313.141211527342, 14420.134791912518, 14472.276386180438, 14552.0, 14824.925875370554, 14849.257537122885, 14865.925670371578, 14959.40162393492, 14963.102213867203], "value": 10083.249825154477, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1366.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 104.0, 106.0, 104.0, 108.0, 106.0, 104.0, 105.0, 104.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 111.0, 110.0, 111.0, 115.0, 114.0, 118.0, 112.0, 116.0], "value": 113.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 159.0, 162.0, 160.0, 161.0, 162.0, 162.0, 163.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 73.0, 71.0, 73.0, 73.0, 74.0, 73.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 78.0, 77.0, 77.0, 78.0, 77.0, 76.0, 77.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 110.0, 113.0, 115.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 148.0, 149.0, 150.0, 148.0, 152.0, 149.0, 149.0, 149.0, 151.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 97.0, 95.0, 96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 46.0, 45.0, 45.0, 45.0, 51.0, 42.0, 43.0, 43.0], "value": 44.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [35.0, 35.0, 35.0, 35.0, 36.0, 35.0, 36.0, 36.0, 35.0, 36.0], "value": 35.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 75.0, 73.0, 74.0, 73.0, 77.0, 73.0, 74.0, 72.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 109.0, 108.0, 108.0, 112.0, 105.0, 112.0, 112.0, 108.0, 119.0], "value": 109.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 159.0, 151.0, 159.0, 149.0, 151.0, 150.0, 148.0, 149.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 60.0, 60.0, 59.0, 62.0, 63.0, 61.0, 61.0, 59.0], "value": 60.5, "unit": "score"}]}]} 21:01:54 INFO - Return code: 0 21:01:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:01:54 INFO - # TBPL SUCCESS # 21:01:54 INFO - Running post-action listener: _package_coverage_data 21:01:54 INFO - Running post-action listener: _resource_record_post_action 21:01:54 INFO - [mozharness: 2017-09-24 04:01:54.087821Z] Finished run-tests step (success) 21:01:54 INFO - Running post-run listener: _resource_record_post_run 21:01:54 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 12288; Write bytes: 405975040; Read time: 320; Write time: 206020 21:01:54 INFO - TinderboxPrint: CPU usage
13.1% 21:01:54 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 320 21:01:54 INFO - TinderboxPrint: I/O write bytes / time
405,975,040 / 206,020 21:01:54 INFO - TinderboxPrint: CPU idle
8,212.0 (86.9%) 21:01:54 INFO - TinderboxPrint: CPU user
1,186.3 (12.6%) 21:01:54 INFO - TinderboxPrint: Swap in / out
0 / 0 21:01:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 75321344; Read time: 140; Write time: 27324 21:01:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 21:01:54 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 8192; Write bytes: 330653696; Read time: 180; Write time: 178696 21:01:54 INFO - Running post-run listener: _upload_blobber_files 21:01:54 INFO - Blob upload gear active. 21:01:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:01:54 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 21:01:54 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'] 21:01:54 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 21:01:55 INFO - (blobuploader) - INFO - Open directory for files ... 21:01:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 21:01:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:01:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:01:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 21:01:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:01:55 INFO - (blobuploader) - INFO - Done attempting. 21:01:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 21:01:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:01:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:01:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 21:01:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:01:56 INFO - (blobuploader) - INFO - Done attempting. 21:01:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:01:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:01:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:02:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:02:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:02:03 INFO - (blobuploader) - INFO - Done attempting. 21:02:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:02:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:02:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:02:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:02:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:02:04 INFO - (blobuploader) - INFO - Done attempting. 21:02:04 INFO - (blobuploader) - INFO - Iteration through files over. 21:02:04 INFO - Return code: 0 21:02:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:02:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:02:04 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d93d3af83484a710a648b286bc013322d4fc8879b23d156fa8729d76e994d9c3cf02c765a2ee84ee9842f71907d5cde6173dd175602c802e5c8f25e6821f829f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7324d1a32d6fff1b0c6af8af5c9d6596a245e30389dfedd98048862d54f7dde95b652fe7af35b58f6737ad6582d500e7e1e358862eacd2925f7b9c128e7e68a1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fee6663ba3d01e825f79ebd466e85cb6c4678bfb8e3215bc0b080ee2bc6d3764b5b5572e2d082e3241c0828955b00947625c904a2935e0b1239dcb7c2f3af05d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80351b84baa92985c50c32afb6325cc62a900e4f1a62bb4e3b8f361f613585c72bef0fad715d511f3334c092c65cc4bcfba178081892fea7659fa5e81ff26f86"} 21:02:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:02:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:02:04 INFO - Contents: 21:02:04 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d93d3af83484a710a648b286bc013322d4fc8879b23d156fa8729d76e994d9c3cf02c765a2ee84ee9842f71907d5cde6173dd175602c802e5c8f25e6821f829f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7324d1a32d6fff1b0c6af8af5c9d6596a245e30389dfedd98048862d54f7dde95b652fe7af35b58f6737ad6582d500e7e1e358862eacd2925f7b9c128e7e68a1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fee6663ba3d01e825f79ebd466e85cb6c4678bfb8e3215bc0b080ee2bc6d3764b5b5572e2d082e3241c0828955b00947625c904a2935e0b1239dcb7c2f3af05d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80351b84baa92985c50c32afb6325cc62a900e4f1a62bb4e3b8f361f613585c72bef0fad715d511f3334c092c65cc4bcfba178081892fea7659fa5e81ff26f86"} 21:02:04 INFO - Running post-run listener: copy_logs_to_upload_dir 21:02:04 INFO - Copying logs to upload dir... 21:02:04 INFO - mkdir: /builds/slave/test/build/upload/logs 21:02:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.631432 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-23 21:02:04.771682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 21:02:04.776127) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534 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/d93d3af83484a710a648b286bc013322d4fc8879b23d156fa8729d76e994d9c3cf02c765a2ee84ee9842f71907d5cde6173dd175602c802e5c8f25e6821f829f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7324d1a32d6fff1b0c6af8af5c9d6596a245e30389dfedd98048862d54f7dde95b652fe7af35b58f6737ad6582d500e7e1e358862eacd2925f7b9c128e7e68a1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fee6663ba3d01e825f79ebd466e85cb6c4678bfb8e3215bc0b080ee2bc6d3764b5b5572e2d082e3241c0828955b00947625c904a2935e0b1239dcb7c2f3af05d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80351b84baa92985c50c32afb6325cc62a900e4f1a62bb4e3b8f361f613585c72bef0fad715d511f3334c092c65cc4bcfba178081892fea7659fa5e81ff26f86"} build_url:https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/Q4ywgNwcTHaso13_WBPeKA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d93d3af83484a710a648b286bc013322d4fc8879b23d156fa8729d76e994d9c3cf02c765a2ee84ee9842f71907d5cde6173dd175602c802e5c8f25e6821f829f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7324d1a32d6fff1b0c6af8af5c9d6596a245e30389dfedd98048862d54f7dde95b652fe7af35b58f6737ad6582d500e7e1e358862eacd2925f7b9c128e7e68a1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fee6663ba3d01e825f79ebd466e85cb6c4678bfb8e3215bc0b080ee2bc6d3764b5b5572e2d082e3241c0828955b00947625c904a2935e0b1239dcb7c2f3af05d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80351b84baa92985c50c32afb6325cc62a900e4f1a62bb4e3b8f361f613585c72bef0fad715d511f3334c092c65cc4bcfba178081892fea7659fa5e81ff26f86"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 21:02:04.803865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 21:02:04.804191) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506223998.846246-207703534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 21:02:04.856842) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 21:02:04.857143) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 21:02:04.857476) ========= ========= Total master_lag: 0.52 =========