builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-027 starttime: 1506558009.85 results: success (0) revision: 69e3f89816455e567f1a20b694fd6afd549c82c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:09.854935) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:09.855332) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:09.855661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:09.870877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:09.871187) ========= 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=1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 17:20:09-- 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% 229M=0s 2017-09-27 17:20:10 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157942 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:10.048577) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:10.048912) ========= 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=1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019512 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:10.100383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:10.100723) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 69e3f89816455e567f1a20b694fd6afd549c82c7 --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 69e3f89816455e567f1a20b694fd6afd549c82c7 --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=1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 17:20:10,139 truncating revision to first 12 chars 2017-09-27 17:20:10,139 Setting DEBUG logging. 2017-09-27 17:20:10,139 attempt 1/10 2017-09-27 17:20:10,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/69e3f8981645?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 17:20:10,558 unpacking tar archive at: mozilla-central-69e3f8981645/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727828 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:10.847847) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:10.848152) ========= script_repo_revision: 69e3f89816455e567f1a20b694fd6afd549c82c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:10.848530) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:10.848798) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 17:20:10.862447) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-09-27 17:20:10.862802) ========= /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=1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:20:11 INFO - MultiFileLogger online at 20170927 17:20:11 in /builds/slave/test 17:20:11 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 17:20:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:20:11 INFO - {'append_to_log': False, 17:20:11 INFO - 'base_work_dir': '/builds/slave/test', 17:20:11 INFO - 'blob_upload_branch': 'Firefox', 17:20:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:20:11 INFO - 'branch': 'Firefox', 17:20:11 INFO - 'buildbot_json_path': 'buildprops.json', 17:20:11 INFO - 'code_coverage': False, 17:20:11 INFO - 'config_files': ('talos/linux_config.py',), 17:20:11 INFO - 'default_actions': ('clobber', 17:20:11 INFO - 'read-buildbot-config', 17:20:11 INFO - 'download-and-extract', 17:20:11 INFO - 'populate-webroot', 17:20:11 INFO - 'create-virtualenv', 17:20:11 INFO - 'install', 17:20:11 INFO - 'setup-mitmproxy', 17:20:11 INFO - 'run-tests'), 17:20:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:20:11 INFO - 'disable_ccov_upload': False, 17:20:11 INFO - 'disable_stylo': False, 17:20:11 INFO - 'download_minidump_stackwalk': True, 17:20:11 INFO - 'download_symbols': 'ondemand', 17:20:11 INFO - 'enable_stylo': False, 17:20:11 INFO - 'enable_webrender': False, 17:20:11 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:20:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:20:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:20:11 INFO - 'gecko_profile': False, 17:20:11 INFO - 'gecko_profile_interval': 0, 17:20:11 INFO - 'installer_path': 'installer.exe', 17:20:11 INFO - 'log_level': 'info', 17:20:11 INFO - 'log_name': 'talos', 17:20:11 INFO - 'log_to_console': True, 17:20:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:20:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:20:11 INFO - 'opt_config_files': (), 17:20:11 INFO - 'pip_index': False, 17:20:11 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:20:11 INFO - 'system_bits': '32', 17:20:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:20:11 INFO - 'title': 'talos-linux64-ix-027', 17:20:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:20:11 INFO - 'use_talos_json': True, 17:20:11 INFO - 'verify': 'False', 17:20:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:20:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:20:11 INFO - 'work_dir': 'build'} 17:20:11 INFO - [mozharness: 2017-09-28 00:20:11.043150Z] Running clobber step. 17:20:11 INFO - Running pre-action listener: _resource_record_pre_action 17:20:11 INFO - Running main action method: clobber 17:20:11 INFO - rmtree: /builds/slave/test/build 17:20:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:20:12 INFO - Running post-action listener: _resource_record_post_action 17:20:12 INFO - [mozharness: 2017-09-28 00:20:12.089093Z] Finished clobber step (success) 17:20:12 INFO - [mozharness: 2017-09-28 00:20:12.089191Z] Running read-buildbot-config step. 17:20:12 INFO - Running pre-action listener: _resource_record_pre_action 17:20:12 INFO - Running main action method: read_buildbot_config 17:20:12 INFO - Using buildbot properties: 17:20:12 INFO - { 17:20:12 INFO - "project": "", 17:20:12 INFO - "product": "firefox", 17:20:12 INFO - "who": "archaeopteryx@coole-files.de", 17:20:12 INFO - "installer_path": "public/build/target.tar.bz2", 17:20:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:20:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:20:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 17:20:12 INFO - "stage_platform": "linux64-pgo", 17:20:12 INFO - "basedir": "/builds/slave/test", 17:20:12 INFO - "buildnumber": 67, 17:20:12 INFO - "platform": "ubuntu64_hw", 17:20:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:20:12 INFO - "slavebuilddir": "test", 17:20:12 INFO - "taskId": "N6Tf3Cs4Rwu39s2oWrxSxg", 17:20:12 INFO - "branch": "mozilla-central", 17:20:12 INFO - "script_repo_revision": "production", 17:20:12 INFO - "revision": "69e3f89816455e567f1a20b694fd6afd549c82c7", 17:20:12 INFO - "slavename": "talos-linux64-ix-027", 17:20:12 INFO - "repo_path": "mozilla-central" 17:20:12 INFO - } 17:20:12 INFO - Finding installer, test and symbols from parent task. 17:20:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N6Tf3Cs4Rwu39s2oWrxSxg'}, attempt #1 17:20:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N6Tf3Cs4Rwu39s2oWrxSxg'}, attempt #1 17:20:12 INFO - Task dependencies: IgMi7h1TRIKpKFonaQA_1Q 17:20:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q'}, attempt #1 17:20:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.tar.bz2 17:20:13 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.test_packages.json 17:20:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.crashreporter-symbols.zip 17:20:13 INFO - Running post-action listener: _resource_record_post_action 17:20:13 INFO - [mozharness: 2017-09-28 00:20:13.402953Z] Finished read-buildbot-config step (success) 17:20:13 INFO - [mozharness: 2017-09-28 00:20:13.403169Z] Running download-and-extract step. 17:20:13 INFO - Running pre-action listener: _resource_record_pre_action 17:20:13 INFO - Running main action method: download_and_extract 17:20:13 INFO - mkdir: /builds/slave/test/build/tests 17:20:13 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')]} 17:20:13 INFO - trying https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.test_packages.json 17:20:13 INFO - Downloading https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:20:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:20:13 INFO - Downloaded 989 bytes. 17:20:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:20:13 INFO - Using the following test package requirements: 17:20:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:20:13 INFO - u'common': [u'target.common.tests.zip'], 17:20:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:20:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:20:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:20:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:20:13 INFO - u'mozbase': [u'target.common.tests.zip'], 17:20:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:20:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:20:13 INFO - u'web-platform': [u'target.common.tests.zip', 17:20:13 INFO - u'target.web-platform.tests.tar.gz'], 17:20:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:20:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:20:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.common.tests.zip 17:20:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:20:13 INFO - Fetch https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.common.tests.zip into memory 17:20:15 INFO - Content-Length response header: 55350054 17:20:15 INFO - Bytes received: 55350054 17:20:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.talos.tests.zip 17:20:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:20:25 INFO - Fetch https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.talos.tests.zip into memory 17:20:26 INFO - Content-Length response header: 14513779 17:20:26 INFO - Bytes received: 14513779 17:20: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')]} 17:20:26 INFO - trying https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.tar.bz2 17:20:26 INFO - Downloading https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:20:27 INFO - Downloaded 62383395 bytes. 17:20:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.tar.bz2 17:20:27 INFO - mkdir: /builds/slave/test/properties 17:20:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:20:27 INFO - Writing to file /builds/slave/test/properties/build_url 17:20:27 INFO - Contents: 17:20:27 INFO - build_url:https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.tar.bz2 17:20:27 INFO - Running post-action listener: _resource_record_post_action 17:20:27 INFO - Running post-action listener: find_tests_for_verification 17:20:27 INFO - Running post-action listener: set_extra_try_arguments 17:20:27 INFO - [mozharness: 2017-09-28 00:20:27.821450Z] Finished download-and-extract step (success) 17:20:27 INFO - [mozharness: 2017-09-28 00:20:27.821545Z] Running populate-webroot step. 17:20:27 INFO - Running pre-action listener: _resource_record_pre_action 17:20:27 INFO - Running main action method: populate_webroot 17:20:27 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:20:27 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:20:27 INFO - 'tests': ['tresize', 17:20:27 INFO - 'tcanvasmark']}, 17:20:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:20:27 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:20:27 INFO - 'tests': ['dromaeo_css', 17:20:27 INFO - 'kraken']}, 17:20:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:20:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:20:27 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:20:27 INFO - 'talos_options': ['--disable-stylo'], 17:20:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:20:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:20:27 INFO - 'tests': ['damp', 'tps']}, 17:20:27 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:20:27 INFO - 'talos_options': ['--disable-stylo'], 17:20:27 INFO - 'tests': ['damp', 'tps']}, 17:20:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:20:27 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:20:27 INFO - 'tests': ['dromaeo_dom']}, 17:20:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:20:27 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:20:27 INFO - 'tests': ['basic_compositor_video', 17:20:27 INFO - 'glvideo']}, 17:20:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:20:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:20:27 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:20:27 INFO - 'talos_options': ['--disable-stylo'], 17:20:27 INFO - 'tests': ['ts_paint_webext', 17:20:27 INFO - 'tp5o_webext']}, 17:20:27 INFO - 'other-e10s': {'tests': ['a11yr', 17:20:27 INFO - 'ts_paint', 17:20:27 INFO - 'tpaint', 17:20:27 INFO - 'sessionrestore', 17:20:27 INFO - 'sessionrestore_many_windows', 17:20:27 INFO - 'sessionrestore_no_auto_restore', 17:20:27 INFO - 'tabpaint']}, 17:20:27 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:20:27 INFO - 'tests': ['a11yr', 17:20:27 INFO - 'ts_paint', 17:20:27 INFO - 'tpaint', 17:20:27 INFO - 'sessionrestore', 17:20:27 INFO - 'sessionrestore_many_windows', 17:20:27 INFO - 'sessionrestore_no_auto_restore', 17:20:27 INFO - 'tabpaint']}, 17:20:27 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:20:27 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:20:27 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:20:27 INFO - 'tests': ['perf_reftest_singletons']}, 17:20:27 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:20:27 INFO - 'tests': ['perf_reftest']}, 17:20:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:20:27 INFO - 'tsvgr_opacity', 17:20:27 INFO - 'tart', 17:20:27 INFO - 'tscrollx', 17:20:27 INFO - 'tsvg_static']}, 17:20:27 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:20:27 INFO - 'tests': ['tsvgx', 17:20:27 INFO - 'tsvgr_opacity', 17:20:27 INFO - 'tart', 17:20:27 INFO - 'tscrollx', 17:20:27 INFO - 'tsvg_static']}, 17:20:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:20:27 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:20:27 INFO - 'talos_options': ['--disable-stylo'], 17:20:27 INFO - 'tests': ['tp5o']}, 17:20:27 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:20:27 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:20:27 INFO - 'talos_options': ['--mitmproxy', 17:20:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:20:27 INFO - '--firstNonBlankPaint'], 17:20:27 INFO - 'tests': ['tp6_google', 17:20:27 INFO - 'tp6_youtube', 17:20:27 INFO - 'tp6_amazon', 17:20:27 INFO - 'tp6_facebook']}, 17:20:27 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:20:27 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:20:27 INFO - 'talos_options': ['--disable-stylo', 17:20:27 INFO - '--mitmproxy', 17:20:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:20:27 INFO - '--firstNonBlankPaint'], 17:20:27 INFO - 'tests': ['tp6_google', 17:20:27 INFO - 'tp6_youtube', 17:20:27 INFO - 'tp6_amazon', 17:20:27 INFO - 'tp6_facebook']}, 17:20:27 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:20:27 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:20:27 INFO - 'talos_options': ['--stylo-threads=1', 17:20:27 INFO - '--mitmproxy', 17:20:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:20:27 INFO - '--firstNonBlankPaint'], 17:20:27 INFO - 'tests': ['tp6_google', 17:20:27 INFO - 'tp6_youtube', 17:20:27 INFO - 'tp6_amazon', 17:20:27 INFO - 'tp6_facebook']}, 17:20:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:20:27 INFO - 'talos_options': ['--xperf_path', 17:20:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:20:27 INFO - 'tests': ['tp5n']}, 17:20:27 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:20:27 INFO - 'talos_options': ['--disable-stylo', 17:20:27 INFO - '--xperf_path', 17:20:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:20:27 INFO - 'tests': ['tp5n']}}} 17:20:27 INFO - Running post-action listener: _resource_record_post_action 17:20:27 INFO - [mozharness: 2017-09-28 00:20:27.837419Z] Finished populate-webroot step (success) 17:20:27 INFO - [mozharness: 2017-09-28 00:20:27.837517Z] Running create-virtualenv step. 17:20:27 INFO - Running pre-action listener: _resource_record_pre_action 17:20:27 INFO - Running main action method: create_virtualenv 17:20:27 INFO - Creating virtualenv /builds/slave/test/build/venv 17:20:27 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:20:27 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:20:27 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:20:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:20:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:20:28 INFO - Installing distribute.............................................................................................................................................................................................done. 17:20:28 INFO - Installing pip...............done. 17:20:28 INFO - Return code: 0 17:20:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:20:28 INFO - Reading from file tmpfile_stdout 17:20:28 INFO - Output received: 17:20:28 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:20:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879d60>, '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 0x187aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187aef0>, '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': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', '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 17:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:20:28 INFO - Using env: {'DISPLAY': ':0', 17:20:28 INFO - 'HOME': '/home/cltbld', 17:20:28 INFO - 'LANG': 'en_US.UTF-8', 17:20:28 INFO - 'LANGUAGE': 'en_US:en', 17:20:28 INFO - 'LOGNAME': 'cltbld', 17:20:28 INFO - 'MAIL': '/var/mail/cltbld', 17:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:28 INFO - 'MOZ_NO_REMOTE': '1', 17:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:28 INFO - 'NO_EM_RESTART': '1', 17:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:28 INFO - 'PWD': '/builds/slave/test', 17:20:28 INFO - 'SHELL': '/bin/bash', 17:20:28 INFO - 'SHLVL': '1', 17:20:28 INFO - 'TERM': 'linux', 17:20:28 INFO - 'TMOUT': '86400', 17:20:28 INFO - 'USER': 'cltbld', 17:20:28 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', 17:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:28 INFO - '_': '/tools/buildbot/bin/python'} 17:20:30 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:20:30 INFO - Downloading/unpacking pip>=1.5 17:20:30 INFO - Running setup.py egg_info for package pip 17:20:30 INFO - warning: no files found matching 'pip/cacert.pem' 17:20:30 INFO - warning: no files found matching '*.html' under directory 'docs' 17:20:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:20:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:20:30 INFO - Installing collected packages: pip 17:20:30 INFO - Found existing installation: pip 1.1 17:20:30 INFO - Uninstalling pip: 17:20:30 INFO - Successfully uninstalled pip 17:20:30 INFO - Running setup.py install for pip 17:20:30 INFO - warning: no files found matching 'pip/cacert.pem' 17:20:30 INFO - warning: no files found matching '*.html' under directory 'docs' 17:20:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:20:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:20:30 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:20:30 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:20:30 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:20:30 INFO - Successfully installed pip 17:20:30 INFO - Cleaning up... 17:20:30 INFO - Return code: 0 17:20:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:20: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')]} 17:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20: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')]} 17:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:30 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 0x150f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879d60>, '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 0x187aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187aef0>, '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': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', '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 17:20:30 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 17:20:30 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 17:20:30 INFO - Using env: {'DISPLAY': ':0', 17:20:30 INFO - 'HOME': '/home/cltbld', 17:20:30 INFO - 'LANG': 'en_US.UTF-8', 17:20:30 INFO - 'LANGUAGE': 'en_US:en', 17:20:30 INFO - 'LOGNAME': 'cltbld', 17:20:30 INFO - 'MAIL': '/var/mail/cltbld', 17:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:30 INFO - 'MOZ_NO_REMOTE': '1', 17:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:30 INFO - 'NO_EM_RESTART': '1', 17:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:30 INFO - 'PWD': '/builds/slave/test', 17:20:30 INFO - 'SHELL': '/bin/bash', 17:20:30 INFO - 'SHLVL': '1', 17:20:30 INFO - 'TERM': 'linux', 17:20:30 INFO - 'TMOUT': '86400', 17:20:30 INFO - 'USER': 'cltbld', 17:20:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', 17:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:30 INFO - '_': '/tools/buildbot/bin/python'} 17:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:30 INFO - Downloading/unpacking psutil>=3.1.1 17:20:30 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 17:20:30 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 17:20:30 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 17:20:30 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 17:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:20:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:20:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:20:31 INFO - Installing collected packages: psutil 17:20:31 INFO - Running setup.py install for psutil 17:20:32 INFO - building 'psutil._psutil_linux' extension 17:20:32 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 17:20:32 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 17:20:32 INFO - building 'psutil._psutil_posix' extension 17:20:32 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 17:20:32 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 17:20:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:20:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:20:32 INFO - Successfully installed psutil 17:20:32 INFO - Cleaning up... 17:20:32 INFO - Return code: 0 17:20:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879d60>, '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 0x187aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187aef0>, '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': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', '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 17:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:20:32 INFO - Using env: {'DISPLAY': ':0', 17:20:32 INFO - 'HOME': '/home/cltbld', 17:20:32 INFO - 'LANG': 'en_US.UTF-8', 17:20:32 INFO - 'LANGUAGE': 'en_US:en', 17:20:32 INFO - 'LOGNAME': 'cltbld', 17:20:32 INFO - 'MAIL': '/var/mail/cltbld', 17:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:32 INFO - 'MOZ_NO_REMOTE': '1', 17:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:32 INFO - 'NO_EM_RESTART': '1', 17:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:32 INFO - 'PWD': '/builds/slave/test', 17:20:32 INFO - 'SHELL': '/bin/bash', 17:20:32 INFO - 'SHLVL': '1', 17:20:32 INFO - 'TERM': 'linux', 17:20:32 INFO - 'TMOUT': '86400', 17:20:32 INFO - 'USER': 'cltbld', 17:20:32 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', 17:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:32 INFO - '_': '/tools/buildbot/bin/python'} 17:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:20:33 INFO - Installing collected packages: mozsystemmonitor 17:20:33 INFO - Running setup.py install for mozsystemmonitor 17:20:33 INFO - Successfully installed mozsystemmonitor 17:20:33 INFO - Cleaning up... 17:20:33 INFO - Return code: 0 17:20:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879d60>, '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 0x187aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187aef0>, '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': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', '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 17:20:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:20:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:20:34 INFO - Using env: {'DISPLAY': ':0', 17:20:34 INFO - 'HOME': '/home/cltbld', 17:20:34 INFO - 'LANG': 'en_US.UTF-8', 17:20:34 INFO - 'LANGUAGE': 'en_US:en', 17:20:34 INFO - 'LOGNAME': 'cltbld', 17:20:34 INFO - 'MAIL': '/var/mail/cltbld', 17:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:34 INFO - 'MOZ_NO_REMOTE': '1', 17:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:34 INFO - 'NO_EM_RESTART': '1', 17:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:34 INFO - 'PWD': '/builds/slave/test', 17:20:34 INFO - 'SHELL': '/bin/bash', 17:20:34 INFO - 'SHLVL': '1', 17:20:34 INFO - 'TERM': 'linux', 17:20:34 INFO - 'TMOUT': '86400', 17:20:34 INFO - 'USER': 'cltbld', 17:20:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', 17:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:34 INFO - '_': '/tools/buildbot/bin/python'} 17:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:34 INFO - Downloading/unpacking jsonschema==2.5.1 17:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:20:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:35 INFO - Downloading functools32-3.2.3-2.tar.gz 17:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:20:35 INFO - warning: no files found matching '*.txt' 17:20:35 INFO - no previously-included directories found matching 'build' 17:20:35 INFO - no previously-included directories found matching 'dist' 17:20:35 INFO - no previously-included directories found matching '.git*' 17:20:35 INFO - Installing collected packages: jsonschema, functools32 17:20:35 INFO - Running setup.py install for functools32 17:20:35 INFO - warning: no files found matching '*.txt' 17:20:35 INFO - no previously-included directories found matching 'build' 17:20:35 INFO - no previously-included directories found matching 'dist' 17:20:35 INFO - no previously-included directories found matching '.git*' 17:20:35 INFO - Successfully installed jsonschema functools32 17:20:35 INFO - Cleaning up... 17:20:35 INFO - Return code: 0 17:20:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879d60>, '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 0x187aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187aef0>, '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': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', '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 17:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:20:35 INFO - Using env: {'DISPLAY': ':0', 17:20:35 INFO - 'HOME': '/home/cltbld', 17:20:35 INFO - 'LANG': 'en_US.UTF-8', 17:20:35 INFO - 'LANGUAGE': 'en_US:en', 17:20:35 INFO - 'LOGNAME': 'cltbld', 17:20:35 INFO - 'MAIL': '/var/mail/cltbld', 17:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:35 INFO - 'MOZ_NO_REMOTE': '1', 17:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:35 INFO - 'NO_EM_RESTART': '1', 17:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:35 INFO - 'PWD': '/builds/slave/test', 17:20:35 INFO - 'SHELL': '/bin/bash', 17:20:35 INFO - 'SHLVL': '1', 17:20:35 INFO - 'TERM': 'linux', 17:20:35 INFO - 'TMOUT': '86400', 17:20:35 INFO - 'USER': 'cltbld', 17:20:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', 17:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:35 INFO - '_': '/tools/buildbot/bin/python'} 17:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:20:35 INFO - Cleaning up... 17:20:35 INFO - Return code: 0 17:20:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879d60>, '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 0x187aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187aef0>, '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': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', '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 17:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:20:35 INFO - Using env: {'DISPLAY': ':0', 17:20:35 INFO - 'HOME': '/home/cltbld', 17:20:35 INFO - 'LANG': 'en_US.UTF-8', 17:20:35 INFO - 'LANGUAGE': 'en_US:en', 17:20:35 INFO - 'LOGNAME': 'cltbld', 17:20:35 INFO - 'MAIL': '/var/mail/cltbld', 17:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:35 INFO - 'MOZ_NO_REMOTE': '1', 17:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:35 INFO - 'NO_EM_RESTART': '1', 17:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:35 INFO - 'PWD': '/builds/slave/test', 17:20:35 INFO - 'SHELL': '/bin/bash', 17:20:35 INFO - 'SHLVL': '1', 17:20:35 INFO - 'TERM': 'linux', 17:20:35 INFO - 'TMOUT': '86400', 17:20:35 INFO - 'USER': 'cltbld', 17:20:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', 17:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:35 INFO - '_': '/tools/buildbot/bin/python'} 17:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:37 INFO - Downloading blobuploader-1.2.4.tar.gz 17:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:20:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:20:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:37 INFO - Downloading docopt-0.6.1.tar.gz 17:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:20:37 INFO - Installing collected packages: blobuploader, requests, docopt 17:20:37 INFO - Running setup.py install for blobuploader 17:20:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:20:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:20:37 INFO - Running setup.py install for requests 17:20:38 INFO - Running setup.py install for docopt 17:20:38 INFO - Successfully installed blobuploader requests docopt 17:20:38 INFO - Cleaning up... 17:20:38 INFO - Return code: 0 17:20:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879d60>, '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 0x187aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187aef0>, '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': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', '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 17:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:20:38 INFO - Using env: {'DISPLAY': ':0', 17:20:38 INFO - 'HOME': '/home/cltbld', 17:20:38 INFO - 'LANG': 'en_US.UTF-8', 17:20:38 INFO - 'LANGUAGE': 'en_US:en', 17:20:38 INFO - 'LOGNAME': 'cltbld', 17:20:38 INFO - 'MAIL': '/var/mail/cltbld', 17:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:38 INFO - 'MOZ_NO_REMOTE': '1', 17:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:38 INFO - 'NO_EM_RESTART': '1', 17:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:38 INFO - 'PWD': '/builds/slave/test', 17:20:38 INFO - 'SHELL': '/bin/bash', 17:20:38 INFO - 'SHLVL': '1', 17:20:38 INFO - 'TERM': 'linux', 17:20:38 INFO - 'TMOUT': '86400', 17:20:38 INFO - 'USER': 'cltbld', 17:20:38 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', 17:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:38 INFO - '_': '/tools/buildbot/bin/python'} 17:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:38 INFO - Running setup.py (path:/tmp/pip-URaR8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:38 INFO - Running setup.py (path:/tmp/pip-rJjvWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:38 INFO - Running setup.py (path:/tmp/pip-NlTj99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:38 INFO - Running setup.py (path:/tmp/pip-Nv0oAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:38 INFO - Running setup.py (path:/tmp/pip-mK2Q9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:38 INFO - Running setup.py (path:/tmp/pip-p6saRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:39 INFO - Running setup.py (path:/tmp/pip-3QbWIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:39 INFO - Running setup.py (path:/tmp/pip-KNr6kZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:39 INFO - Running setup.py (path:/tmp/pip-z6y8Pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:39 INFO - Running setup.py (path:/tmp/pip-R8cAQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:39 INFO - Running setup.py (path:/tmp/pip-fyC7_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:39 INFO - Running setup.py (path:/tmp/pip-k29G_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:39 INFO - Running setup.py (path:/tmp/pip-wgpXOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:39 INFO - Running setup.py (path:/tmp/pip-8tZO7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:39 INFO - Running setup.py (path:/tmp/pip-ESam8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:39 INFO - Running setup.py (path:/tmp/pip-1nFFiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:39 INFO - Running setup.py (path:/tmp/pip-obKPLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:20:39 INFO - Running setup.py install for manifestparser 17:20:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:20:39 INFO - Running setup.py install for mozcrash 17:20:40 INFO - Running setup.py install for mozdebug 17:20:40 INFO - Running setup.py install for mozdevice 17:20:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:20:40 INFO - Running setup.py install for mozfile 17:20:40 INFO - Running setup.py install for mozhttpd 17:20:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:20:40 INFO - Running setup.py install for mozinfo 17:20:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:20:40 INFO - Running setup.py install for mozInstall 17:20:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:20:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:20:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:20:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:20:40 INFO - Running setup.py install for mozleak 17:20:40 INFO - Running setup.py install for mozlog 17:20:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:20:40 INFO - Running setup.py install for moznetwork 17:20:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:20:40 INFO - Running setup.py install for mozprocess 17:20:41 INFO - Running setup.py install for mozprofile 17:20:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:20:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:20:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:20:41 INFO - Running setup.py install for mozrunner 17:20:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:20:41 INFO - Running setup.py install for mozscreenshot 17:20:41 INFO - Running setup.py install for moztest 17:20:41 INFO - Running setup.py install for mozversion 17:20:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:20:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:20:41 INFO - Cleaning up... 17:20:41 INFO - Return code: 0 17:20:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879d60>, '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 0x187aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187aef0>, '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': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', '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 17:20:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:20:41 INFO - Using env: {'DISPLAY': ':0', 17:20:41 INFO - 'HOME': '/home/cltbld', 17:20:41 INFO - 'LANG': 'en_US.UTF-8', 17:20:41 INFO - 'LANGUAGE': 'en_US:en', 17:20:41 INFO - 'LOGNAME': 'cltbld', 17:20:41 INFO - 'MAIL': '/var/mail/cltbld', 17:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:41 INFO - 'MOZ_NO_REMOTE': '1', 17:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:41 INFO - 'NO_EM_RESTART': '1', 17:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:41 INFO - 'PWD': '/builds/slave/test', 17:20:41 INFO - 'SHELL': '/bin/bash', 17:20:41 INFO - 'SHLVL': '1', 17:20:41 INFO - 'TERM': 'linux', 17:20:41 INFO - 'TMOUT': '86400', 17:20:41 INFO - 'USER': 'cltbld', 17:20:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', 17:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:41 INFO - '_': '/tools/buildbot/bin/python'} 17:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:41 INFO - Running setup.py (path:/tmp/pip-wSQZxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:41 INFO - Running setup.py (path:/tmp/pip-_BPu0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:41 INFO - Running setup.py (path:/tmp/pip-U_QRP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:42 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)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:42 INFO - Running setup.py (path:/tmp/pip-x0XNyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:42 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)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:42 INFO - Running setup.py (path:/tmp/pip-eDbMM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:42 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)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:42 INFO - Running setup.py (path:/tmp/pip-8xBT1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:42 INFO - Running setup.py (path:/tmp/pip-4SEkxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:42 INFO - Running setup.py (path:/tmp/pip-vZovla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:42 INFO - Running setup.py (path:/tmp/pip-Ys4i74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:42 INFO - Running setup.py (path:/tmp/pip-w52B5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:42 INFO - Running setup.py (path:/tmp/pip-rbedhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:42 INFO - Running setup.py (path:/tmp/pip-VdiaAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:42 INFO - Running setup.py (path:/tmp/pip-Jw8xZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:42 INFO - Running setup.py (path:/tmp/pip-2Aoclz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:42 INFO - Running setup.py (path:/tmp/pip-3Ni_FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:42 INFO - Running setup.py (path:/tmp/pip-gGngbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:42 INFO - Running setup.py (path:/tmp/pip-4IIjkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:43 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)) 17:20:43 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)) 17:20:43 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)) 17:20:43 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)) 17:20:43 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)) 17:20:43 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)) 17:20:43 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)) 17:20:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:20:43 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 17:20:43 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 17:20:43 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 17:20:43 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 17:20:44 INFO - Downloading blessings-1.6.tar.gz 17:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:20:44 INFO - Installing collected packages: blessings 17:20:44 INFO - Running setup.py install for blessings 17:20:44 INFO - Successfully installed blessings 17:20:44 INFO - Cleaning up... 17:20:44 INFO - Return code: 0 17:20:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:20:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:44 INFO - Reading from file tmpfile_stdout 17:20:44 INFO - Current package versions: 17:20:44 INFO - argparse == 1.2.1 17:20:44 INFO - blessings == 1.6 17:20:44 INFO - blobuploader == 1.2.4 17:20:44 INFO - docopt == 0.6.1 17:20:44 INFO - functools32 == 3.2.3-2 17:20:44 INFO - jsonschema == 2.5.1 17:20:44 INFO - manifestparser == 1.1 17:20:44 INFO - mozInstall == 1.13 17:20:44 INFO - mozcrash == 1.0 17:20:44 INFO - mozdebug == 0.1 17:20:44 INFO - mozdevice == 0.51 17:20:44 INFO - mozfile == 1.2 17:20:44 INFO - mozhttpd == 0.7 17:20:44 INFO - mozinfo == 0.10 17:20:44 INFO - mozleak == 0.1 17:20:44 INFO - mozlog == 3.5 17:20:44 INFO - moznetwork == 0.27 17:20:44 INFO - mozprocess == 0.25 17:20:44 INFO - mozprofile == 0.28 17:20:44 INFO - mozrunner == 6.13 17:20:44 INFO - mozscreenshot == 0.1 17:20:44 INFO - mozsystemmonitor == 0.3 17:20:44 INFO - moztest == 0.8 17:20:44 INFO - mozversion == 1.4 17:20:44 INFO - psutil == 3.1.1 17:20:44 INFO - requests == 1.2.3 17:20:44 INFO - wsgiref == 0.1.2 17:20:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879d60>, '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 0x187aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187aef0>, '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': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', '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 17:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:20:44 INFO - Using env: {'DISPLAY': ':0', 17:20:44 INFO - 'HOME': '/home/cltbld', 17:20:44 INFO - 'LANG': 'en_US.UTF-8', 17:20:44 INFO - 'LANGUAGE': 'en_US:en', 17:20:44 INFO - 'LOGNAME': 'cltbld', 17:20:44 INFO - 'MAIL': '/var/mail/cltbld', 17:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:44 INFO - 'MOZ_NO_REMOTE': '1', 17:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:44 INFO - 'NO_EM_RESTART': '1', 17:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:44 INFO - 'PWD': '/builds/slave/test', 17:20:44 INFO - 'SHELL': '/bin/bash', 17:20:44 INFO - 'SHLVL': '1', 17:20:44 INFO - 'TERM': 'linux', 17:20:44 INFO - 'TMOUT': '86400', 17:20:44 INFO - 'USER': 'cltbld', 17:20:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', 17:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:44 INFO - '_': '/tools/buildbot/bin/python'} 17:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:20:44 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:20:45 INFO - Installing collected packages: simplejson 17:20:45 INFO - Running setup.py install for simplejson 17:20:46 INFO - building 'simplejson._speedups' extension 17:20:46 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 17:20:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 17:20:46 INFO - Successfully installed simplejson 17:20:46 INFO - Cleaning up... 17:20:47 INFO - Return code: 0 17:20:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:20:47 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')]} 17:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:47 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')]} 17:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:47 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 0x150f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879d60>, '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 0x187aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187aef0>, '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': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', '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 17:20:47 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 17:20:47 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 17:20:47 INFO - Using env: {'DISPLAY': ':0', 17:20:47 INFO - 'HOME': '/home/cltbld', 17:20:47 INFO - 'LANG': 'en_US.UTF-8', 17:20:47 INFO - 'LANGUAGE': 'en_US:en', 17:20:47 INFO - 'LOGNAME': 'cltbld', 17:20:47 INFO - 'MAIL': '/var/mail/cltbld', 17:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:47 INFO - 'MOZ_NO_REMOTE': '1', 17:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:47 INFO - 'NO_EM_RESTART': '1', 17:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:47 INFO - 'PWD': '/builds/slave/test', 17:20:47 INFO - 'SHELL': '/bin/bash', 17:20:47 INFO - 'SHLVL': '1', 17:20:47 INFO - 'TERM': 'linux', 17:20:47 INFO - 'TMOUT': '86400', 17:20:47 INFO - 'USER': 'cltbld', 17:20:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', 17:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:47 INFO - '_': '/tools/buildbot/bin/python'} 17:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:20:47 INFO - Cleaning up... 17:20:47 INFO - Return code: 0 17:20:47 INFO - Running post-action listener: _resource_record_post_action 17:20:47 INFO - Running post-action listener: _start_resource_monitoring 17:20:47 INFO - Starting resource monitoring. 17:20:47 INFO - [mozharness: 2017-09-28 00:20:47.289597Z] Finished create-virtualenv step (success) 17:20:47 INFO - [mozharness: 2017-09-28 00:20:47.290059Z] Running install step. 17:20:47 INFO - Running pre-action listener: _resource_record_pre_action 17:20:47 INFO - Running main action method: install 17:20:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:47 INFO - Reading from file tmpfile_stdout 17:20:47 INFO - Detecting whether we're running mozinstall >=1.0... 17:20:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:20:47 INFO - Reading from file tmpfile_stdout 17:20:47 INFO - Output received: 17:20:47 INFO - Usage: mozinstall [options] installer 17:20:47 INFO - Options: 17:20:47 INFO - -h, --help show this help message and exit 17:20:47 INFO - -d DEST, --destination=DEST 17:20:47 INFO - Directory to install application into. [default: 17:20:47 INFO - "/builds/slave/test"] 17:20:47 INFO - --app=APP Application being installed. [default: firefox] 17:20:47 INFO - mkdir: /builds/slave/test/build/application 17:20:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:21:05 INFO - Reading from file tmpfile_stdout 17:21:05 INFO - Output received: 17:21:05 INFO - /builds/slave/test/build/application/firefox/firefox 17:21:05 INFO - Running post-action listener: _resource_record_post_action 17:21:05 INFO - [mozharness: 2017-09-28 00:21:05.255240Z] Finished install step (success) 17:21:05 INFO - [mozharness: 2017-09-28 00:21:05.255385Z] Running setup-mitmproxy step. 17:21:05 INFO - Running pre-action listener: _resource_record_pre_action 17:21:05 INFO - Running main action method: setup_mitmproxy 17:21:05 INFO - Skipping: mitmproxy is not required 17:21:05 INFO - Running post-action listener: _resource_record_post_action 17:21:05 INFO - [mozharness: 2017-09-28 00:21:05.256290Z] Finished setup-mitmproxy step (success) 17:21:05 INFO - [mozharness: 2017-09-28 00:21:05.256507Z] Running run-tests step. 17:21:05 INFO - Running pre-action listener: _resource_record_pre_action 17:21:05 INFO - Running pre-action listener: _set_gcov_prefix 17:21:05 INFO - Running main action method: run_tests 17:21:05 WARNING - Try message not found. 17:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:21:05 INFO - Python 2.7.3 17:21:05 INFO - Return code: 0 17:21:05 INFO - grabbing minidump binary from tooltool 17:21: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')]} 17:21:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879d60>, '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 0x187aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187aef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:21:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:21:05 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:21:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:21:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:21:05 INFO - Return code: 0 17:21:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:21:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:21:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:21:05 INFO - ENV: RUST_BACKTRACE is now full 17:21:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:21:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 17:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 17:21:05 INFO - Using env: {'DISPLAY': ':0', 17:21:05 INFO - 'HOME': '/home/cltbld', 17:21:05 INFO - 'LANG': 'en_US.UTF-8', 17:21:05 INFO - 'LANGUAGE': 'en_US:en', 17:21:05 INFO - 'LOGNAME': 'cltbld', 17:21:05 INFO - 'MAIL': '/var/mail/cltbld', 17:21:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:21:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:05 INFO - 'MOZ_NO_REMOTE': '1', 17:21:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:05 INFO - 'NO_EM_RESTART': '1', 17:21:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:05 INFO - 'PWD': '/builds/slave/test', 17:21:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:21:05 INFO - 'RUST_BACKTRACE': 'full', 17:21:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:21:05 INFO - 'SHELL': '/bin/bash', 17:21:05 INFO - 'SHLVL': '1', 17:21:05 INFO - 'TERM': 'linux', 17:21:05 INFO - 'TMOUT': '86400', 17:21:05 INFO - 'USER': 'cltbld', 17:21:05 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', 17:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:05 INFO - '_': '/tools/buildbot/bin/python'} 17:21:05 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/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 17:21:05 INFO - mozversion application_buildid: 20170927215532 17:21:05 INFO - mozversion application_changeset: 69e3f89816455e567f1a20b694fd6afd549c82c7 17:21:05 INFO - mozversion application_display_name: Nightly 17:21:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:21:05 INFO - mozversion application_name: Firefox 17:21:05 INFO - mozversion application_remotingname: firefox 17:21:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:21:05 INFO - mozversion application_vendor: Mozilla 17:21:05 INFO - mozversion application_version: 58.0a1 17:21:05 INFO - mozversion platform_buildid: 20170927215532 17:21:05 INFO - mozversion platform_changeset: 69e3f89816455e567f1a20b694fd6afd549c82c7 17:21:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:21:05 INFO - mozversion platform_version: 58.0a1 17:21:05 INFO - using testdate: 1506558065 17:21:05 INFO - actual date: 1506558065 17:21:05 INFO - starting webserver on 'localhost:43487' 17:21:05 INFO - SUITE-START | Running 2 tests 17:21:05 INFO - TEST-START | dromaeo_css 17:21:05 INFO - Initialising browser for dromaeo_css test... 17:21:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43487/getInfo.html -profile /tmp/tmpDwNBxH/profile 17:21:05 INFO - TEST-INFO | started process 13952 (/builds/slave/test/build/application/firefox/firefox http://localhost:43487/getInfo.html) 17:21:10 INFO - TEST-INFO | 13952: exit 0 17:21:11 INFO - Browser initialized. 17:21:11 INFO - Running cycle 1/1 for dromaeo_css test... 17:21:11 INFO - Using env: {'DISPLAY': ':0', 17:21:11 INFO - 'HOME': '/home/cltbld', 17:21:11 INFO - 'JSGC_DISABLE_POISONING': '1', 17:21:11 INFO - 'LANG': 'en_US.UTF-8', 17:21:11 INFO - 'LANGUAGE': 'en_US:en', 17:21:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:21:11 INFO - 'LOGNAME': 'cltbld', 17:21:11 INFO - 'MAIL': '/var/mail/cltbld', 17:21:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:21:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:21:11 INFO - 'MOZ_CRASHREPORTER': '1', 17:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:21:11 INFO - 'MOZ_NO_REMOTE': '1', 17:21:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:11 INFO - 'NO_EM_RESTART': '1', 17:21:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:11 INFO - 'PWD': '/builds/slave/test', 17:21:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:21:11 INFO - 'RUST_BACKTRACE': 'full', 17:21:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:21:11 INFO - 'SHELL': '/bin/bash', 17:21:11 INFO - 'SHLVL': '1', 17:21:11 INFO - 'STYLO_FORCE_DISABLED': '1', 17:21:11 INFO - 'TERM': 'linux', 17:21:11 INFO - 'TMOUT': '86400', 17:21:11 INFO - 'USER': 'cltbld', 17:21:11 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', 17:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:11 INFO - '_': '/tools/buildbot/bin/python'} 17:21:11 INFO - TEST-INFO | started process 14188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDwNBxH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:21:11 INFO - PID 14188 | 17:21:11 INFO - PID 14188 | (/builds/slave/test/build/application/firefox/firefox:14238): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:21:11 INFO - PID 14188 | 17:21:22 INFO - PID 14188 | RSS: Main: 144740352 17:21:22 INFO - PID 14188 | 17:24:19 INFO - PID 14188 | Cycle 1(1): loaded http://localhost:43487/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43487/tests/dromaeo/cssquery-ext.html) 17:24:20 INFO - PID 14188 | RSS: Main: 142655488 17:24:20 INFO - PID 14188 | 17:27:22 INFO - PID 14188 | Cycle 1(1): loaded http://localhost:43487/tests/dromaeo/cssquery-ext.html (next: http://localhost:43487/tests/dromaeo/cssquery-jquery.html) 17:27:23 INFO - PID 14188 | RSS: Main: 143261696 17:27:23 INFO - PID 14188 | 17:30:24 INFO - PID 14188 | Cycle 1(1): loaded http://localhost:43487/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43487/tests/dromaeo/cssquery-mootools.html) 17:30:25 INFO - PID 14188 | RSS: Main: 144850944 17:30:25 INFO - PID 14188 | 17:33:26 INFO - PID 14188 | Cycle 1(1): loaded http://localhost:43487/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43487/tests/dromaeo/cssquery-prototype.html) 17:33:27 INFO - PID 14188 | RSS: Main: 144265216 17:33:27 INFO - PID 14188 | 17:36:30 INFO - PID 14188 | Cycle 1(1): loaded http://localhost:43487/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43487/tests/dromaeo/cssquery-yui.html) 17:36:31 INFO - PID 14188 | RSS: Main: 148176896 17:36:31 INFO - PID 14188 | 17:39:32 INFO - PID 14188 | Cycle 1(1): loaded http://localhost:43487/tests/dromaeo/cssquery-yui.html (next: http://localhost:43487/tests/dromaeo/cssquery-dojo.html) 17:39:32 INFO - PID 14188 | RSS: Main: 148463616 17:39:32 INFO - PID 14188 | 17:39:32 INFO - PID 14188 | __start_tp_report 17:39:32 INFO - PID 14188 | _x_x_mozilla_page_load 17:39:32 INFO - PID 14188 | _x_x_mozilla_page_load_details 17:39:32 INFO - PID 14188 | |i|pagename|runs| 17:39:32 INFO - PID 14188 | |0;dojo.html;3888.319544079789;3929.469521614582;3960.0297927007878;3960.900977475561;4001.2597669431157;6186.041163619646;6270.216222972129;6323.905141422877;6358.650274234915;6415.262244841844;6338.841528961778;6344.429001389874;6414.454771344442;6415.06981487684;6469;5738.512226460735;5749.453801888814;5756.107803290497;5769.538436925046;5816.621919575236;940.3119581139499;5668.489835914766;5690.715464226772;5812.447817457335;5844.678542680151;5324.403274781872;5648.887022259573;5759.3376761672525;5777.537796976253;5778.8266352009505;5667.4049224831215;5676.375598684142;5730.856728581777;5751.597388182787;5770.336411312669;5671.7731290748325;5692.459216374438;5734.827955161351;5770.624909380919;5786.3056433228285;6233.376662333776;6281.309056003836;6404.775832845875;6405;6412.262589802186;6798.966005169992;6882.380585747307;6883.27725588816;6893.241743408221;7011.439084873198;6958.443324534025;6983.057287266256;6984.266652001517;6986.930130698679;7037.120359955005;6302.968485157545;6339.36606339367;6415.93584064158;6450.193725784277;6467;7177.246389129066;7181.712731490787;7181.820454488679;7183.425325974014;7185.49701520899;6776.085228494188;6776.15298087739;6778.898316525256;6867.656617169122;6886.414654754402;6820.965895170492;6875.346842049998;6938.826529336807;6951.200611929693;6984.406325462291;6794.014867844234;6803.625800581016;6836.726530938707;6841.62371069596;6926.896096558556;6921.930780692129;6965.373116419547;6998.055262539594;7004.964975175091;7012.964935175291;4964.652474326763;4972.7513624318635;5034.723090229999;5036.043151801146;5038.546530812245;4440.62254708347;4476.26141686618;4476.843310484118;4518.70628409159;4531.796069176895;6303.212098487689;6311.810645680637;6341.55609107358;6346.650934198571;6351.015592583157;6833.6241506716615;6838.21360543534;6858.177018757781;6919;6923.515353925278;6307.337729538424;6319.115323854664;6379.808605741835;6390.0734393512685;6393.808185754435;5433.293671822637;5515.145152501369;5543.805966791224;5577.442255774471;5581.134924086773;7096.858062838817;7170.856582868313;7192.856142877114;7196.568205907663;7200.9639951800955;6802.761903333359;6848.897266541106;6865.450763938873;6891.689873955584;6949.3745562899585;7151.749688760869;7157.391621712213;7221.4222862171955;7230.276972302728;7261.164966028974;6824.727010919706;6877.621730804653;6896.896546551706;6906.551074180162;6919.481038922;6843.733909226809;6907.34380233877;6907.585544867324;7002.2647622000995;7004.894926576208;6546.279909209888;6657.567258128206;6690.498212633975;6693.464522838064;6694.464442844658;6716.932830671631;6740.88775352081;6743.055972163803;6745.460363171032;6753.966230168818;6474.611523308617;6626.2379826318665;6631.336866313523;6642.833929151617;6650.401463868082;6689.46484281266;6705.8994115087335;6772.52592318533;6787.389134977876;6789.932100679128;6411.839704007437;6454.160959075478;6521.804345869631;6522.478201743754;6530.575512591667 17:39:32 INFO - PID 14188 | |1;ext.html;937.6905621145021;964.6768332608574;969.6848524229628;970.3401686852937;972.6449845806278;40359.192816143695;43769.78115109424;43989.34015989763;44129.33805992905;44234;41940.58059419405;41951.58048419515;41956.58043419565;42000;42018;7395.371393431551;7536;7542.8114297142465;7556.131044929821;7556.924430755705;7428.665710043061;7503.324700776929;7513.2862378074;7518.360939320164;7523.134839493474;7481.775546733579;7518.924810751877;7534.886976695327;7537.924620753804;7936.642851071716;8582.313414926792;8691.435056721324;8712.869306960401;8713.738587842312;8714.607842647065;8279.089300176976;8510.191531804468;8557.871631925525;8577.627579587235;8584.914150858474;41231.7938410309;41624;41888.790556047024;41890.58109418928;41910.58089419128;3711.870084547055;3747.362948298796;3755.4742336072973;3796.791176485292;3798.6771124454453;32349.191270218435;32768.344633107445;32770.508442373386;32772.180695482566;32819.83590082058;5432.158015507603;5482.698451585201;5493.807716729935;5528.695921724304;5604.579656525736;217577;218064.9999999984;218218;218395;219035;46181;46948.530514694416;51931.74034129805;52382;53513.46486535163;56721.14918276229;56727.43272567304;56790;56899.71550142223;56911.430885690614;16673.08298043595;16689.33242670304;16695.33218671264;16743.83256167447;16776.580585485215;13610.115342502706;13620.863791362157;13625.182489050689;13659.043866929418;13793.310334483236;14476.131432113896;14746.852531474762;14803.703925921422;14839.777403338958;14915.254237288093;5808.419158084158;5841.2990441146485;5889.94110058894;5933.703314834241;5985.22930553757;1096.2545469081101;1099.8570185875944;1103.089950790601;1114.5597488991802;1118.8937050980144;25391.11131110402;25517.3620659485;25578.23265302044;25642.23073307804;25715.48569028609;1206.6561030106377;1212.9454174562165;1214.3503225774168;1221.6640423883503;1227.6317104868683;13470.969031967925;13623.86376136226;13653.522126725517;13871.306434678225;13895.930520347334;282409;284109;284700;285397;285747;60354.396456035756;60405;60589.09116363258;60809;60838.695806520685;1493.5417777932862;1526.86258236757;1550.4108438793187;1553.6581951970547;1567.474895909883;24720;24756.876215618806;24891.377715556533;25008.37479063038;25192.622110668723;42287.1542569153;42463.78768106263;42480;42519.7874010628;42544.361834571886;231480;233451;234059;234340;234889;33979.32041359208;34238.82880585581;34279.14302142367;35698.28603427865;37172.44241336328;48904.51095489142;48946.510534894194;49059.754701226266;49294.26058609052;49731.25403118884;35099;35100.82449587736;35320.29359412849;35634.28731425305;35910.82044589865;35388;35486.11284717903;36063.459048114826;36189;36475.08812279608;41209.1758164841;41604.58395416007;41720.58279417167;41812;42501.57498424976;33857.66142338545;34160.82919585386;34326.82836585801;34553.82723086369;34626.30747385089;25680.871595641904;25898.74101258963;26271.737282626927;26306.473870522866;26539.33651658724 17:39:32 INFO - PID 14188 | |2;jquery.html;614.2659521871362;614.9368867449704;615.4092071611256;616.2235583165212;618.1130078337586;22192;23255.534889302206;23285.534289314204;23317.533649327004;23391.64912526309;24987;26823.32941676459;27096.864515677444;27101.593476097874;27131.45737085257;6533.673316334188;6615.636140012298;6659.533832631718;6669.466442684574;6674.3325667433355;6471.870562588745;6476.255230648489;6574;6744.258131605519;6768.3908448239645;6715.46276297895;6717.966410167943;6725.2938441463675;6734.326567343251;6736.191657001143;6674.8998765018805;6693.263740988487;6697.330266973312;6710.899336509932;6726.93273067268;6202.255729312466;6217.658028808413;6230.096635987757;6233.968830155865;6235.7505699771955;28717;29990.70009299923;30071.849640751876;30438.391232175454;30568.847155764302;2222.0889435331596;2273.9204127855446;2275.1581914691506;2277.8633282003134;2279.4187482191933;20472.18111275562;20545.69181462279;21022.2642207522;21038.684419733716;21135.048922798356;2489.3154382544944;2514.1451906351926;2545.834520756145;2570.55015372311;2586.0690151545427;130193;136456;150279;154999;155572;16295.266712997944;16412.456069309275;16766.329346826235;17010;17066.48800535986;26519;26586.601200982;26598.335041623726;26651.600225996626;26672.59991100135;10630.255882088335;10730.678079657622;10739;10745.677629671123;10817.621383251548;9419.811603767886;9481.383710058824;9632.229421646252;9632.422054676741;9675.661351852792;9985.30102892805;10020.749481263027;10064.496775161213;10164.440955747357;10363.32638378503;2825.3077995890726;2909.912702618925;2955.2020954342206;2961.4225226080707;3014.7136022077866;1014.7919676466307;1041.1618646989095;1042.4110377636612;1044.2794471814423;1047.6804574604819;21130.577388452144;21425.57148857014;21499.14003439845;21840.017199226073;21937.232196873032;1094.3543309447305;1096.2928910852456;1110.1008183371496;1117.6535274065066;1117.7149826794116;11605;11635.01102406305;11661.416929153509;11777.941110294394;11792.174547781573;509230;513767;520429;523582;527920;119236;121093;121185;121452;121867.39066304611;1040.9434424059586;1209.4255228766442;1234.6110975042832;1237.4802582915197;1253.2918900821007;22139.889300553394;22621.8868905661;22997;23211.651825222296;23406.76593234114;60571.39428605657;62655;63170;63590;64379.67810160919;80379;80445;80492;80754.59622701848;80953;15515.922420387826;16024.919875401014;16028.439004634782;16037.35850566011;16077.517674469784;24164;24437.51124977526;24487.265382038568;24507;24578;19620.607587848448;19738.70391944151;19824.008799559677;19869.105890235263;20032.098555564742;16809.663806724042;17242.137893105544;17587;18006.00966946778;18345;19652.705209422154;20260.59478810445;20389.79610203938;20597.279095231595;20609.278675246296;15716;15736.134512601458;15808.76286855675;15808.841911580737;15856.76214856755;18415.355462558746;19450.124744386252;19462.221511139396;19522.121504532613;19605.8039419604 17:39:32 INFO - PID 14188 | |3;mootools.html;1449.4636984315805;1526.8015158029455;1528.8700460460875;1539.3688587679053;1544.5675210940933;16397.91801040996;16988;16989.405370812023;17000.064996425208;17005.064721440314;16140.919295403506;16405.42581009665;16440.095794731285;16456.753148702777;16467;2785.4011387551673;2791.1766029021387;2866.4410439964217;2869.684334723179;2875.583040459132;2854.8001639885215;2856.057501024667;2891.161563146685;2894.6815850256453;2895.8407287599175;2734.5487994480986;2826.2086615747626;2834.248924035122;2836.602875597418;2838.489071967045;2847.117393607988;2888.523393640047;2895.8262504249706;2899.60855284536;2919.255589824592;2734.7948903832093;2770.6952235254307;2795.566687163493;2799.14626039058;2799.216219458555;16030.679386412323;16460.506184814356;16462.588435289093;16485.34058637665;16490.917545412198;8360.540170290631;8602;8641.30869530436;8643.567821608895;8646.135386461367;5458.727063646841;5634.154876768476;5769.1346298055205;5809.302883653946;5919.911201331984;2027.4829918370722;2066.9793302067087;2073.502359433725;2116.375669177596;2124.097258665061;29701.851490742625;29999.700002999907;30038.849805750833;30064.398712025857;30095.398092038256;7378.852422951511;7383;7434.814129646802;7567.886481702779;7587.544747315179;19431.514212144528;19447.611047778966;19472.415827525198;19504.122314495882;19523.707144392847;8423.620937057847;8585.871211931826;8599.39804213699;8605.225529702357;8606.26846718036;7372.741954031583;7719.421043421766;7809.297163255334;7812.492188007761;7817.8827317590285;5819.127130930395;5820.35976042635;5875.764969401176;5903.2325797646035;6166.167567378347;1578.4002079210056;1611.7582362645462;1645.5556999610278;1674.2884274183423;1684.983150168507;991.7272749993665;1008.641932114089;1013.280570794744;1018.6892997635643;1027.4246422003703;9621.08599683029;9743.902560974442;9766.902330976742;9892.901070989197;10045;1031.2781053262745;1058.0477570186893;1060.7772367802693;1062.9043386095134;1072.06730144773;5348.251244825728;5411.161270003156;5413;5481.835544933659;5486.61593688438;24427.51144977126;24536;25308.620370694454;25308.620370694454;25308.74691253101;24526.632100518505;24904.750952490605;24929.875350623493;24981.750182498305;25191.62212566813;12458.12793104492;12470.81293780594;12645.43095560702;12652.683682907817;12667.619971400689;9431.858522122311;9558.378705384128;9592.856107158259;9624;9748.561314740995;20407.59184816325;21364.572708546053;21386.144554217655;21518.569628607653;21554.999999999374;21104;21767.129314827864;22019;22302;22418.551628967656;12465.065120115847;12674.873251267369;12678.366081695694;12684.746305074032;12686.429110689856;15360.155191464577;15639.45261915873;15735.213239337758;15741.527754167393;15742.29159687794;12511.311877846805;12567.49730010826;12577.496900124259;12720;13071.215727056408;12353.3823308836;12433.626991190278;12658.620241392773;12702.36488175606;12738.87261127377;9644.710658680251;9837.803243934937;9841.950790246003;9846.556904939438;9853.704388868346;8226.066874284657;8369.623366948625;8370.87443688333;8486.74539763808;8486.872696909675;8191.467554608931;8375.20435558621;8456.365772566958;8464.788380290296;8470.15298470148 17:39:32 INFO - PID 14188 | |4;prototype.html;537.612918698537;547.3869266421608;565.3244372974298;572.627791935242;578.9305283365994;6155.692215389229;6256.436920677138;6269.2163479565;6333.366663333676;6389;6184.876302473948;6205.317415084337;6220.6267623942595;6225.937740622592;6267.091271765591;4834.2265237562;4974.8258810941625;5126.512981266774;5175.560077393426;5189.989805912562;4994.300797888299;5006.824761133361;5008.5993120550265;5034.119029169899;5055.115354812893;4971.279164521142;4971.552560269575;5002.549770520653;5007.2489126630935;5041.3194218780545;4918.827841025565;4939.851804445836;4945.67853089548;4958.6281028922795;5026.874328141789;4525.32120181972;4595.322707211877;4596.931046034279;4598.218302888484;4602.125596136723;6159.722812473449;6244.438000579924;6265.154204182422;6279.654618995954;6282.120503129566;5781.768729250825;5824.534037277008;5875.706214689249;5898.439648233454;5910.379410161957;6587.275399706028;6664.666766661648;6672.69972851218;6712.194536655584;6770.796876093725;4984.601231901475;5027.3464449621315;5031.77357018935;5035.647504674637;5061.342025536694;6962.7911162665205;6983.9650801746175;7020.824479388005;7063.223045464994;7073.115860517435;5240.318758561439;5250.133727934848;5258.526732594085;5292.841214763564;5294.100002999499;5341.65279256847;5356.973215133899;5373.650712703662;5374.5700343972385;5377.704226267515;5926.318473375617;5941.287045554474;5943.257092863392;5946.1972633693895;5949.524038076944;6297.590656607397;6417.8716425672155;6550.934490655128;6731.596104233761;6822.829429264209;1813.220315264449;1819.8908065515845;1826.4794533557872;1838.237131590375;1844.8431883289802;1261.520622163572;1265.1776345375579;1278.846538415396;1285.2160182288796;1294.2428679222571;6158.137860699506;6247.781327653511;6256.343083976117;6320.873582528324;6361.236651601837;6758.357955994173;6771;6806.863862722717;6833.214180369222;6849.280825513349;6248.125262463259;6433.613983161025;6436.710348034256;6438.291787903327;6461.773837915651;3622.3117607654463;3663.5970043295215;3666.6333366663653;3674.4488326751202;3677.8712745053795;7220.75066220203;7235.131784185826;7265.437930844788;7283.4537409694485;7311.707531698672;7078.398336141383;7084.43324534036;7149.820279653903;7151.570905745568;7181.281871812777;7178.425725941912;7229.819254518574;7249.275072492708;7249.746258880914;7291.8541629168185;6866.279040700654;6889.173299204128;6925.099737034153;6947.131608548932;6997.860042799217;6860.794176174722;6908.412784913338;6947.930520694728;6993.475489338218;7003.307783784774;7072.858542829217;7130.322619351154;7171.3545780877885;7220.38626716735;7227.314069824322;5145.92281115776;5160.845174644766;5196.714180720097;5211.530962213267;5275.868103297448;6650.168728908887;6839.2476827547935;6870.3473170048765;6935.202451718117;6939.479539034492;6461.418472337512;6548.967255163694;6616.966915165393;6663.5007123396845;6691.966540167268;6532.477401807939;6568.408843204134;6602.372774586406;6640.402363787282;6693.891424201555;6336.429721325103;6339.2392912850755;6481.287058423475;6492.48060155177;6556.901646475211;6483.319251478527;6554;6631.3700198481065;6655.534112612071;6688.565243259172;6390.712417941111;6462.806115816533;6525.934740652533;6548.377904099103;6557.9344206557325 17:39:32 INFO - PID 14188 | |5;yui.html;953.1746705059811;988.4069558265041;988.4810474500887;1000.4797505297241;1007.7631756537212;20953.68569471457;21312.147514099437;21334.99999999998;21456.785432145673;21487.03308351124;19213;19372.225110995543;19880.602387952233;20037.59924801503;20196.596068078667;1050.322541960435;1086.4893500054961;1086.5490821309186;1086.7337502311946;1087.0596933652373;1086.239632257419;1086.7337502311905;1089.727568107973;1091.6779550032759;1128.424503503211;1165.388171210113;1169.193256652911;1169.3860723120345;1169.7894379011775;1170.4791367841315;1143.9599614013512;1146.1346683254174;1147.0823341326904;1147.7073346296725;1149.6953307373553;804.9235322644339;822.9588520574007;830.7424698343533;831.4927893984665;854.7136709202425;20228.595428091503;20265.08807103684;20433.386998390073;20442.488937776525;20450.693239601416;22747.431314217112;22897;23587.528249435087;23783.881080594485;23788.762112378827;18326.175322110535;18472.3534676287;18597.16312765929;18682;18713.438596842116;3966.127451960564;4008.1382502761753;4013.819378127991;4016.0160760613544;4018.3369743992207;164248;164335;166077;167611;168793;17091.48725538236;17279.222434990457;17329;17554.38559650406;17577.912110439367;33779.15552111168;34557;34705.65294347075;34903.12742181466;34918;8935.821283574422;8976.685815996409;8978.057303983118;8979;9005.234555062762;4247.851325203603;4323.027318853296;4326.113146804897;4331.090471001062;4373.715708479002;6195.132681424604;6337.96831015842;6369.9681501592195;6384.7126879290545;6391.872162556723;1147.713071732067;1174.1018121137338;1188.5780547905542;1193.2899924544881;1193.2959553863088;741.9220981796941;756.2588663110183;762.4396068889362;767.5279702982625;781.199270747477;13471;13637.249951252577;13686.110402823784;14607.561773146823;14616.415343386145;697.3340459860821;702.9753958611526;725.7133432294214;736.3225832234357;743.4795643049887;6168;6176.135341052256;6254.21822272216;6296.905546416808;6334.3032266450655;147122;148620;149393;151259;158172;98083.50958245163;100286.49856750816;127678;134382;139888;114011.42994284976;114661;115449.4227528857;116682;119329;14077.296135192995;14354.784678229626;14500.828789966345;14588.343524541633;14589.197594132;53824.19263711126;55480.44519554753;57792.71103644455;58048.12927806171;58279.12581311199;71311;71612;71946;72571.63714181395;74043;20101.97813612719;20784;20960.895195523924;20989.475263118544;21241.68137477908;21244.468888277916;21337.466563336042;21450.892745536174;21479.248226312004;21516.892415537823;19354.903225483784;19451;19497.415077547696;19534.511637209183;19715.11281992285;18717.53206169802;18791.71812422842;18933.431997040112;18971.33600323982;18975;21067;21329;21641.78358216398;21641.783582164608;21826;14027.438902444195;15028.624284392978;15052;15162.545123646309;15364;15127.621809454411;15438;15444.768328474856;15474;15663.608409789846 17:39:32 INFO - PID 14188 | __end_tp_report 17:39:32 INFO - PID 14188 | __start_cc_report 17:39:32 INFO - PID 14188 | _x_x_mozilla_cycle_collect,288 17:39:32 INFO - PID 14188 | __end_cc_report 17:39:32 INFO - PID 14188 | __startTimestamp1506559172931__endTimestamp 17:39:32 INFO - PID 14188 | 17:39:32 INFO - PID 14188 | ------- Summary: start ------- 17:39:32 INFO - PID 14188 | Number of tests: 6 17:39:32 INFO - PID 14188 | 17:39:32 INFO - PID 14188 | [#0] dojo.html Cycles:165 Average:6320.54 Median:6631.34 stddev:875.87 (13.2%) stddev-sans-first:857.52 17:39:32 INFO - PID 14188 | Values: 3888.3 3929.5 3960.0 3960.9 4001.3 6186.0 6270.2 6323.9 6358.7 6415.3 6338.8 6344.4 6414.5 6415.1 6469.0 5738.5 5749.5 5756.1 5769.5 5816.6 940.3 5668.5 5690.7 5812.4 5844.7 5324.4 5648.9 5759.3 5777.5 5778.8 5667.4 5676.4 5730.9 5751.6 5770.3 5671.8 5692.5 5734.8 5770.6 5786.3 6233.4 6281.3 6404.8 6405.0 6412.3 6799.0 6882.4 6883.3 6893.2 7011.4 6958.4 6983.1 6984.3 6986.9 7037.1 6303.0 6339.4 6415.9 6450.2 6467.0 7177.2 7181.7 7181.8 7183.4 7185.5 6776.1 6776.2 6778.9 6867.7 6886.4 6821.0 6875.3 6938.8 6951.2 6984.4 6794.0 6803.6 6836.7 6841.6 6926.9 6921.9 6965.4 6998.1 7005.0 7013.0 4964.7 4972.8 5034.7 5036.0 5038.5 4440.6 4476.3 4476.8 4518.7 4531.8 6303.2 6311.8 6341.6 6346.7 6351.0 6833.6 6838.2 6858.2 6919.0 6923.5 6307.3 6319.1 6379.8 6390.1 6393.8 5433.3 5515.1 5543.8 5577.4 5581.1 7096.9 7170.9 7192.9 7196.6 7201.0 6802.8 6848.9 6865.5 6891.7 6949.4 7151.7 7157.4 7221.4 7230.3 7261.2 6824.7 6877.6 6896.9 6906.6 6919.5 6843.7 6907.3 6907.6 7002.3 7004.9 6546.3 6657.6 6690.5 6693.5 6694.5 6716.9 6740.9 6743.1 6745.5 6754.0 6474.6 6626.2 6631.3 6642.8 6650.4 6689.5 6705.9 6772.5 6787.4 6789.9 6411.8 6454.2 6521.8 6522.5 6530.6 17:39:32 INFO - PID 14188 | 17:39:32 INFO - PID 14188 | [#1] ext.html Cycles:180 Average:42584.03 Median:20459.90 stddev:64275.00 (314.2%) stddev-sans-first:64379.24 17:39:32 INFO - PID 14188 | Values: 937.7 964.7 969.7 970.3 972.6 40359.2 43769.8 43989.3 44129.3 44234.0 41940.6 41951.6 41956.6 42000.0 42018.0 7395.4 7536.0 7542.8 7556.1 7556.9 7428.7 7503.3 7513.3 7518.4 7523.1 7481.8 7518.9 7534.9 7537.9 7936.6 8582.3 8691.4 8712.9 8713.7 8714.6 8279.1 8510.2 8557.9 8577.6 8584.9 41231.8 41624.0 41888.8 41890.6 41910.6 3711.9 3747.4 3755.5 3796.8 3798.7 32349.2 32768.3 32770.5 32772.2 32819.8 5432.2 5482.7 5493.8 5528.7 5604.6 217577.0 218065.0 218218.0 218395.0 219035.0 46181.0 46948.5 51931.7 52382.0 53513.5 56721.1 56727.4 56790.0 56899.7 56911.4 16673.1 16689.3 16695.3 16743.8 16776.6 13610.1 13620.9 13625.2 13659.0 13793.3 14476.1 14746.9 14803.7 14839.8 14915.3 5808.4 5841.3 5889.9 5933.7 5985.2 1096.3 1099.9 1103.1 1114.6 1118.9 25391.1 25517.4 25578.2 25642.2 25715.5 1206.7 1212.9 1214.4 1221.7 1227.6 13471.0 13623.9 13653.5 13871.3 13895.9 282409.0 284109.0 284700.0 285397.0 285747.0 60354.4 60405.0 60589.1 60809.0 60838.7 1493.5 1526.9 1550.4 1553.7 1567.5 24720.0 24756.9 24891.4 25008.4 25192.6 42287.2 42463.8 42480.0 42519.8 42544.4 231480.0 233451.0 234059.0 234340.0 234889.0 33979.3 34238.8 34279.1 35698.3 37172.4 48904.5 48946.5 49059.8 49294.3 49731.3 35099.0 35100.8 35320.3 35634.3 35910.8 35388.0 35486.1 36063.5 36189.0 36475.1 41209.2 41604.6 41720.6 41812.0 42501.6 33857.7 34160.8 34326.8 34553.8 34626.3 25680.9 25898.7 26271.7 26306.5 26539.3 17:39:32 INFO - PID 14188 | 17:39:32 INFO - PID 14188 | [#2] jquery.html Cycles:180 Average:37140.79 Median:2278.64 stddev:87472.10 (3838.8%) stddev-sans-first:87674.49 17:39:32 INFO - PID 14188 | Values: 614.3 614.9 615.4 616.2 618.1 22192.0 23255.5 23285.5 23317.5 23391.6 24987.0 26823.3 27096.9 27101.6 27131.5 6533.7 6615.6 6659.5 6669.5 6674.3 6471.9 6476.3 6574.0 6744.3 6768.4 6715.5 6718.0 6725.3 6734.3 6736.2 6674.9 6693.3 6697.3 6710.9 6726.9 6202.3 6217.7 6230.1 6234.0 6235.8 28717.0 29990.7 30071.8 30438.4 30568.8 2222.1 2273.9 2275.2 2277.9 2279.4 20472.2 20545.7 21022.3 21038.7 21135.0 2489.3 2514.1 2545.8 2570.6 2586.1 130193.0 136456.0 150279.0 154999.0 155572.0 16295.3 16412.5 16766.3 17010.0 17066.5 26519.0 26586.6 26598.3 26651.6 26672.6 10630.3 10730.7 10739.0 10745.7 10817.6 9419.8 9481.4 9632.2 9632.4 9675.7 9985.3 10020.7 10064.5 10164.4 10363.3 2825.3 2909.9 2955.2 2961.4 3014.7 1014.8 1041.2 1042.4 1044.3 1047.7 21130.6 21425.6 21499.1 21840.0 21937.2 1094.4 1096.3 1110.1 1117.7 1117.7 11605.0 11635.0 11661.4 11777.9 11792.2 509230.0 513767.0 520429.0 523582.0 527920.0 119236.0 121093.0 121185.0 121452.0 121867.4 1040.9 1209.4 1234.6 1237.5 1253.3 22139.9 22621.9 22997.0 23211.7 23406.8 60571.4 62655.0 63170.0 63590.0 64379.7 80379.0 80445.0 80492.0 80754.6 80953.0 15515.9 16024.9 16028.4 16037.4 16077.5 24164.0 24437.5 24487.3 24507.0 24578.0 19620.6 19738.7 19824.0 19869.1 20032.1 16809.7 17242.1 17587.0 18006.0 18345.0 19652.7 20260.6 20389.8 20597.3 20609.3 15716.0 15736.1 15808.8 15808.8 15856.8 18415.4 19450.1 19462.2 19522.1 19605.8 17:39:32 INFO - PID 14188 | 17:39:32 INFO - PID 14188 | [#3] mootools.html Cycles:180 Average:10421.14 Median:2734.67 stddev:7632.70 (279.1%) stddev-sans-first:7624.35 17:39:32 INFO - PID 14188 | Values: 1449.5 1526.8 1528.9 1539.4 1544.6 16397.9 16988.0 16989.4 17000.1 17005.1 16140.9 16405.4 16440.1 16456.8 16467.0 2785.4 2791.2 2866.4 2869.7 2875.6 2854.8 2856.1 2891.2 2894.7 2895.8 2734.5 2826.2 2834.2 2836.6 2838.5 2847.1 2888.5 2895.8 2899.6 2919.3 2734.8 2770.7 2795.6 2799.1 2799.2 16030.7 16460.5 16462.6 16485.3 16490.9 8360.5 8602.0 8641.3 8643.6 8646.1 5458.7 5634.2 5769.1 5809.3 5919.9 2027.5 2067.0 2073.5 2116.4 2124.1 29701.9 29999.7 30038.8 30064.4 30095.4 7378.9 7383.0 7434.8 7567.9 7587.5 19431.5 19447.6 19472.4 19504.1 19523.7 8423.6 8585.9 8599.4 8605.2 8606.3 7372.7 7719.4 7809.3 7812.5 7817.9 5819.1 5820.4 5875.8 5903.2 6166.2 1578.4 1611.8 1645.6 1674.3 1685.0 991.7 1008.6 1013.3 1018.7 1027.4 9621.1 9743.9 9766.9 9892.9 10045.0 1031.3 1058.0 1060.8 1062.9 1072.1 5348.3 5411.2 5413.0 5481.8 5486.6 24427.5 24536.0 25308.6 25308.6 25308.7 24526.6 24904.8 24929.9 24981.8 25191.6 12458.1 12470.8 12645.4 12652.7 12667.6 9431.9 9558.4 9592.9 9624.0 9748.6 20407.6 21364.6 21386.1 21518.6 21555.0 21104.0 21767.1 22019.0 22302.0 22418.6 12465.1 12674.9 12678.4 12684.7 12686.4 15360.2 15639.5 15735.2 15741.5 15742.3 12511.3 12567.5 12577.5 12720.0 13071.2 12353.4 12433.6 12658.6 12702.4 12738.9 9644.7 9837.8 9842.0 9846.6 9853.7 8226.1 8369.6 8370.9 8486.7 8486.9 8191.5 8375.2 8456.4 8464.8 8470.2 17:39:32 INFO - PID 14188 | 17:39:32 INFO - PID 14188 | [#4] prototype.html Cycles:180 Average:5704.23 Median:6280.89 stddev:1610.91 (25.6%) stddev-sans-first:1568.06 17:39:32 INFO - PID 14188 | Values: 537.6 547.4 565.3 572.6 578.9 6155.7 6256.4 6269.2 6333.4 6389.0 6184.9 6205.3 6220.6 6225.9 6267.1 4834.2 4974.8 5126.5 5175.6 5190.0 4994.3 5006.8 5008.6 5034.1 5055.1 4971.3 4971.6 5002.5 5007.2 5041.3 4918.8 4939.9 4945.7 4958.6 5026.9 4525.3 4595.3 4596.9 4598.2 4602.1 6159.7 6244.4 6265.2 6279.7 6282.1 5781.8 5824.5 5875.7 5898.4 5910.4 6587.3 6664.7 6672.7 6712.2 6770.8 4984.6 5027.3 5031.8 5035.6 5061.3 6962.8 6984.0 7020.8 7063.2 7073.1 5240.3 5250.1 5258.5 5292.8 5294.1 5341.7 5357.0 5373.7 5374.6 5377.7 5926.3 5941.3 5943.3 5946.2 5949.5 6297.6 6417.9 6550.9 6731.6 6822.8 1813.2 1819.9 1826.5 1838.2 1844.8 1261.5 1265.2 1278.8 1285.2 1294.2 6158.1 6247.8 6256.3 6320.9 6361.2 6758.4 6771.0 6806.9 6833.2 6849.3 6248.1 6433.6 6436.7 6438.3 6461.8 3622.3 3663.6 3666.6 3674.4 3677.9 7220.8 7235.1 7265.4 7283.5 7311.7 7078.4 7084.4 7149.8 7151.6 7181.3 7178.4 7229.8 7249.3 7249.7 7291.9 6866.3 6889.2 6925.1 6947.1 6997.9 6860.8 6908.4 6947.9 6993.5 7003.3 7072.9 7130.3 7171.4 7220.4 7227.3 5145.9 5160.8 5196.7 5211.5 5275.9 6650.2 6839.2 6870.3 6935.2 6939.5 6461.4 6549.0 6617.0 6663.5 6692.0 6532.5 6568.4 6602.4 6640.4 6693.9 6336.4 6339.2 6481.3 6492.5 6556.9 6483.3 6554.0 6631.4 6655.5 6688.6 6390.7 6462.8 6525.9 6548.4 6557.9 17:39:32 INFO - PID 14188 | 17:39:32 INFO - PID 14188 | [#5] yui.html Cycles:180 Average:28811.52 Median:20149.29 stddev:42272.46 (209.8%) stddev-sans-first:42339.29 17:39:32 INFO - PID 14188 | Values: 953.2 988.4 988.5 1000.5 1007.8 20953.7 21312.1 21335.0 21456.8 21487.0 19213.0 19372.2 19880.6 20037.6 20196.6 1050.3 1086.5 1086.5 1086.7 1087.1 1086.2 1086.7 1089.7 1091.7 1128.4 1165.4 1169.2 1169.4 1169.8 1170.5 1144.0 1146.1 1147.1 1147.7 1149.7 804.9 823.0 830.7 831.5 854.7 20228.6 20265.1 20433.4 20442.5 20450.7 22747.4 22897.0 23587.5 23783.9 23788.8 18326.2 18472.4 18597.2 18682.0 18713.4 3966.1 4008.1 4013.8 4016.0 4018.3 164248.0 164335.0 166077.0 167611.0 168793.0 17091.5 17279.2 17329.0 17554.4 17577.9 33779.2 34557.0 34705.7 34903.1 34918.0 8935.8 8976.7 8978.1 8979.0 9005.2 4247.9 4323.0 4326.1 4331.1 4373.7 6195.1 6338.0 6370.0 6384.7 6391.9 1147.7 1174.1 1188.6 1193.3 1193.3 741.9 756.3 762.4 767.5 781.2 13471.0 13637.2 13686.1 14607.6 14616.4 697.3 703.0 725.7 736.3 743.5 6168.0 6176.1 6254.2 6296.9 6334.3 147122.0 148620.0 149393.0 151259.0 158172.0 98083.5 100286.5 127678.0 134382.0 139888.0 114011.4 114661.0 115449.4 116682.0 119329.0 14077.3 14354.8 14500.8 14588.3 14589.2 53824.2 55480.4 57792.7 58048.1 58279.1 71311.0 71612.0 71946.0 72571.6 74043.0 20102.0 20784.0 20960.9 20989.5 21241.7 21244.5 21337.5 21450.9 21479.2 21516.9 19354.9 19451.0 19497.4 19534.5 19715.1 18717.5 18791.7 18933.4 18971.3 18975.0 21067.0 21329.0 21641.8 21641.8 21826.0 14027.4 15028.6 15052.0 15162.5 15364.0 15127.6 15438.0 15444.8 15474.0 15663.6 17:39:32 INFO - PID 14188 | -------- Summary: end -------- 17:39:32 INFO - PID 14188 | 17:39:33 INFO - TEST-INFO | 14188: exit 0 17:39:33 INFO - TEST-OK | dromaeo_css | took 1107795ms 17:39:33 INFO - TEST-START | kraken 17:39:33 INFO - Initialising browser for kraken test... 17:39:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43487/getInfo.html -profile /tmp/tmpgq1asr/profile 17:39:33 INFO - TEST-INFO | started process 14551 (/builds/slave/test/build/application/firefox/firefox http://localhost:43487/getInfo.html) 17:39:38 INFO - TEST-INFO | 14551: exit 0 17:39:38 INFO - Browser initialized. 17:39:38 INFO - Running cycle 1/1 for kraken test... 17:39:38 INFO - Using env: {'DISPLAY': ':0', 17:39:38 INFO - 'HOME': '/home/cltbld', 17:39:38 INFO - 'JSGC_DISABLE_POISONING': '1', 17:39:38 INFO - 'LANG': 'en_US.UTF-8', 17:39:38 INFO - 'LANGUAGE': 'en_US:en', 17:39:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:39:38 INFO - 'LOGNAME': 'cltbld', 17:39:38 INFO - 'MAIL': '/var/mail/cltbld', 17:39:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:39:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:39:38 INFO - 'MOZ_CRASHREPORTER': '1', 17:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:39:38 INFO - 'MOZ_NO_REMOTE': '1', 17:39:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:38 INFO - 'NO_EM_RESTART': '1', 17:39:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:38 INFO - 'PWD': '/builds/slave/test', 17:39:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:39:38 INFO - 'RUST_BACKTRACE': 'full', 17:39:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:39:38 INFO - 'SHELL': '/bin/bash', 17:39:38 INFO - 'SHLVL': '1', 17:39:38 INFO - 'STYLO_FORCE_DISABLED': '1', 17:39:38 INFO - 'TERM': 'linux', 17:39:38 INFO - 'TMOUT': '86400', 17:39:38 INFO - 'USER': 'cltbld', 17:39:38 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209', 17:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:38 INFO - '_': '/tools/buildbot/bin/python'} 17:39:38 INFO - TEST-INFO | started process 14789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgq1asr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:39 INFO - PID 14789 | 17:39:39 INFO - PID 14789 | (/builds/slave/test/build/application/firefox/firefox:14838): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:39:39 INFO - PID 14789 | 17:39:49 INFO - PID 14789 | RSS: Main: 145702912 17:39:49 INFO - PID 14789 | 17:39:52 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43487/tests/kraken/driver.html?testName=audio-beat-detection) 17:39:52 INFO - PID 14789 | RSS: Main: 151412736 17:39:52 INFO - PID 14789 | 17:39:55 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43487/tests/kraken/driver.html?testName=audio-dft) 17:39:56 INFO - PID 14789 | RSS: Main: 151564288 17:39:56 INFO - PID 14789 | 17:39:59 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43487/tests/kraken/driver.html?testName=audio-fft) 17:39:59 INFO - PID 14789 | RSS: Main: 147595264 17:39:59 INFO - PID 14789 | 17:40:01 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43487/tests/kraken/driver.html?testName=audio-oscillator) 17:40:02 INFO - PID 14789 | RSS: Main: 148389888 17:40:02 INFO - PID 14789 | 17:40:04 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43487/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:40:04 INFO - PID 14789 | RSS: Main: 148619264 17:40:04 INFO - PID 14789 | 17:40:07 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43487/tests/kraken/driver.html?testName=imaging-darkroom) 17:40:08 INFO - PID 14789 | RSS: Main: 148389888 17:40:08 INFO - PID 14789 | 17:40:12 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43487/tests/kraken/driver.html?testName=imaging-desaturate) 17:40:12 INFO - PID 14789 | RSS: Main: 149577728 17:40:12 INFO - PID 14789 | 17:40:15 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43487/tests/kraken/driver.html?testName=json-parse-financial) 17:40:16 INFO - PID 14789 | RSS: Main: 151293952 17:40:16 INFO - PID 14789 | 17:40:17 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43487/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:40:18 INFO - PID 14789 | RSS: Main: 151044096 17:40:18 INFO - PID 14789 | 17:40:19 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43487/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:40:20 INFO - PID 14789 | RSS: Main: 150966272 17:40:20 INFO - PID 14789 | 17:40:22 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43487/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:40:23 INFO - PID 14789 | RSS: Main: 148103168 17:40:23 INFO - PID 14789 | 17:40:25 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:40:26 INFO - PID 14789 | RSS: Main: 148054016 17:40:26 INFO - PID 14789 | 17:40:28 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:40:29 INFO - PID 14789 | RSS: Main: 148500480 17:40:29 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | Cycle 1(1): loaded http://localhost:43487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43487/tests/kraken/driver.html?testName=ai-astar) 17:40:31 INFO - PID 14789 | RSS: Main: 150032384 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | __start_tp_report 17:40:31 INFO - PID 14789 | _x_x_mozilla_page_load 17:40:31 INFO - PID 14789 | _x_x_mozilla_page_load_details 17:40:31 INFO - PID 14789 | |i|pagename|runs| 17:40:31 INFO - PID 14789 | |0;ai-astar;106;107;105;104;107;99;108;107;107;108 17:40:31 INFO - PID 14789 | |1;audio-beat-detection;113;116;110;112;116;116;114;140;115;115 17:40:31 INFO - PID 14789 | |2;audio-dft;162;164;165;164;163;166;163;163;167;165 17:40:31 INFO - PID 14789 | |3;audio-fft;76;80;73;72;74;73;74;73;75;73 17:40:31 INFO - PID 14789 | |4;audio-oscillator;78;79;78;78;77;77;77;77;78;78 17:40:31 INFO - PID 14789 | |5;imaging-gaussian-blur;114;113;110;114;114;114;114;114;114;115 17:40:31 INFO - PID 14789 | |6;imaging-darkroom;149;149;150;151;149;149;151;149;150;151 17:40:31 INFO - PID 14789 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;96;94 17:40:31 INFO - PID 14789 | |8;json-parse-financial;45;44;44;45;45;45;44;42;44;43 17:40:31 INFO - PID 14789 | |9;json-stringify-tinderbox;38;37;37;37;40;37;37;37;37;37 17:40:31 INFO - PID 14789 | |10;stanford-crypto-aes;70;70;71;70;70;69;71;72;71;72 17:40:31 INFO - PID 14789 | |11;stanford-crypto-ccm;106;108;113;112;106;104;105;105;106;108 17:40:31 INFO - PID 14789 | |12;stanford-crypto-pbkdf2;154;152;154;155;154;148;154;152;150;162 17:40:31 INFO - PID 14789 | |13;stanford-crypto-sha256-iterative;60;58;61;62;59;62;62;64;59;58 17:40:31 INFO - PID 14789 | __end_tp_report 17:40:31 INFO - PID 14789 | __start_cc_report 17:40:31 INFO - PID 14789 | _x_x_mozilla_cycle_collect,696 17:40:31 INFO - PID 14789 | __end_cc_report 17:40:31 INFO - PID 14789 | __startTimestamp1506559231420__endTimestamp 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | ------- Summary: start ------- 17:40:31 INFO - PID 14789 | Number of tests: 14 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#0] ai-astar Cycles:10 Average:105.80 Median:107.00 stddev:2.70 (2.5%) stddev-sans-first:2.86 17:40:31 INFO - PID 14789 | Values: 106.0 107.0 105.0 104.0 107.0 99.0 108.0 107.0 107.0 108.0 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#1] audio-beat-detection Cycles:10 Average:116.70 Median:115.50 stddev:8.42 (7.3%) stddev-sans-first:8.82 17:40:31 INFO - PID 14789 | Values: 113.0 116.0 110.0 112.0 116.0 116.0 114.0 140.0 115.0 115.0 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:1.55 (0.9%) stddev-sans-first:1.42 17:40:31 INFO - PID 14789 | Values: 162.0 164.0 165.0 164.0 163.0 166.0 163.0 163.0 167.0 165.0 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#3] audio-fft Cycles:10 Average:74.30 Median:74.00 stddev:2.31 (3.1%) stddev-sans-first:2.37 17:40:31 INFO - PID 14789 | Values: 76.0 80.0 73.0 72.0 74.0 73.0 74.0 73.0 75.0 73.0 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 17:40:31 INFO - PID 14789 | Values: 78.0 79.0 78.0 78.0 77.0 77.0 77.0 77.0 78.0 78.0 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 17:40:31 INFO - PID 14789 | Values: 114.0 113.0 110.0 114.0 114.0 114.0 114.0 114.0 114.0 115.0 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 17:40:31 INFO - PID 14789 | Values: 149.0 149.0 150.0 151.0 149.0 149.0 151.0 149.0 150.0 151.0 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:40:31 INFO - PID 14789 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 96.0 94.0 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#8] json-parse-financial Cycles:10 Average:44.10 Median:44.50 stddev:0.99 (2.2%) stddev-sans-first:1.00 17:40:31 INFO - PID 14789 | Values: 45.0 44.0 44.0 45.0 45.0 45.0 44.0 42.0 44.0 43.0 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#9] json-stringify-tinderbox Cycles:10 Average:37.40 Median:37.00 stddev:0.97 (2.6%) stddev-sans-first:1.00 17:40:31 INFO - PID 14789 | Values: 38.0 37.0 37.0 37.0 40.0 37.0 37.0 37.0 37.0 37.0 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#10] stanford-crypto-aes Cycles:10 Average:70.60 Median:71.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 17:40:31 INFO - PID 14789 | Values: 70.0 70.0 71.0 70.0 70.0 69.0 71.0 72.0 71.0 72.0 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#11] stanford-crypto-ccm Cycles:10 Average:107.30 Median:107.00 stddev:3.02 (2.8%) stddev-sans-first:3.17 17:40:31 INFO - PID 14789 | Values: 106.0 108.0 113.0 112.0 106.0 104.0 105.0 105.0 106.0 108.0 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:154.00 stddev:3.69 (2.4%) stddev-sans-first:3.91 17:40:31 INFO - PID 14789 | Values: 154.0 152.0 154.0 155.0 154.0 148.0 154.0 152.0 150.0 162.0 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:61.50 stddev:2.01 (3.3%) stddev-sans-first:2.13 17:40:31 INFO - PID 14789 | Values: 60.0 58.0 61.0 62.0 59.0 62.0 62.0 64.0 59.0 58.0 17:40:31 INFO - PID 14789 | -------- Summary: end -------- 17:40:31 INFO - PID 14789 | 17:40:31 INFO - PID 14789 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:40:31 INFO - TEST-INFO | 14789: exit 0 17:40:32 INFO - TEST-OK | kraken | took 58605ms 17:40:32 INFO - SUITE-END | took 1166s 17:40:32 INFO - Completed test suite (00:19:26) 17:40:32 INFO - javascript benchmark 17:40:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9157.644612452421, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3888.319544079789, 3929.469521614582, 3960.0297927007878, 3960.900977475561, 4001.2597669431157, 6186.041163619646, 6270.216222972129, 6323.905141422877, 6358.650274234915, 6415.262244841844, 6338.841528961778, 6344.429001389874, 6414.454771344442, 6415.06981487684, 6469.0, 5738.512226460735, 5749.453801888814, 5756.107803290497, 5769.538436925046, 5816.621919575236, 940.3119581139499, 5668.489835914766, 5690.715464226772, 5812.447817457335, 5844.678542680151, 5324.403274781872, 5648.887022259573, 5759.3376761672525, 5777.537796976253, 5778.8266352009505, 5667.4049224831215, 5676.375598684142, 5730.856728581777, 5751.597388182787, 5770.336411312669, 5671.7731290748325, 5692.459216374438, 5734.827955161351, 5770.624909380919, 5786.3056433228285, 6233.376662333776, 6281.309056003836, 6404.775832845875, 6405.0, 6412.262589802186, 6798.966005169992, 6882.380585747307, 6883.27725588816, 6893.241743408221, 7011.439084873198, 6958.443324534025, 6983.057287266256, 6984.266652001517, 6986.930130698679, 7037.120359955005, 6302.968485157545, 6339.36606339367, 6415.93584064158, 6450.193725784277, 6467.0, 7177.246389129066, 7181.712731490787, 7181.820454488679, 7183.425325974014, 7185.49701520899, 6776.085228494188, 6776.15298087739, 6778.898316525256, 6867.656617169122, 6886.414654754402, 6820.965895170492, 6875.346842049998, 6938.826529336807, 6951.200611929693, 6984.406325462291, 6794.014867844234, 6803.625800581016, 6836.726530938707, 6841.62371069596, 6926.896096558556, 6921.930780692129, 6965.373116419547, 6998.055262539594, 7004.964975175091, 7012.964935175291, 4964.652474326763, 4972.7513624318635, 5034.723090229999, 5036.043151801146, 5038.546530812245, 4440.62254708347, 4476.26141686618, 4476.843310484118, 4518.70628409159, 4531.796069176895, 6303.212098487689, 6311.810645680637, 6341.55609107358, 6346.650934198571, 6351.015592583157, 6833.6241506716615, 6838.21360543534, 6858.177018757781, 6919.0, 6923.515353925278, 6307.337729538424, 6319.115323854664, 6379.808605741835, 6390.0734393512685, 6393.808185754435, 5433.293671822637, 5515.145152501369, 5543.805966791224, 5577.442255774471, 5581.134924086773, 7096.858062838817, 7170.856582868313, 7192.856142877114, 7196.568205907663, 7200.9639951800955, 6802.761903333359, 6848.897266541106, 6865.450763938873, 6891.689873955584, 6949.3745562899585, 7151.749688760869, 7157.391621712213, 7221.4222862171955, 7230.276972302728, 7261.164966028974, 6824.727010919706, 6877.621730804653, 6896.896546551706, 6906.551074180162, 6919.481038922, 6843.733909226809, 6907.34380233877, 6907.585544867324, 7002.2647622000995, 7004.894926576208, 6546.279909209888, 6657.567258128206, 6690.498212633975, 6693.464522838064, 6694.464442844658, 6716.932830671631, 6740.88775352081, 6743.055972163803, 6745.460363171032, 6753.966230168818, 6474.611523308617, 6626.2379826318665, 6631.336866313523, 6642.833929151617, 6650.401463868082, 6689.46484281266, 6705.8994115087335, 6772.52592318533, 6787.389134977876, 6789.932100679128, 6411.839704007437, 6454.160959075478, 6521.804345869631, 6522.478201743754, 6530.575512591667], "value": 6261.713921138868, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [937.6905621145021, 964.6768332608574, 969.6848524229628, 970.3401686852937, 972.6449845806278, 40359.192816143695, 43769.78115109424, 43989.34015989763, 44129.33805992905, 44234.0, 41940.58059419405, 41951.58048419515, 41956.58043419565, 42000.0, 42018.0, 7395.371393431551, 7536.0, 7542.8114297142465, 7556.131044929821, 7556.924430755705, 7428.665710043061, 7503.324700776929, 7513.2862378074, 7518.360939320164, 7523.134839493474, 7481.775546733579, 7518.924810751877, 7534.886976695327, 7537.924620753804, 7936.642851071716, 8582.313414926792, 8691.435056721324, 8712.869306960401, 8713.738587842312, 8714.607842647065, 8279.089300176976, 8510.191531804468, 8557.871631925525, 8577.627579587235, 8584.914150858474, 41231.7938410309, 41624.0, 41888.790556047024, 41890.58109418928, 41910.58089419128, 3711.870084547055, 3747.362948298796, 3755.4742336072973, 3796.791176485292, 3798.6771124454453, 32349.191270218435, 32768.344633107445, 32770.508442373386, 32772.180695482566, 32819.83590082058, 5432.158015507603, 5482.698451585201, 5493.807716729935, 5528.695921724304, 5604.579656525736, 217577.0, 218064.9999999984, 218218.0, 218395.0, 219035.0, 46181.0, 46948.530514694416, 51931.74034129805, 52382.0, 53513.46486535163, 56721.14918276229, 56727.43272567304, 56790.0, 56899.71550142223, 56911.430885690614, 16673.08298043595, 16689.33242670304, 16695.33218671264, 16743.83256167447, 16776.580585485215, 13610.115342502706, 13620.863791362157, 13625.182489050689, 13659.043866929418, 13793.310334483236, 14476.131432113896, 14746.852531474762, 14803.703925921422, 14839.777403338958, 14915.254237288093, 5808.419158084158, 5841.2990441146485, 5889.94110058894, 5933.703314834241, 5985.22930553757, 1096.2545469081101, 1099.8570185875944, 1103.089950790601, 1114.5597488991802, 1118.8937050980144, 25391.11131110402, 25517.3620659485, 25578.23265302044, 25642.23073307804, 25715.48569028609, 1206.6561030106377, 1212.9454174562165, 1214.3503225774168, 1221.6640423883503, 1227.6317104868683, 13470.969031967925, 13623.86376136226, 13653.522126725517, 13871.306434678225, 13895.930520347334, 282409.0, 284109.0, 284700.0, 285397.0, 285747.0, 60354.396456035756, 60405.0, 60589.09116363258, 60809.0, 60838.695806520685, 1493.5417777932862, 1526.86258236757, 1550.4108438793187, 1553.6581951970547, 1567.474895909883, 24720.0, 24756.876215618806, 24891.377715556533, 25008.37479063038, 25192.622110668723, 42287.1542569153, 42463.78768106263, 42480.0, 42519.7874010628, 42544.361834571886, 231480.0, 233451.0, 234059.0, 234340.0, 234889.0, 33979.32041359208, 34238.82880585581, 34279.14302142367, 35698.28603427865, 37172.44241336328, 48904.51095489142, 48946.510534894194, 49059.754701226266, 49294.26058609052, 49731.25403118884, 35099.0, 35100.82449587736, 35320.29359412849, 35634.28731425305, 35910.82044589865, 35388.0, 35486.11284717903, 36063.459048114826, 36189.0, 36475.08812279608, 41209.1758164841, 41604.58395416007, 41720.58279417167, 41812.0, 42501.57498424976, 33857.66142338545, 34160.82919585386, 34326.82836585801, 34553.82723086369, 34626.30747385089, 25680.871595641904, 25898.74101258963, 26271.737282626927, 26306.473870522866, 26539.33651658724], "value": 18588.444981155673, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.2659521871362, 614.9368867449704, 615.4092071611256, 616.2235583165212, 618.1130078337586, 22192.0, 23255.534889302206, 23285.534289314204, 23317.533649327004, 23391.64912526309, 24987.0, 26823.32941676459, 27096.864515677444, 27101.593476097874, 27131.45737085257, 6533.673316334188, 6615.636140012298, 6659.533832631718, 6669.466442684574, 6674.3325667433355, 6471.870562588745, 6476.255230648489, 6574.0, 6744.258131605519, 6768.3908448239645, 6715.46276297895, 6717.966410167943, 6725.2938441463675, 6734.326567343251, 6736.191657001143, 6674.8998765018805, 6693.263740988487, 6697.330266973312, 6710.899336509932, 6726.93273067268, 6202.255729312466, 6217.658028808413, 6230.096635987757, 6233.968830155865, 6235.7505699771955, 28717.0, 29990.70009299923, 30071.849640751876, 30438.391232175454, 30568.847155764302, 2222.0889435331596, 2273.9204127855446, 2275.1581914691506, 2277.8633282003134, 2279.4187482191933, 20472.18111275562, 20545.69181462279, 21022.2642207522, 21038.684419733716, 21135.048922798356, 2489.3154382544944, 2514.1451906351926, 2545.834520756145, 2570.55015372311, 2586.0690151545427, 130193.0, 136456.0, 150279.0, 154999.0, 155572.0, 16295.266712997944, 16412.456069309275, 16766.329346826235, 17010.0, 17066.48800535986, 26519.0, 26586.601200982, 26598.335041623726, 26651.600225996626, 26672.59991100135, 10630.255882088335, 10730.678079657622, 10739.0, 10745.677629671123, 10817.621383251548, 9419.811603767886, 9481.383710058824, 9632.229421646252, 9632.422054676741, 9675.661351852792, 9985.30102892805, 10020.749481263027, 10064.496775161213, 10164.440955747357, 10363.32638378503, 2825.3077995890726, 2909.912702618925, 2955.2020954342206, 2961.4225226080707, 3014.7136022077866, 1014.7919676466307, 1041.1618646989095, 1042.4110377636612, 1044.2794471814423, 1047.6804574604819, 21130.577388452144, 21425.57148857014, 21499.14003439845, 21840.017199226073, 21937.232196873032, 1094.3543309447305, 1096.2928910852456, 1110.1008183371496, 1117.6535274065066, 1117.7149826794116, 11605.0, 11635.01102406305, 11661.416929153509, 11777.941110294394, 11792.174547781573, 509230.0, 513767.0, 520429.0, 523582.0, 527920.0, 119236.0, 121093.0, 121185.0, 121452.0, 121867.39066304611, 1040.9434424059586, 1209.4255228766442, 1234.6110975042832, 1237.4802582915197, 1253.2918900821007, 22139.889300553394, 22621.8868905661, 22997.0, 23211.651825222296, 23406.76593234114, 60571.39428605657, 62655.0, 63170.0, 63590.0, 64379.67810160919, 80379.0, 80445.0, 80492.0, 80754.59622701848, 80953.0, 15515.922420387826, 16024.919875401014, 16028.439004634782, 16037.35850566011, 16077.517674469784, 24164.0, 24437.51124977526, 24487.265382038568, 24507.0, 24578.0, 19620.607587848448, 19738.70391944151, 19824.008799559677, 19869.105890235263, 20032.098555564742, 16809.663806724042, 17242.137893105544, 17587.0, 18006.00966946778, 18345.0, 19652.705209422154, 20260.59478810445, 20389.79610203938, 20597.279095231595, 20609.278675246296, 15716.0, 15736.134512601458, 15808.76286855675, 15808.841911580737, 15856.76214856755, 18415.355462558746, 19450.124744386252, 19462.221511139396, 19522.121504532613, 19605.8039419604], "value": 12788.846728008784, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.4636984315805, 1526.8015158029455, 1528.8700460460875, 1539.3688587679053, 1544.5675210940933, 16397.91801040996, 16988.0, 16989.405370812023, 17000.064996425208, 17005.064721440314, 16140.919295403506, 16405.42581009665, 16440.095794731285, 16456.753148702777, 16467.0, 2785.4011387551673, 2791.1766029021387, 2866.4410439964217, 2869.684334723179, 2875.583040459132, 2854.8001639885215, 2856.057501024667, 2891.161563146685, 2894.6815850256453, 2895.8407287599175, 2734.5487994480986, 2826.2086615747626, 2834.248924035122, 2836.602875597418, 2838.489071967045, 2847.117393607988, 2888.523393640047, 2895.8262504249706, 2899.60855284536, 2919.255589824592, 2734.7948903832093, 2770.6952235254307, 2795.566687163493, 2799.14626039058, 2799.216219458555, 16030.679386412323, 16460.506184814356, 16462.588435289093, 16485.34058637665, 16490.917545412198, 8360.540170290631, 8602.0, 8641.30869530436, 8643.567821608895, 8646.135386461367, 5458.727063646841, 5634.154876768476, 5769.1346298055205, 5809.302883653946, 5919.911201331984, 2027.4829918370722, 2066.9793302067087, 2073.502359433725, 2116.375669177596, 2124.097258665061, 29701.851490742625, 29999.700002999907, 30038.849805750833, 30064.398712025857, 30095.398092038256, 7378.852422951511, 7383.0, 7434.814129646802, 7567.886481702779, 7587.544747315179, 19431.514212144528, 19447.611047778966, 19472.415827525198, 19504.122314495882, 19523.707144392847, 8423.620937057847, 8585.871211931826, 8599.39804213699, 8605.225529702357, 8606.26846718036, 7372.741954031583, 7719.421043421766, 7809.297163255334, 7812.492188007761, 7817.8827317590285, 5819.127130930395, 5820.35976042635, 5875.764969401176, 5903.2325797646035, 6166.167567378347, 1578.4002079210056, 1611.7582362645462, 1645.5556999610278, 1674.2884274183423, 1684.983150168507, 991.7272749993665, 1008.641932114089, 1013.280570794744, 1018.6892997635643, 1027.4246422003703, 9621.08599683029, 9743.902560974442, 9766.902330976742, 9892.901070989197, 10045.0, 1031.2781053262745, 1058.0477570186893, 1060.7772367802693, 1062.9043386095134, 1072.06730144773, 5348.251244825728, 5411.161270003156, 5413.0, 5481.835544933659, 5486.61593688438, 24427.51144977126, 24536.0, 25308.620370694454, 25308.620370694454, 25308.74691253101, 24526.632100518505, 24904.750952490605, 24929.875350623493, 24981.750182498305, 25191.62212566813, 12458.12793104492, 12470.81293780594, 12645.43095560702, 12652.683682907817, 12667.619971400689, 9431.858522122311, 9558.378705384128, 9592.856107158259, 9624.0, 9748.561314740995, 20407.59184816325, 21364.572708546053, 21386.144554217655, 21518.569628607653, 21554.999999999374, 21104.0, 21767.129314827864, 22019.0, 22302.0, 22418.551628967656, 12465.065120115847, 12674.873251267369, 12678.366081695694, 12684.746305074032, 12686.429110689856, 15360.155191464577, 15639.45261915873, 15735.213239337758, 15741.527754167393, 15742.29159687794, 12511.311877846805, 12567.49730010826, 12577.496900124259, 12720.0, 13071.215727056408, 12353.3823308836, 12433.626991190278, 12658.620241392773, 12702.36488175606, 12738.87261127377, 9644.710658680251, 9837.803243934937, 9841.950790246003, 9846.556904939438, 9853.704388868346, 8226.066874284657, 8369.623366948625, 8370.87443688333, 8486.74539763808, 8486.872696909675, 8191.467554608931, 8375.20435558621, 8456.365772566958, 8464.788380290296, 8470.15298470148], "value": 7355.139611219239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.612918698537, 547.3869266421608, 565.3244372974298, 572.627791935242, 578.9305283365994, 6155.692215389229, 6256.436920677138, 6269.2163479565, 6333.366663333676, 6389.0, 6184.876302473948, 6205.317415084337, 6220.6267623942595, 6225.937740622592, 6267.091271765591, 4834.2265237562, 4974.8258810941625, 5126.512981266774, 5175.560077393426, 5189.989805912562, 4994.300797888299, 5006.824761133361, 5008.5993120550265, 5034.119029169899, 5055.115354812893, 4971.279164521142, 4971.552560269575, 5002.549770520653, 5007.2489126630935, 5041.3194218780545, 4918.827841025565, 4939.851804445836, 4945.67853089548, 4958.6281028922795, 5026.874328141789, 4525.32120181972, 4595.322707211877, 4596.931046034279, 4598.218302888484, 4602.125596136723, 6159.722812473449, 6244.438000579924, 6265.154204182422, 6279.654618995954, 6282.120503129566, 5781.768729250825, 5824.534037277008, 5875.706214689249, 5898.439648233454, 5910.379410161957, 6587.275399706028, 6664.666766661648, 6672.69972851218, 6712.194536655584, 6770.796876093725, 4984.601231901475, 5027.3464449621315, 5031.77357018935, 5035.647504674637, 5061.342025536694, 6962.7911162665205, 6983.9650801746175, 7020.824479388005, 7063.223045464994, 7073.115860517435, 5240.318758561439, 5250.133727934848, 5258.526732594085, 5292.841214763564, 5294.100002999499, 5341.65279256847, 5356.973215133899, 5373.650712703662, 5374.5700343972385, 5377.704226267515, 5926.318473375617, 5941.287045554474, 5943.257092863392, 5946.1972633693895, 5949.524038076944, 6297.590656607397, 6417.8716425672155, 6550.934490655128, 6731.596104233761, 6822.829429264209, 1813.220315264449, 1819.8908065515845, 1826.4794533557872, 1838.237131590375, 1844.8431883289802, 1261.520622163572, 1265.1776345375579, 1278.846538415396, 1285.2160182288796, 1294.2428679222571, 6158.137860699506, 6247.781327653511, 6256.343083976117, 6320.873582528324, 6361.236651601837, 6758.357955994173, 6771.0, 6806.863862722717, 6833.214180369222, 6849.280825513349, 6248.125262463259, 6433.613983161025, 6436.710348034256, 6438.291787903327, 6461.773837915651, 3622.3117607654463, 3663.5970043295215, 3666.6333366663653, 3674.4488326751202, 3677.8712745053795, 7220.75066220203, 7235.131784185826, 7265.437930844788, 7283.4537409694485, 7311.707531698672, 7078.398336141383, 7084.43324534036, 7149.820279653903, 7151.570905745568, 7181.281871812777, 7178.425725941912, 7229.819254518574, 7249.275072492708, 7249.746258880914, 7291.8541629168185, 6866.279040700654, 6889.173299204128, 6925.099737034153, 6947.131608548932, 6997.860042799217, 6860.794176174722, 6908.412784913338, 6947.930520694728, 6993.475489338218, 7003.307783784774, 7072.858542829217, 7130.322619351154, 7171.3545780877885, 7220.38626716735, 7227.314069824322, 5145.92281115776, 5160.845174644766, 5196.714180720097, 5211.530962213267, 5275.868103297448, 6650.168728908887, 6839.2476827547935, 6870.3473170048765, 6935.202451718117, 6939.479539034492, 6461.418472337512, 6548.967255163694, 6616.966915165393, 6663.5007123396845, 6691.966540167268, 6532.477401807939, 6568.408843204134, 6602.372774586406, 6640.402363787282, 6693.891424201555, 6336.429721325103, 6339.2392912850755, 6481.287058423475, 6492.48060155177, 6556.901646475211, 6483.319251478527, 6554.0, 6631.3700198481065, 6655.534112612071, 6688.565243259172, 6390.712417941111, 6462.806115816533, 6525.934740652533, 6548.377904099103, 6557.9344206557325], "value": 5238.3467483065315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [953.1746705059811, 988.4069558265041, 988.4810474500887, 1000.4797505297241, 1007.7631756537212, 20953.68569471457, 21312.147514099437, 21334.99999999998, 21456.785432145673, 21487.03308351124, 19213.0, 19372.225110995543, 19880.602387952233, 20037.59924801503, 20196.596068078667, 1050.322541960435, 1086.4893500054961, 1086.5490821309186, 1086.7337502311946, 1087.0596933652373, 1086.239632257419, 1086.7337502311905, 1089.727568107973, 1091.6779550032759, 1128.424503503211, 1165.388171210113, 1169.193256652911, 1169.3860723120345, 1169.7894379011775, 1170.4791367841315, 1143.9599614013512, 1146.1346683254174, 1147.0823341326904, 1147.7073346296725, 1149.6953307373553, 804.9235322644339, 822.9588520574007, 830.7424698343533, 831.4927893984665, 854.7136709202425, 20228.595428091503, 20265.08807103684, 20433.386998390073, 20442.488937776525, 20450.693239601416, 22747.431314217112, 22897.0, 23587.528249435087, 23783.881080594485, 23788.762112378827, 18326.175322110535, 18472.3534676287, 18597.16312765929, 18682.0, 18713.438596842116, 3966.127451960564, 4008.1382502761753, 4013.819378127991, 4016.0160760613544, 4018.3369743992207, 164248.0, 164335.0, 166077.0, 167611.0, 168793.0, 17091.48725538236, 17279.222434990457, 17329.0, 17554.38559650406, 17577.912110439367, 33779.15552111168, 34557.0, 34705.65294347075, 34903.12742181466, 34918.0, 8935.821283574422, 8976.685815996409, 8978.057303983118, 8979.0, 9005.234555062762, 4247.851325203603, 4323.027318853296, 4326.113146804897, 4331.090471001062, 4373.715708479002, 6195.132681424604, 6337.96831015842, 6369.9681501592195, 6384.7126879290545, 6391.872162556723, 1147.713071732067, 1174.1018121137338, 1188.5780547905542, 1193.2899924544881, 1193.2959553863088, 741.9220981796941, 756.2588663110183, 762.4396068889362, 767.5279702982625, 781.199270747477, 13471.0, 13637.249951252577, 13686.110402823784, 14607.561773146823, 14616.415343386145, 697.3340459860821, 702.9753958611526, 725.7133432294214, 736.3225832234357, 743.4795643049887, 6168.0, 6176.135341052256, 6254.21822272216, 6296.905546416808, 6334.3032266450655, 147122.0, 148620.0, 149393.0, 151259.0, 158172.0, 98083.50958245163, 100286.49856750816, 127678.0, 134382.0, 139888.0, 114011.42994284976, 114661.0, 115449.4227528857, 116682.0, 119329.0, 14077.296135192995, 14354.784678229626, 14500.828789966345, 14588.343524541633, 14589.197594132, 53824.19263711126, 55480.44519554753, 57792.71103644455, 58048.12927806171, 58279.12581311199, 71311.0, 71612.0, 71946.0, 72571.63714181395, 74043.0, 20101.97813612719, 20784.0, 20960.895195523924, 20989.475263118544, 21241.68137477908, 21244.468888277916, 21337.466563336042, 21450.892745536174, 21479.248226312004, 21516.892415537823, 19354.903225483784, 19451.0, 19497.415077547696, 19534.511637209183, 19715.11281992285, 18717.53206169802, 18791.71812422842, 18933.431997040112, 18971.33600323982, 18975.0, 21067.0, 21329.0, 21641.78358216398, 21641.783582164608, 21826.0, 14027.438902444195, 15028.624284392978, 15052.0, 15162.545123646309, 15364.0, 15127.621809454411, 15438.0, 15444.768328474856, 15474.0, 15663.608409789846], "value": 10283.08840573345, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1369.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 107.0, 105.0, 104.0, 107.0, 99.0, 108.0, 107.0, 107.0, 108.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 110.0, 112.0, 116.0, 116.0, 114.0, 140.0, 115.0, 115.0], "value": 116.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 165.0, 164.0, 163.0, 166.0, 163.0, 163.0, 167.0, 165.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 73.0, 72.0, 74.0, 73.0, 74.0, 73.0, 75.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 78.0, 77.0, 77.0, 77.0, 77.0, 78.0, 78.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 110.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 151.0, 149.0, 149.0, 151.0, 149.0, 150.0, 151.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 44.0, 45.0, 45.0, 45.0, 44.0, 42.0, 44.0, 43.0], "value": 44.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 37.0, 37.0, 40.0, 37.0, 37.0, 37.0, 37.0, 37.0], "value": 37.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 70.0, 70.0, 69.0, 71.0, 72.0, 71.0, 72.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 108.0, 113.0, 112.0, 106.0, 104.0, 105.0, 105.0, 106.0, 108.0], "value": 107.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 154.0, 155.0, 154.0, 148.0, 154.0, 152.0, 150.0, 162.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 61.0, 62.0, 59.0, 62.0, 62.0, 64.0, 59.0, 58.0], "value": 60.5, "unit": "score"}]}]} 17:40:32 INFO - Return code: 0 17:40:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:40:32 INFO - # TBPL SUCCESS # 17:40:32 INFO - Running post-action listener: _package_coverage_data 17:40:32 INFO - Running post-action listener: _resource_record_post_action 17:40:32 INFO - [mozharness: 2017-09-28 00:40:32.190366Z] Finished run-tests step (success) 17:40:32 INFO - Running post-run listener: _resource_record_post_run 17:40:32 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 151552; Write bytes: 316256256; Read time: 60; Write time: 224540 17:40:32 INFO - TinderboxPrint: CPU usage
13.1% 17:40:32 INFO - TinderboxPrint: I/O read bytes / time
151,552 / 60 17:40:32 INFO - TinderboxPrint: I/O write bytes / time
316,256,256 / 224,540 17:40:32 INFO - TinderboxPrint: CPU idle
8,206.1 (86.9%) 17:40:32 INFO - TinderboxPrint: CPU user
1,186.4 (12.6%) 17:40:32 INFO - TinderboxPrint: Swap in / out
0 / 0 17:40:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 180224; Read time: 0; Write time: 36 17:40:32 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:40:32 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 151552; Write bytes: 316076032; Read time: 60; Write time: 224504 17:40:32 INFO - Running post-run listener: _upload_blobber_files 17:40:32 INFO - Blob upload gear active. 17:40:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:40:32 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 17:40:32 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'] 17:40:32 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 17:40:33 INFO - (blobuploader) - INFO - Open directory for files ... 17:40:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:40:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:40:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:34 INFO - (blobuploader) - INFO - Done attempting. 17:40:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:40:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:40:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:41 INFO - (blobuploader) - INFO - Done attempting. 17:40:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:40:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:40:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:42 INFO - (blobuploader) - INFO - Done attempting. 17:40:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:40:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:40:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:43 INFO - (blobuploader) - INFO - Done attempting. 17:40:43 INFO - (blobuploader) - INFO - Iteration through files over. 17:40:43 INFO - Return code: 0 17:40:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:40:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:40:43 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07f72d65a27565d0a05a766165253815028031f3bafc18d21d9fa9eb3cbc7fa4286196d9271f4880c8a929131b123a7c6e4bbc85964ab7bfc309bc84b0572140", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/735ae6cec490c7ecac9699cd084b1ae901bb75e29f7e05aa40f1ca0ec7f2966e266f089ecf1ec50093e658f8bb79d32732a2e7f9cca5d288a135174a3371e7c8", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/584e75e524caf3edceefd626ec0554b942c7b8af2c8a670bbfd8d4e03a135c325cc1ede335d137d8ecd95ebd62117eee6a07871459fa7c2c6c0989b38d4ecb81", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/371fe3d3f3f085dbc9afe0e3ce466a0c7849c8ae313054213b738704f29da27095e5a3582b5b435daa1fb64baa0b6d2957c5a57b9203e5429768489aaefeaed2"} 17:40:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:40:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:40:43 INFO - Contents: 17:40:43 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07f72d65a27565d0a05a766165253815028031f3bafc18d21d9fa9eb3cbc7fa4286196d9271f4880c8a929131b123a7c6e4bbc85964ab7bfc309bc84b0572140", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/735ae6cec490c7ecac9699cd084b1ae901bb75e29f7e05aa40f1ca0ec7f2966e266f089ecf1ec50093e658f8bb79d32732a2e7f9cca5d288a135174a3371e7c8", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/584e75e524caf3edceefd626ec0554b942c7b8af2c8a670bbfd8d4e03a135c325cc1ede335d137d8ecd95ebd62117eee6a07871459fa7c2c6c0989b38d4ecb81", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/371fe3d3f3f085dbc9afe0e3ce466a0c7849c8ae313054213b738704f29da27095e5a3582b5b435daa1fb64baa0b6d2957c5a57b9203e5429768489aaefeaed2"} 17:40:43 INFO - Running post-run listener: copy_logs_to_upload_dir 17:40:43 INFO - Copying logs to upload dir... 17:40:43 INFO - mkdir: /builds/slave/test/build/upload/logs 17:40:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.617862 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-09-27 17:40:43.529509) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 17:40:43.537018) ========= 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=1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209 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/07f72d65a27565d0a05a766165253815028031f3bafc18d21d9fa9eb3cbc7fa4286196d9271f4880c8a929131b123a7c6e4bbc85964ab7bfc309bc84b0572140", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/735ae6cec490c7ecac9699cd084b1ae901bb75e29f7e05aa40f1ca0ec7f2966e266f089ecf1ec50093e658f8bb79d32732a2e7f9cca5d288a135174a3371e7c8", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/584e75e524caf3edceefd626ec0554b942c7b8af2c8a670bbfd8d4e03a135c325cc1ede335d137d8ecd95ebd62117eee6a07871459fa7c2c6c0989b38d4ecb81", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/371fe3d3f3f085dbc9afe0e3ce466a0c7849c8ae313054213b738704f29da27095e5a3582b5b435daa1fb64baa0b6d2957c5a57b9203e5429768489aaefeaed2"} build_url:https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011654 build_url: 'https://queue.taskcluster.net/v1/task/IgMi7h1TRIKpKFonaQA_1Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07f72d65a27565d0a05a766165253815028031f3bafc18d21d9fa9eb3cbc7fa4286196d9271f4880c8a929131b123a7c6e4bbc85964ab7bfc309bc84b0572140", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/735ae6cec490c7ecac9699cd084b1ae901bb75e29f7e05aa40f1ca0ec7f2966e266f089ecf1ec50093e658f8bb79d32732a2e7f9cca5d288a135174a3371e7c8", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/584e75e524caf3edceefd626ec0554b942c7b8af2c8a670bbfd8d4e03a135c325cc1ede335d137d8ecd95ebd62117eee6a07871459fa7c2c6c0989b38d4ecb81", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/371fe3d3f3f085dbc9afe0e3ce466a0c7849c8ae313054213b738704f29da27095e5a3582b5b435daa1fb64baa0b6d2957c5a57b9203e5429768489aaefeaed2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 17:40:43.567942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:40:43.568274) ========= 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=1f5564757af27664ca02d71f000001b0-1506558008.524126-188805209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:40:43.653399) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 17:40:43.655780) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 17:40:43.656104) ========= ========= Total master_lag: 0.22 =========