builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-037 starttime: 1506640862.62 results: success (0) revision: 307a7a34013060a6a1e87dfbb911f058d0781a2e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:02.618344) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:02.619970) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:02.620233) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:02.692046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:02.692299) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-28 16:21:03-- 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% 36.3M=0s 2017-09-28 16:21:03 (36.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127408 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:02.877977) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:02.878299) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018534 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:02.936214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:02.936660) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 307a7a34013060a6a1e87dfbb911f058d0781a2e --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 307a7a34013060a6a1e87dfbb911f058d0781a2e --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=56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-28 16:21:03,366 truncating revision to first 12 chars 2017-09-28 16:21:03,366 Setting DEBUG logging. 2017-09-28 16:21:03,366 attempt 1/10 2017-09-28 16:21:03,366 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/307a7a340130?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-28 16:21:03,631 unpacking tar archive at: mozilla-central-307a7a340130/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546492 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:03.525302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:03.527591) ========= script_repo_revision: 307a7a34013060a6a1e87dfbb911f058d0781a2e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:03.527938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:03.528192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 16:21:03.541943) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-28 16:21:03.542247) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:21:04 INFO - MultiFileLogger online at 20170928 16:21:04 in /builds/slave/test 16:21:04 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 16:21:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:21:04 INFO - {'append_to_log': False, 16:21:04 INFO - 'base_work_dir': '/builds/slave/test', 16:21:04 INFO - 'blob_upload_branch': 'Firefox', 16:21:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:21:04 INFO - 'branch': 'Firefox', 16:21:04 INFO - 'buildbot_json_path': 'buildprops.json', 16:21:04 INFO - 'code_coverage': False, 16:21:04 INFO - 'config_files': ('talos/linux_config.py',), 16:21:04 INFO - 'default_actions': ('clobber', 16:21:04 INFO - 'read-buildbot-config', 16:21:04 INFO - 'download-and-extract', 16:21:04 INFO - 'populate-webroot', 16:21:04 INFO - 'create-virtualenv', 16:21:04 INFO - 'install', 16:21:04 INFO - 'setup-mitmproxy', 16:21:04 INFO - 'run-tests'), 16:21:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:21:04 INFO - 'disable_ccov_upload': False, 16:21:04 INFO - 'disable_stylo': False, 16:21:04 INFO - 'download_minidump_stackwalk': True, 16:21:04 INFO - 'download_symbols': 'ondemand', 16:21:04 INFO - 'enable_stylo': False, 16:21:04 INFO - 'enable_webrender': False, 16:21:04 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:21:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:21:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:21:04 INFO - 'gecko_profile': False, 16:21:04 INFO - 'gecko_profile_interval': 0, 16:21:04 INFO - 'installer_path': 'installer.exe', 16:21:04 INFO - 'log_level': 'info', 16:21:04 INFO - 'log_name': 'talos', 16:21:04 INFO - 'log_to_console': True, 16:21:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:21:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:21:04 INFO - 'opt_config_files': (), 16:21:04 INFO - 'pip_index': False, 16:21:04 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 16:21:04 INFO - 'system_bits': '32', 16:21:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:21:04 INFO - 'title': 'talos-linux64-ix-037', 16:21:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:21:04 INFO - 'use_talos_json': True, 16:21:04 INFO - 'verify': 'False', 16:21:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:21:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:21:04 INFO - 'work_dir': 'build'} 16:21:04 INFO - [mozharness: 2017-09-28 23:21:04.098344Z] Running clobber step. 16:21:04 INFO - Running pre-action listener: _resource_record_pre_action 16:21:04 INFO - Running main action method: clobber 16:21:04 INFO - rmtree: /builds/slave/test/build 16:21:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:21:05 INFO - Running post-action listener: _resource_record_post_action 16:21:05 INFO - [mozharness: 2017-09-28 23:21:05.616292Z] Finished clobber step (success) 16:21:05 INFO - [mozharness: 2017-09-28 23:21:05.616389Z] Running read-buildbot-config step. 16:21:05 INFO - Running pre-action listener: _resource_record_pre_action 16:21:05 INFO - Running main action method: read_buildbot_config 16:21:05 INFO - Using buildbot properties: 16:21:05 INFO - { 16:21:05 INFO - "project": "", 16:21:05 INFO - "product": "firefox", 16:21:05 INFO - "who": "ryanvm@gmail.com", 16:21:05 INFO - "installer_path": "public/build/target.tar.bz2", 16:21:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 16:21:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:21:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 16:21:05 INFO - "stage_platform": "linux64-pgo", 16:21:05 INFO - "basedir": "/builds/slave/test", 16:21:05 INFO - "buildnumber": 71, 16:21:05 INFO - "platform": "ubuntu64_hw", 16:21:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:21:05 INFO - "slavebuilddir": "test", 16:21:05 INFO - "taskId": "Cn5C7mtnRU6MDdWAWPmx9Q", 16:21:05 INFO - "branch": "mozilla-central", 16:21:05 INFO - "script_repo_revision": "production", 16:21:05 INFO - "revision": "307a7a34013060a6a1e87dfbb911f058d0781a2e", 16:21:05 INFO - "slavename": "talos-linux64-ix-037", 16:21:05 INFO - "repo_path": "mozilla-central" 16:21:05 INFO - } 16:21:05 INFO - Finding installer, test and symbols from parent task. 16:21:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cn5C7mtnRU6MDdWAWPmx9Q'}, attempt #1 16:21:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cn5C7mtnRU6MDdWAWPmx9Q'}, attempt #1 16:21:06 INFO - Task dependencies: cmYlyjEDRk2IOAJ-a13Uqg 16:21:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg'}, attempt #1 16:21:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.tar.bz2 16:21:07 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.test_packages.json 16:21:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.crashreporter-symbols.zip 16:21:07 INFO - Running post-action listener: _resource_record_post_action 16:21:07 INFO - [mozharness: 2017-09-28 23:21:07.034465Z] Finished read-buildbot-config step (success) 16:21:07 INFO - [mozharness: 2017-09-28 23:21:07.034686Z] Running download-and-extract step. 16:21:07 INFO - Running pre-action listener: _resource_record_pre_action 16:21:07 INFO - Running main action method: download_and_extract 16:21:07 INFO - mkdir: /builds/slave/test/build/tests 16:21:07 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')]} 16:21:07 INFO - trying https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.test_packages.json 16:21:07 INFO - Downloading https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:21:07 INFO - Downloaded 989 bytes. 16:21:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:21:07 INFO - Using the following test package requirements: 16:21:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:21:07 INFO - u'common': [u'target.common.tests.zip'], 16:21:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:21:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:21:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:21:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:21:07 INFO - u'mozbase': [u'target.common.tests.zip'], 16:21:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:21:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:21:07 INFO - u'web-platform': [u'target.common.tests.zip', 16:21:07 INFO - u'target.web-platform.tests.tar.gz'], 16:21:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:21:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:21:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.common.tests.zip 16:21:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:21:07 INFO - Fetch https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.common.tests.zip into memory 16:21:09 INFO - Content-Length response header: 55830420 16:21:09 INFO - Bytes received: 55830420 16:21:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.talos.tests.zip 16:21:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:21:19 INFO - Fetch https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.talos.tests.zip into memory 16:21:21 INFO - Content-Length response header: 14521162 16:21:21 INFO - Bytes received: 14521162 16:21:21 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')]} 16:21:21 INFO - trying https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.tar.bz2 16:21:21 INFO - Downloading https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:21:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:21:24 INFO - Downloaded 62432193 bytes. 16:21:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.tar.bz2 16:21:24 INFO - mkdir: /builds/slave/test/properties 16:21:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:21:24 INFO - Writing to file /builds/slave/test/properties/build_url 16:21:24 INFO - Contents: 16:21:24 INFO - build_url:https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.tar.bz2 16:21:24 INFO - Running post-action listener: _resource_record_post_action 16:21:24 INFO - Running post-action listener: find_tests_for_verification 16:21:24 INFO - Running post-action listener: set_extra_try_arguments 16:21:24 INFO - [mozharness: 2017-09-28 23:21:24.911536Z] Finished download-and-extract step (success) 16:21:24 INFO - [mozharness: 2017-09-28 23:21:24.911636Z] Running populate-webroot step. 16:21:24 INFO - Running pre-action listener: _resource_record_pre_action 16:21:24 INFO - Running main action method: populate_webroot 16:21:24 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:21:24 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:21:24 INFO - 'tests': ['tresize', 16:21:24 INFO - 'tcanvasmark']}, 16:21:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:21:24 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:21:24 INFO - 'tests': ['dromaeo_css', 16:21:24 INFO - 'kraken']}, 16:21:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:21:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:24 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:21:24 INFO - 'talos_options': ['--disable-stylo'], 16:21:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:21:24 INFO - 'tests': ['damp', 'tps']}, 16:21:24 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:21:24 INFO - 'talos_options': ['--disable-stylo'], 16:21:24 INFO - 'tests': ['damp', 'tps']}, 16:21:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:21:24 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:21:24 INFO - 'tests': ['dromaeo_dom']}, 16:21:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:21:24 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:21:24 INFO - 'tests': ['basic_compositor_video', 16:21:24 INFO - 'glvideo']}, 16:21:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:21:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:21:24 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:21:24 INFO - 'talos_options': ['--disable-stylo'], 16:21:24 INFO - 'tests': ['ts_paint_webext', 16:21:24 INFO - 'tp5o_webext']}, 16:21:24 INFO - 'other-e10s': {'tests': ['a11yr', 16:21:24 INFO - 'ts_paint', 16:21:24 INFO - 'tpaint', 16:21:24 INFO - 'sessionrestore', 16:21:24 INFO - 'sessionrestore_many_windows', 16:21:24 INFO - 'sessionrestore_no_auto_restore', 16:21:24 INFO - 'tabpaint', 16:21:24 INFO - 'cpstartup']}, 16:21:24 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:21:24 INFO - 'tests': ['a11yr', 16:21:24 INFO - 'ts_paint', 16:21:24 INFO - 'tpaint', 16:21:24 INFO - 'sessionrestore', 16:21:24 INFO - 'sessionrestore_many_windows', 16:21:24 INFO - 'sessionrestore_no_auto_restore', 16:21:24 INFO - 'tabpaint', 16:21:24 INFO - 'cpstartup']}, 16:21:24 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 16:21:24 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:21:24 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:21:24 INFO - 'tests': ['perf_reftest_singletons']}, 16:21:24 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:21:24 INFO - 'tests': ['perf_reftest']}, 16:21:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:21:24 INFO - 'tsvgr_opacity', 16:21:24 INFO - 'tart', 16:21:24 INFO - 'tscrollx', 16:21:24 INFO - 'tsvg_static']}, 16:21:24 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:21:24 INFO - 'tests': ['tsvgx', 16:21:24 INFO - 'tsvgr_opacity', 16:21:24 INFO - 'tart', 16:21:24 INFO - 'tscrollx', 16:21:24 INFO - 'tsvg_static']}, 16:21:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:21:24 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:21:24 INFO - 'talos_options': ['--disable-stylo'], 16:21:24 INFO - 'tests': ['tp5o']}, 16:21:24 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:21:24 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:21:24 INFO - 'talos_options': ['--mitmproxy', 16:21:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:21:24 INFO - '--firstNonBlankPaint'], 16:21:24 INFO - 'tests': ['tp6_google', 16:21:24 INFO - 'tp6_youtube', 16:21:24 INFO - 'tp6_amazon', 16:21:24 INFO - 'tp6_facebook']}, 16:21:24 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:21:24 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:21:24 INFO - 'talos_options': ['--disable-stylo', 16:21:24 INFO - '--mitmproxy', 16:21:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:21:24 INFO - '--firstNonBlankPaint'], 16:21:24 INFO - 'tests': ['tp6_google', 16:21:24 INFO - 'tp6_youtube', 16:21:24 INFO - 'tp6_amazon', 16:21:24 INFO - 'tp6_facebook']}, 16:21:24 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:21:24 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:21:24 INFO - 'talos_options': ['--stylo-threads=1', 16:21:24 INFO - '--mitmproxy', 16:21:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:21:24 INFO - '--firstNonBlankPaint'], 16:21:24 INFO - 'tests': ['tp6_google', 16:21:24 INFO - 'tp6_youtube', 16:21:24 INFO - 'tp6_amazon', 16:21:24 INFO - 'tp6_facebook']}, 16:21:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:21:24 INFO - 'talos_options': ['--xperf_path', 16:21:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:24 INFO - 'tests': ['tp5n']}, 16:21:24 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:21:24 INFO - 'talos_options': ['--disable-stylo', 16:21:24 INFO - '--xperf_path', 16:21:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:24 INFO - 'tests': ['tp5n']}}} 16:21:24 INFO - Running post-action listener: _resource_record_post_action 16:21:24 INFO - [mozharness: 2017-09-28 23:21:24.933059Z] Finished populate-webroot step (success) 16:21:24 INFO - [mozharness: 2017-09-28 23:21:24.933149Z] Running create-virtualenv step. 16:21:24 INFO - Running pre-action listener: _resource_record_pre_action 16:21:24 INFO - Running main action method: create_virtualenv 16:21:24 INFO - Creating virtualenv /builds/slave/test/build/venv 16:21:24 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:21:24 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:21:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:21:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:21:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:21:25 INFO - Installing distribute.............................................................................................................................................................................................done. 16:21:25 INFO - Installing pip...............done. 16:21:25 INFO - Return code: 0 16:21:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:21:25 INFO - Reading from file tmpfile_stdout 16:21:25 INFO - Output received: 16:21:25 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:21:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:21:25 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')]} 16:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:25 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')]} 16:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:25 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 0x1f7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2145b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec440>, '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 0x22ed130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7320>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', '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 16:21:25 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 16:21:25 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 16:21:25 INFO - Using env: {'DISPLAY': ':0', 16:21:25 INFO - 'HOME': '/home/cltbld', 16:21:25 INFO - 'LANG': 'en_US.UTF-8', 16:21:25 INFO - 'LANGUAGE': 'en_US:en', 16:21:25 INFO - 'LOGNAME': 'cltbld', 16:21:25 INFO - 'MAIL': '/var/mail/cltbld', 16:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:25 INFO - 'MOZ_NO_REMOTE': '1', 16:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:25 INFO - 'NO_EM_RESTART': '1', 16:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:25 INFO - 'PWD': '/builds/slave/test', 16:21:25 INFO - 'SHELL': '/bin/bash', 16:21:25 INFO - 'SHLVL': '1', 16:21:25 INFO - 'TERM': 'linux', 16:21:25 INFO - 'TMOUT': '86400', 16:21:25 INFO - 'USER': 'cltbld', 16:21:25 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', 16:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:25 INFO - '_': '/tools/buildbot/bin/python'} 16:21:27 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:21:27 INFO - Downloading/unpacking pip>=1.5 16:21:27 INFO - Running setup.py egg_info for package pip 16:21:27 INFO - warning: no files found matching 'pip/cacert.pem' 16:21:27 INFO - warning: no files found matching '*.html' under directory 'docs' 16:21:27 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:21:27 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:21:27 INFO - Installing collected packages: pip 16:21:27 INFO - Found existing installation: pip 1.1 16:21:27 INFO - Uninstalling pip: 16:21:27 INFO - Successfully uninstalled pip 16:21:27 INFO - Running setup.py install for pip 16:21:27 INFO - warning: no files found matching 'pip/cacert.pem' 16:21:27 INFO - warning: no files found matching '*.html' under directory 'docs' 16:21:27 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:21:27 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:21:27 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:21:27 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:21:27 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:21:27 INFO - Successfully installed pip 16:21:27 INFO - Cleaning up... 16:21:27 INFO - Return code: 0 16:21:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:27 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 0x1f7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2145b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec440>, '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 0x22ed130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7320>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', '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 16:21:27 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 16:21:27 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 16:21:27 INFO - Using env: {'DISPLAY': ':0', 16:21:27 INFO - 'HOME': '/home/cltbld', 16:21:27 INFO - 'LANG': 'en_US.UTF-8', 16:21:27 INFO - 'LANGUAGE': 'en_US:en', 16:21:27 INFO - 'LOGNAME': 'cltbld', 16:21:27 INFO - 'MAIL': '/var/mail/cltbld', 16:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:27 INFO - 'MOZ_NO_REMOTE': '1', 16:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:27 INFO - 'NO_EM_RESTART': '1', 16:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:27 INFO - 'PWD': '/builds/slave/test', 16:21:27 INFO - 'SHELL': '/bin/bash', 16:21:27 INFO - 'SHLVL': '1', 16:21:27 INFO - 'TERM': 'linux', 16:21:27 INFO - 'TMOUT': '86400', 16:21:27 INFO - 'USER': 'cltbld', 16:21:27 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', 16:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:27 INFO - '_': '/tools/buildbot/bin/python'} 16:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:27 INFO - Downloading/unpacking psutil>=3.1.1 16:21:27 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 16:21:27 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 16:21:27 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 16:21:27 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 16:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:21:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:28 INFO - Installing collected packages: psutil 16:21:28 INFO - Running setup.py install for psutil 16:21:28 INFO - building 'psutil._psutil_linux' extension 16:21:28 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 16:21:28 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 16:21:28 INFO - building 'psutil._psutil_posix' extension 16:21:28 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 16:21:28 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 16:21:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:29 INFO - Successfully installed psutil 16:21:29 INFO - Cleaning up... 16:21:29 INFO - Return code: 0 16:21:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:21:29 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')]} 16:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:29 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')]} 16:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:29 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 0x1f7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2145b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec440>, '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 0x22ed130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7320>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', '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 16:21:29 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 16:21:29 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 16:21:29 INFO - Using env: {'DISPLAY': ':0', 16:21:29 INFO - 'HOME': '/home/cltbld', 16:21:29 INFO - 'LANG': 'en_US.UTF-8', 16:21:29 INFO - 'LANGUAGE': 'en_US:en', 16:21:29 INFO - 'LOGNAME': 'cltbld', 16:21:29 INFO - 'MAIL': '/var/mail/cltbld', 16:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:29 INFO - 'MOZ_NO_REMOTE': '1', 16:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:29 INFO - 'NO_EM_RESTART': '1', 16:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:29 INFO - 'PWD': '/builds/slave/test', 16:21:29 INFO - 'SHELL': '/bin/bash', 16:21:29 INFO - 'SHLVL': '1', 16:21:29 INFO - 'TERM': 'linux', 16:21:29 INFO - 'TMOUT': '86400', 16:21:29 INFO - 'USER': 'cltbld', 16:21:29 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', 16:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:29 INFO - '_': '/tools/buildbot/bin/python'} 16:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:21:29 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 16:21:29 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 16:21:29 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 16:21:29 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 16:21:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:21:30 INFO - Installing collected packages: mozsystemmonitor 16:21:30 INFO - Running setup.py install for mozsystemmonitor 16:21:30 INFO - Successfully installed mozsystemmonitor 16:21:30 INFO - Cleaning up... 16:21:31 INFO - Return code: 0 16:21:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:21:31 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')]} 16:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:31 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')]} 16:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:31 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 0x1f7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2145b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec440>, '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 0x22ed130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7320>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', '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 16:21:31 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 16:21:31 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 16:21:31 INFO - Using env: {'DISPLAY': ':0', 16:21:31 INFO - 'HOME': '/home/cltbld', 16:21:31 INFO - 'LANG': 'en_US.UTF-8', 16:21:31 INFO - 'LANGUAGE': 'en_US:en', 16:21:31 INFO - 'LOGNAME': 'cltbld', 16:21:31 INFO - 'MAIL': '/var/mail/cltbld', 16:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:31 INFO - 'MOZ_NO_REMOTE': '1', 16:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:31 INFO - 'NO_EM_RESTART': '1', 16:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:31 INFO - 'PWD': '/builds/slave/test', 16:21:31 INFO - 'SHELL': '/bin/bash', 16:21:31 INFO - 'SHLVL': '1', 16:21:31 INFO - 'TERM': 'linux', 16:21:31 INFO - 'TMOUT': '86400', 16:21:31 INFO - 'USER': 'cltbld', 16:21:31 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', 16:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:31 INFO - '_': '/tools/buildbot/bin/python'} 16:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:31 INFO - Downloading/unpacking jsonschema==2.5.1 16:21:31 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 16:21:31 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 16:21:31 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 16:21:31 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 16:21:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:21:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:21: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 16:21: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 16:21: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 16:21: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 16:21:32 INFO - Downloading functools32-3.2.3-2.tar.gz 16:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:21:32 INFO - warning: no files found matching '*.txt' 16:21:32 INFO - no previously-included directories found matching 'build' 16:21:32 INFO - no previously-included directories found matching 'dist' 16:21:32 INFO - no previously-included directories found matching '.git*' 16:21:32 INFO - Installing collected packages: jsonschema, functools32 16:21:32 INFO - Running setup.py install for functools32 16:21:32 INFO - warning: no files found matching '*.txt' 16:21:32 INFO - no previously-included directories found matching 'build' 16:21:32 INFO - no previously-included directories found matching 'dist' 16:21:32 INFO - no previously-included directories found matching '.git*' 16:21:32 INFO - Successfully installed jsonschema functools32 16:21:32 INFO - Cleaning up... 16:21:32 INFO - Return code: 0 16:21:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:21: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')]} 16:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21: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')]} 16:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21: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', '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 0x1f7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2145b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec440>, '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 0x22ed130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7320>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', '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 16:21: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:21: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 functools32==3.2.3-2 16:21:32 INFO - Using env: {'DISPLAY': ':0', 16:21:32 INFO - 'HOME': '/home/cltbld', 16:21:32 INFO - 'LANG': 'en_US.UTF-8', 16:21:32 INFO - 'LANGUAGE': 'en_US:en', 16:21:32 INFO - 'LOGNAME': 'cltbld', 16:21:32 INFO - 'MAIL': '/var/mail/cltbld', 16:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:32 INFO - 'MOZ_NO_REMOTE': '1', 16:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:32 INFO - 'NO_EM_RESTART': '1', 16:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:32 INFO - 'PWD': '/builds/slave/test', 16:21:32 INFO - 'SHELL': '/bin/bash', 16:21:32 INFO - 'SHLVL': '1', 16:21:32 INFO - 'TERM': 'linux', 16:21:32 INFO - 'TMOUT': '86400', 16:21:32 INFO - 'USER': 'cltbld', 16:21:32 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', 16:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:32 INFO - '_': '/tools/buildbot/bin/python'} 16:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:21:33 INFO - Cleaning up... 16:21:33 INFO - Return code: 0 16:21:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:21: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')]} 16:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21: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')]} 16:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21: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', '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 0x1f7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2145b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec440>, '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 0x22ed130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7320>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', '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 16:21: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:21: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 blobuploader==1.2.4 16:21:33 INFO - Using env: {'DISPLAY': ':0', 16:21:33 INFO - 'HOME': '/home/cltbld', 16:21:33 INFO - 'LANG': 'en_US.UTF-8', 16:21:33 INFO - 'LANGUAGE': 'en_US:en', 16:21:33 INFO - 'LOGNAME': 'cltbld', 16:21:33 INFO - 'MAIL': '/var/mail/cltbld', 16:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:33 INFO - 'MOZ_NO_REMOTE': '1', 16:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:33 INFO - 'NO_EM_RESTART': '1', 16:21:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:33 INFO - 'PWD': '/builds/slave/test', 16:21:33 INFO - 'SHELL': '/bin/bash', 16:21:33 INFO - 'SHLVL': '1', 16:21:33 INFO - 'TERM': 'linux', 16:21:33 INFO - 'TMOUT': '86400', 16:21:33 INFO - 'USER': 'cltbld', 16:21:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', 16:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:33 INFO - '_': '/tools/buildbot/bin/python'} 16:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:33 INFO - Downloading/unpacking blobuploader==1.2.4 16:21:33 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 16:21:33 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 16:21:33 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 16:21:33 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 16:21:34 INFO - Downloading blobuploader-1.2.4.tar.gz 16:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:21:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:21: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 16:21: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 16:21: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 16:21: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 16:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:21:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:21: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 16:21: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 16:21: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 16:21: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 16:21:34 INFO - Downloading docopt-0.6.1.tar.gz 16:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:21:35 INFO - Installing collected packages: blobuploader, requests, docopt 16:21:35 INFO - Running setup.py install for blobuploader 16:21:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:21:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:21:35 INFO - Running setup.py install for requests 16:21:35 INFO - Running setup.py install for docopt 16:21:35 INFO - Successfully installed blobuploader requests docopt 16:21:35 INFO - Cleaning up... 16:21:35 INFO - Return code: 0 16:21:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21: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')]} 16:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21: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')]} 16:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:35 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 0x1f7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2145b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec440>, '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 0x22ed130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7320>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', '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 16:21:35 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 16:21:35 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 16:21:35 INFO - Using env: {'DISPLAY': ':0', 16:21:35 INFO - 'HOME': '/home/cltbld', 16:21:35 INFO - 'LANG': 'en_US.UTF-8', 16:21:35 INFO - 'LANGUAGE': 'en_US:en', 16:21:35 INFO - 'LOGNAME': 'cltbld', 16:21:35 INFO - 'MAIL': '/var/mail/cltbld', 16:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:35 INFO - 'MOZ_NO_REMOTE': '1', 16:21:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:35 INFO - 'NO_EM_RESTART': '1', 16:21:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:35 INFO - 'PWD': '/builds/slave/test', 16:21:35 INFO - 'SHELL': '/bin/bash', 16:21:35 INFO - 'SHLVL': '1', 16:21:35 INFO - 'TERM': 'linux', 16:21:35 INFO - 'TMOUT': '86400', 16:21:35 INFO - 'USER': 'cltbld', 16:21:35 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', 16:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:35 INFO - '_': '/tools/buildbot/bin/python'} 16:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:35 INFO - Running setup.py (path:/tmp/pip-VbGjrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:35 INFO - Running setup.py (path:/tmp/pip-cHwQkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:35 INFO - Running setup.py (path:/tmp/pip-nqbD_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:36 INFO - Running setup.py (path:/tmp/pip-d3ASWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:36 INFO - Running setup.py (path:/tmp/pip-ImL3uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:36 INFO - Running setup.py (path:/tmp/pip-5i1mBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:36 INFO - Running setup.py (path:/tmp/pip-z_g31a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:36 INFO - Running setup.py (path:/tmp/pip-x_52LC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:36 INFO - Running setup.py (path:/tmp/pip-JQg_yT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:36 INFO - Running setup.py (path:/tmp/pip-_WlnNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:36 INFO - Running setup.py (path:/tmp/pip-flKjL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:36 INFO - Running setup.py (path:/tmp/pip-T6a0j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:36 INFO - Running setup.py (path:/tmp/pip-A4kc6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:36 INFO - Running setup.py (path:/tmp/pip-41ty0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:36 INFO - Running setup.py (path:/tmp/pip-ejbcUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:36 INFO - Running setup.py (path:/tmp/pip-TLhONC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:36 INFO - Running setup.py (path:/tmp/pip-BKP6H7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:21:37 INFO - Running setup.py install for manifestparser 16:21:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:21:37 INFO - Running setup.py install for mozcrash 16:21:37 INFO - Running setup.py install for mozdebug 16:21:37 INFO - Running setup.py install for mozdevice 16:21:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:21:37 INFO - Running setup.py install for mozfile 16:21:37 INFO - Running setup.py install for mozhttpd 16:21:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:21:37 INFO - Running setup.py install for mozinfo 16:21:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:21:37 INFO - Running setup.py install for mozInstall 16:21:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:21:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:21:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:21:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:21:37 INFO - Running setup.py install for mozleak 16:21:37 INFO - Running setup.py install for mozlog 16:21:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:21:38 INFO - Running setup.py install for moznetwork 16:21:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:21:38 INFO - Running setup.py install for mozprocess 16:21:38 INFO - Running setup.py install for mozprofile 16:21:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:21:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:21:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:21:38 INFO - Running setup.py install for mozrunner 16:21:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:21:38 INFO - Running setup.py install for mozscreenshot 16:21:38 INFO - Running setup.py install for moztest 16:21:38 INFO - Running setup.py install for mozversion 16:21:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:21:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:21:38 INFO - Cleaning up... 16:21:38 INFO - Return code: 0 16:21:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21: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')]} 16:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21: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')]} 16:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:38 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 0x1f7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2145b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec440>, '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 0x22ed130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7320>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', '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 16:21:38 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 16:21:38 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 16:21:38 INFO - Using env: {'DISPLAY': ':0', 16:21:38 INFO - 'HOME': '/home/cltbld', 16:21:38 INFO - 'LANG': 'en_US.UTF-8', 16:21:38 INFO - 'LANGUAGE': 'en_US:en', 16:21:38 INFO - 'LOGNAME': 'cltbld', 16:21:38 INFO - 'MAIL': '/var/mail/cltbld', 16:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:38 INFO - 'MOZ_NO_REMOTE': '1', 16:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:38 INFO - 'NO_EM_RESTART': '1', 16:21:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:38 INFO - 'PWD': '/builds/slave/test', 16:21:38 INFO - 'SHELL': '/bin/bash', 16:21:38 INFO - 'SHLVL': '1', 16:21:38 INFO - 'TERM': 'linux', 16:21:38 INFO - 'TMOUT': '86400', 16:21:38 INFO - 'USER': 'cltbld', 16:21:38 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', 16:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:38 INFO - '_': '/tools/buildbot/bin/python'} 16:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:39 INFO - Running setup.py (path:/tmp/pip-D2SZSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:39 INFO - Running setup.py (path:/tmp/pip-90tuIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:39 INFO - Running setup.py (path:/tmp/pip-zAhlxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:39 INFO - Running setup.py (path:/tmp/pip-4uiO88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:39 INFO - Running setup.py (path:/tmp/pip-0BWKzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:39 INFO - Running setup.py (path:/tmp/pip-ZCFCpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:39 INFO - Running setup.py (path:/tmp/pip-4mxHZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:39 INFO - Running setup.py (path:/tmp/pip-KwD5dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:39 INFO - Running setup.py (path:/tmp/pip-D3mUDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:39 INFO - Running setup.py (path:/tmp/pip-PlbyAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:39 INFO - Running setup.py (path:/tmp/pip-yKn4vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:39 INFO - Running setup.py (path:/tmp/pip-pzglKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:39 INFO - Running setup.py (path:/tmp/pip-_wE0lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:39 INFO - Running setup.py (path:/tmp/pip-wjVmJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:40 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)) 16:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:40 INFO - Running setup.py (path:/tmp/pip-sOshIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:40 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)) 16:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:40 INFO - Running setup.py (path:/tmp/pip-dpiuAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:40 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)) 16:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:40 INFO - Running setup.py (path:/tmp/pip-jkYqiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:40 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)) 16:21:40 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)) 16:21:40 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)) 16:21:40 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)) 16:21:40 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)) 16:21:40 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)) 16:21:40 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)) 16:21:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:21:40 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 16:21:40 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 16:21:40 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 16:21:40 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 16:21:41 INFO - Downloading blessings-1.6.tar.gz 16:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:21:41 INFO - Installing collected packages: blessings 16:21:41 INFO - Running setup.py install for blessings 16:21:41 INFO - Successfully installed blessings 16:21:41 INFO - Cleaning up... 16:21:41 INFO - Return code: 0 16:21:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:21:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:41 INFO - Reading from file tmpfile_stdout 16:21:41 INFO - Current package versions: 16:21:41 INFO - argparse == 1.2.1 16:21:41 INFO - blessings == 1.6 16:21:41 INFO - blobuploader == 1.2.4 16:21:41 INFO - docopt == 0.6.1 16:21:41 INFO - functools32 == 3.2.3-2 16:21:41 INFO - jsonschema == 2.5.1 16:21:41 INFO - manifestparser == 1.1 16:21:41 INFO - mozInstall == 1.13 16:21:41 INFO - mozcrash == 1.0 16:21:41 INFO - mozdebug == 0.1 16:21:41 INFO - mozdevice == 0.51 16:21:41 INFO - mozfile == 1.2 16:21:41 INFO - mozhttpd == 0.7 16:21:41 INFO - mozinfo == 0.10 16:21:41 INFO - mozleak == 0.1 16:21:41 INFO - mozlog == 3.5 16:21:41 INFO - moznetwork == 0.27 16:21:41 INFO - mozprocess == 0.25 16:21:41 INFO - mozprofile == 0.28 16:21:41 INFO - mozrunner == 6.13 16:21:41 INFO - mozscreenshot == 0.1 16:21:41 INFO - mozsystemmonitor == 0.3 16:21:41 INFO - moztest == 0.8 16:21:41 INFO - mozversion == 1.4 16:21:41 INFO - psutil == 3.1.1 16:21:41 INFO - requests == 1.2.3 16:21:41 INFO - wsgiref == 0.1.2 16:21:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21: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')]} 16:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21: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')]} 16:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:41 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 0x1f7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2145b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec440>, '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 0x22ed130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7320>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', '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 16:21:41 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 16:21:41 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 16:21:41 INFO - Using env: {'DISPLAY': ':0', 16:21:41 INFO - 'HOME': '/home/cltbld', 16:21:41 INFO - 'LANG': 'en_US.UTF-8', 16:21:41 INFO - 'LANGUAGE': 'en_US:en', 16:21:41 INFO - 'LOGNAME': 'cltbld', 16:21:41 INFO - 'MAIL': '/var/mail/cltbld', 16:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:41 INFO - 'MOZ_NO_REMOTE': '1', 16:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:41 INFO - 'NO_EM_RESTART': '1', 16:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:41 INFO - 'PWD': '/builds/slave/test', 16:21:41 INFO - 'SHELL': '/bin/bash', 16:21:41 INFO - 'SHLVL': '1', 16:21:41 INFO - 'TERM': 'linux', 16:21:41 INFO - 'TMOUT': '86400', 16:21:41 INFO - 'USER': 'cltbld', 16:21:41 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', 16:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:41 INFO - '_': '/tools/buildbot/bin/python'} 16:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:41 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)) 16:21:41 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)) 16:21:41 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)) 16:21:41 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)) 16:21:41 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)) 16:21:41 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)) 16:21:41 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)) 16:21:41 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)) 16:21:41 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)) 16:21:41 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:21:43 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)) 16:21:43 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)) 16:21:43 INFO - Installing collected packages: simplejson 16:21:43 INFO - Running setup.py install for simplejson 16:21:43 INFO - building 'simplejson._speedups' extension 16:21:43 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 16:21:44 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 16:21:44 INFO - Successfully installed simplejson 16:21:44 INFO - Cleaning up... 16:21:44 INFO - Return code: 0 16:21:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:21: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')]} 16:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21: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')]} 16:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2145b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec440>, '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 0x22ed130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7320>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', '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 16:21:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:21:44 INFO - Using env: {'DISPLAY': ':0', 16:21:44 INFO - 'HOME': '/home/cltbld', 16:21:44 INFO - 'LANG': 'en_US.UTF-8', 16:21:44 INFO - 'LANGUAGE': 'en_US:en', 16:21:44 INFO - 'LOGNAME': 'cltbld', 16:21:44 INFO - 'MAIL': '/var/mail/cltbld', 16:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:44 INFO - 'MOZ_NO_REMOTE': '1', 16:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:44 INFO - 'NO_EM_RESTART': '1', 16:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:44 INFO - 'PWD': '/builds/slave/test', 16:21:44 INFO - 'SHELL': '/bin/bash', 16:21:44 INFO - 'SHLVL': '1', 16:21:44 INFO - 'TERM': 'linux', 16:21:44 INFO - 'TMOUT': '86400', 16:21:44 INFO - 'USER': 'cltbld', 16:21:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', 16:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:44 INFO - '_': '/tools/buildbot/bin/python'} 16:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:21:44 INFO - Cleaning up... 16:21:44 INFO - Return code: 0 16:21:44 INFO - Running post-action listener: _resource_record_post_action 16:21:44 INFO - Running post-action listener: _start_resource_monitoring 16:21:44 INFO - Starting resource monitoring. 16:21:44 INFO - [mozharness: 2017-09-28 23:21:44.496580Z] Finished create-virtualenv step (success) 16:21:44 INFO - [mozharness: 2017-09-28 23:21:44.497174Z] Running install step. 16:21:44 INFO - Running pre-action listener: _resource_record_pre_action 16:21:44 INFO - Running main action method: install 16:21:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:44 INFO - Reading from file tmpfile_stdout 16:21:44 INFO - Detecting whether we're running mozinstall >=1.0... 16:21:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:21:44 INFO - Reading from file tmpfile_stdout 16:21:44 INFO - Output received: 16:21:44 INFO - Usage: mozinstall [options] installer 16:21:44 INFO - Options: 16:21:44 INFO - -h, --help show this help message and exit 16:21:44 INFO - -d DEST, --destination=DEST 16:21:44 INFO - Directory to install application into. [default: 16:21:44 INFO - "/builds/slave/test"] 16:21:44 INFO - --app=APP Application being installed. [default: firefox] 16:21:44 INFO - mkdir: /builds/slave/test/build/application 16:21:44 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'] 16:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:22:02 INFO - Reading from file tmpfile_stdout 16:22:02 INFO - Output received: 16:22:02 INFO - /builds/slave/test/build/application/firefox/firefox 16:22:02 INFO - Running post-action listener: _resource_record_post_action 16:22:02 INFO - [mozharness: 2017-09-28 23:22:02.475039Z] Finished install step (success) 16:22:02 INFO - [mozharness: 2017-09-28 23:22:02.475383Z] Running setup-mitmproxy step. 16:22:02 INFO - Running pre-action listener: _resource_record_pre_action 16:22:02 INFO - Running main action method: setup_mitmproxy 16:22:02 INFO - Skipping: mitmproxy is not required 16:22:02 INFO - Running post-action listener: _resource_record_post_action 16:22:02 INFO - [mozharness: 2017-09-28 23:22:02.477099Z] Finished setup-mitmproxy step (success) 16:22:02 INFO - [mozharness: 2017-09-28 23:22:02.477428Z] Running run-tests step. 16:22:02 INFO - Running pre-action listener: _resource_record_pre_action 16:22:02 INFO - Running pre-action listener: _set_gcov_prefix 16:22:02 INFO - Running main action method: run_tests 16:22:02 WARNING - Try message not found. 16:22:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:22:02 INFO - Python 2.7.3 16:22:02 INFO - Return code: 0 16:22:02 INFO - grabbing minidump binary from tooltool 16:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:02 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 0x22ec440>, '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 0x22ed130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7320>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:22:02 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 16:22:02 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 16:22:02 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 16:22:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:22:02 INFO - Return code: 0 16:22:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:22:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:22:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:22:02 INFO - ENV: RUST_BACKTRACE is now full 16:22:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:22:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:22:02 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/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 16:22:02 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/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 16:22:02 INFO - Using env: {'DISPLAY': ':0', 16:22:02 INFO - 'HOME': '/home/cltbld', 16:22:02 INFO - 'LANG': 'en_US.UTF-8', 16:22:02 INFO - 'LANGUAGE': 'en_US:en', 16:22:02 INFO - 'LOGNAME': 'cltbld', 16:22:02 INFO - 'MAIL': '/var/mail/cltbld', 16:22:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:22:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:02 INFO - 'MOZ_NO_REMOTE': '1', 16:22:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:02 INFO - 'NO_EM_RESTART': '1', 16:22:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:02 INFO - 'PWD': '/builds/slave/test', 16:22:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:22:02 INFO - 'RUST_BACKTRACE': 'full', 16:22:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:22:02 INFO - 'SHELL': '/bin/bash', 16:22:02 INFO - 'SHLVL': '1', 16:22:02 INFO - 'TERM': 'linux', 16:22:02 INFO - 'TMOUT': '86400', 16:22:02 INFO - 'USER': 'cltbld', 16:22:02 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', 16:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:02 INFO - '_': '/tools/buildbot/bin/python'} 16:22:02 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/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 16:22:02 INFO - mozversion application_buildid: 20170928215608 16:22:02 INFO - mozversion application_changeset: 307a7a34013060a6a1e87dfbb911f058d0781a2e 16:22:02 INFO - mozversion application_display_name: Nightly 16:22:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:22:02 INFO - mozversion application_name: Firefox 16:22:02 INFO - mozversion application_remotingname: firefox 16:22:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:22:02 INFO - mozversion application_vendor: Mozilla 16:22:02 INFO - mozversion application_version: 58.0a1 16:22:02 INFO - mozversion platform_buildid: 20170928215608 16:22:02 INFO - mozversion platform_changeset: 307a7a34013060a6a1e87dfbb911f058d0781a2e 16:22:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:22:02 INFO - mozversion platform_version: 58.0a1 16:22:02 INFO - using testdate: 1506640922 16:22:02 INFO - actual date: 1506640922 16:22:02 INFO - starting webserver on 'localhost:45754' 16:22:02 INFO - SUITE-START | Running 2 tests 16:22:02 INFO - TEST-START | dromaeo_css 16:22:02 INFO - Initialising browser for dromaeo_css test... 16:22:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45754/getInfo.html -profile /tmp/tmplzvIjx/profile 16:22:02 INFO - TEST-INFO | started process 5779 (/builds/slave/test/build/application/firefox/firefox http://localhost:45754/getInfo.html) 16:22:08 INFO - TEST-INFO | 5779: exit 0 16:22:08 INFO - Browser initialized. 16:22:08 INFO - Running cycle 1/1 for dromaeo_css test... 16:22:08 INFO - Using env: {'DISPLAY': ':0', 16:22:08 INFO - 'HOME': '/home/cltbld', 16:22:08 INFO - 'JSGC_DISABLE_POISONING': '1', 16:22:08 INFO - 'LANG': 'en_US.UTF-8', 16:22:08 INFO - 'LANGUAGE': 'en_US:en', 16:22:08 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:22:08 INFO - 'LOGNAME': 'cltbld', 16:22:08 INFO - 'MAIL': '/var/mail/cltbld', 16:22:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:22:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:22:08 INFO - 'MOZ_CRASHREPORTER': '1', 16:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:08 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:22:08 INFO - 'MOZ_NO_REMOTE': '1', 16:22:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:08 INFO - 'NO_EM_RESTART': '1', 16:22:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:08 INFO - 'PWD': '/builds/slave/test', 16:22:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:22:08 INFO - 'RUST_BACKTRACE': 'full', 16:22:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:22:08 INFO - 'SHELL': '/bin/bash', 16:22:08 INFO - 'SHLVL': '1', 16:22:08 INFO - 'STYLO_FORCE_DISABLED': '1', 16:22:08 INFO - 'TERM': 'linux', 16:22:08 INFO - 'TMOUT': '86400', 16:22:08 INFO - 'USER': 'cltbld', 16:22:08 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', 16:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:08 INFO - '_': '/tools/buildbot/bin/python'} 16:22:08 INFO - TEST-INFO | started process 6018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplzvIjx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:22:09 INFO - PID 6018 | 16:22:09 INFO - PID 6018 | (/builds/slave/test/build/application/firefox/firefox:6069): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:22:09 INFO - PID 6018 | 16:22:19 INFO - PID 6018 | RSS: Main: 144834560 16:22:19 INFO - PID 6018 | 16:25:15 INFO - PID 6018 | Cycle 1(1): loaded http://localhost:45754/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45754/tests/dromaeo/cssquery-ext.html) 16:25:16 INFO - PID 6018 | RSS: Main: 143163392 16:25:16 INFO - PID 6018 | 16:28:18 INFO - PID 6018 | Cycle 1(1): loaded http://localhost:45754/tests/dromaeo/cssquery-ext.html (next: http://localhost:45754/tests/dromaeo/cssquery-jquery.html) 16:28:19 INFO - PID 6018 | RSS: Main: 142716928 16:28:19 INFO - PID 6018 | 16:31:20 INFO - PID 6018 | Cycle 1(1): loaded http://localhost:45754/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45754/tests/dromaeo/cssquery-mootools.html) 16:31:21 INFO - PID 6018 | RSS: Main: 143998976 16:31:21 INFO - PID 6018 | 16:34:22 INFO - PID 6018 | Cycle 1(1): loaded http://localhost:45754/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45754/tests/dromaeo/cssquery-prototype.html) 16:34:23 INFO - PID 6018 | RSS: Main: 145494016 16:34:23 INFO - PID 6018 | 16:37:26 INFO - PID 6018 | Cycle 1(1): loaded http://localhost:45754/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45754/tests/dromaeo/cssquery-yui.html) 16:37:27 INFO - PID 6018 | RSS: Main: 147320832 16:37:27 INFO - PID 6018 | 16:40:28 INFO - PID 6018 | Cycle 1(1): loaded http://localhost:45754/tests/dromaeo/cssquery-yui.html (next: http://localhost:45754/tests/dromaeo/cssquery-dojo.html) 16:40:28 INFO - PID 6018 | RSS: Main: 149245952 16:40:28 INFO - PID 6018 | 16:40:28 INFO - PID 6018 | __start_tp_report 16:40:28 INFO - PID 6018 | _x_x_mozilla_page_load 16:40:28 INFO - PID 6018 | _x_x_mozilla_page_load_details 16:40:28 INFO - PID 6018 | |i|pagename|runs| 16:40:28 INFO - PID 6018 | |0;dojo.html;3788.5832558418574;3807.752496087754;3813.2564149990744;3820.5988371221006;3831.6359945805157;6067.878642427148;6172.969135154329;6226.719797609107;6236.844078898024;6327.987521996487;6165.16770236018;6169.568130230886;6176.351483094267;6189.845253868644;6256.6871656417225;5599.216109744639;5643.040683083886;5689.089745640698;5694.914576281349;5699.629524080921;215.51724137931046;5666.433356664342;5702.344230413493;5753.482186603205;5758.654480731148;5208.479152084799;5516.7517461714315;5521.503064724174;5663.575231857586;5667.688277144755;5533.00405926933;5601.131824567158;5630.493255606974;5661.971690141564;5698.886022279573;5577.163425486209;5603.943960560383;5675.5743319250805;5692.0608099663505;5695.1741997410145;6205.5345849061505;6205.81382558524;6213.316535181127;6257.030160325156;6282.465990390822;6543.672816359163;6651.135352404156;6763.391294783493;6792.966035169792;6873.072135261726;6766.28953959837;6809.148856392951;6857.588544687334;6858.039874417585;6863.210730765926;6314.873702525923;6325.968370158166;6353.047042943549;6407.583507072025;6414.583052101599;7003.054587630605;7017.92982070183;7071.469639777038;7075.292470752986;7096.92903070973;6447.709853056624;6553.836154096186;6556.8360790980605;6568.014797780275;6672.466202703772;6646.933530664728;6667.33326667339;6733.46132309414;6824;6824.556403833735;6749.763758268437;6768.56004359715;6810.387065164159;6846.178458584902;6847.144106986627;6686.531942764057;6697.698603562754;6709.127813384229;6779.5254332197255;6781.966090169518;4829.420469543607;4881.926771098437;4921.040397122527;4982.825601104017;5001.249812528077;4470.485894122217;4518.864434066983;4548.476925153584;4557.772111394417;4607.539246075366;6191.071339299141;6194.4115309045565;6198.473129784019;6281.057841323746;6352.936470635234;6540.411362977355;6651.501137414713;6710.865782684319;6713.227978782503;6807.18313802337;6286.874262514724;6289.8742025159245;6374;6375.808725738235;6387.840303992344;5364.865878353073;5476.835694929158;5557.499825015768;5563.360213575491;5569.972150139304;6847.897281540781;6888.724451021903;6902.827429314308;6911.688973996082;6916.757913473004;6605.834854128685;6721.8655626887185;6801.591904485746;6829.248782634006;6838.384545390939;7067.717291308496;7069.116360454943;7129.108861392326;7155.177154627077;7165.641717914188;6704.899426508508;6715.4627629790475;6718.798436046926;6809.829754255985;6822.8635427292165;6601.9009714853355;6675.7997260082275;6748.561343512656;6831.146106736658;6836;6494.805155845333;6616.768413105518;6641.601503909781;6643.833904152435;6658.134442522635;6530.575512591667;6533.118029066015;6618.2719900811835;6619.0071489277;6634.834129146617;6203.2556093269095;6428.971364581645;6436.581622194542;6503.642299673564;6533.901991470037;6416.358364163733;6576.506761992774;6614;6632.071509988509;6634.369734875179;6403.519736019724;6426.646534440651;6473.061406095995;6474.417302442803;6483.481321494363 16:40:28 INFO - PID 6018 | |1;ext.html;948.9810203795925;972.9854052189216;999.7800483893545;1004.352192835621;1006.1498034161141;41622.16755664885;42532.78733606335;42569;42604.78697606515;42689.14621707568;39545.60454395455;43068;43502.12995740083;43537.78231108848;43594.78202608982;8227.218414250652;8363.16368363162;8365.832683346329;8366.121557236494;8366.37252206087;8170.714025009126;8307.210814972597;8309.584520773968;8342.29090527306;8344.290735287508;8374.162583741607;8397.328213742885;8399.664013439455;8401.705940292091;8404.789880253013;8311.875321870146;8322.625481853302;8342.37432192588;8358.791030224233;8363.707270245573;8165.2243036911395;8171.264586187212;8236.670533178725;8238.423310368276;8253.133420990769;39156.21687566261;39448.802755986326;39675.20649587021;39780.40329395032;39794.80102599497;3674.963250367489;3768;3771.076086358832;3778.7732736035928;3786.280606684749;32464.18839529007;32533.18667033343;32814.17964550881;32950.50574241388;33053;5211.5049070338255;5360.061989151922;5402.837914862521;5403.378611459693;5491.2312276281355;228924;229506;229792;233437;235556;51143.7442812791;51405.22892156621;51584.48415515797;51734.74132629313;51775.22337164945;53594;53638;53729.73135134378;53815.73092134592;53904;16579.088150151856;16612.58468538296;16747.078910659788;16760.664786704197;16854.904431211933;13793.86206137946;13872.722545549033;13874.306284685927;13877.791833122512;13888.861111388756;12807.423665935055;12896.613101606967;12915.870841291468;12979.286139262242;13117;5128.435872054071;5157.535821775983;5319.627626066215;5319.840404787863;5323.893522129536;1094.6770702642739;1099.8515200447837;1101.432762127505;1101.8843021482628;1112.2436743014828;24984;25527.36181595475;25548;25561.87219063893;25595.232143035737;1185.5317149725981;1188.1207906149386;1191.2018947305153;1201.1831954271179;1209.0629761934572;13040.80438793419;13421.798673019912;13460.730785384434;13507;13591.388387522586;312465;314437;314586;315479;315569;57489;57522.13716794168;57678.7116064417;57679.711601441726;57692.134617980766;1473.1750219876903;1504.8720858727131;1509.9698006039819;1527.5570084675542;1547.81426228851;24757.589216649914;24782.752172478045;24927.376815579755;24947.376315592257;24980.644645684282;41268.587314126475;41689.58310416857;41700.58299416967;41739.58260417357;41739.582604174786;245663;245923;246279;246323;247157;33580.83209583937;34021.149471263416;35239.82380088083;35751.82124089363;35802;46985;47363.28955065746;47422;47895.281570777166;48018.75990620025;34805.825970869984;35094.47358289679;35191.29617407586;35305.82347088248;35491.29017419689;34360.31279374449;34690.30619387649;34739.30521389507;34889.12777180591;35061.64938350686;39399.40900886431;40316.3952540718;40420.393694094026;40431.59568404278;40507.59492405038;33267.66732332646;33557.83221083879;33655.326893461504;33733.49399759054;34083.65916340805;25608.615870762325;25806;26118.86940565285;26239.868800656637;26365.604515931893 16:40:28 INFO - PID 6018 | |2;jquery.html;579.2469789273943;615.5168192968517;633.9809805705828;640.7565125252403;643.7392855893363;18608.34870779523;18947.33684321051;19046.047697615115;24886;24973.250802475955;25906.222813315584;26357.86821065892;27238.45523089537;27527.587086193722;27721.445571088567;6368.8726225475575;6537.248216455121;6563.343665633446;6563.54055216135;6568.507361947873;6422.614643121405;6524.543281970264;6541.7710380136705;6546.3126371731;6803.693833777467;6791.660416979132;6793.592384456949;6795.728170873183;6796.25241223465;6797.354251346114;6483.448906842924;6776.695048722795;6791.864162716743;6797.28628494006;6808.523403361766;6343.555951083426;6353.8411539711415;6361.459275961549;6372.076048972919;6377.872442551123;32092.518612220836;32654.510182347283;32767.50848737271;32821.343573128644;32833;2318.501522172741;2335.708036495438;2344.7303560090636;2346.0381243690003;2346.0381243690176;21439.249626263005;21447.463813404633;22430.663540046913;22457.213997510007;22509.324720258417;2544.770970612654;2559.846409215453;2606.527312068675;2628.2378110347977;2641.4585010073083;144579;150832;165540;170359.14820425943;170417;16601.750973735405;17112.663030708893;17352.47942561725;17560.648787024187;17605.29578816833;27157.456850862873;27197.728022719915;27198.45603087927;27225.45549089007;27233.31916702098;10959.56161753521;11141.610043648434;11210.66368008961;11231.494582743797;11271.549138034386;10020;10034.197264218845;10034.24743144267;10065.34575252621;10154.187664986783;9823.852642210373;10027.247956403298;10213.74465638365;10301.846078884653;10343;2886.585573069181;2936.7797415193945;2953.3797902440297;3038.3315670552442;3134.4044631519937;1049.459528342904;1085.4464223246043;1087.9184061195442;1090.6946055104584;1091.8689757229183;21892;22150.88924555399;22251.221207257993;22315.44211394728;22401.887990559942;1124.820028795389;1136.852209212797;1140.8573928258968;1142.1548054439654;1151.4588143572507;11799.233049851731;12092.87907120935;12204.145709800228;12210.389480525939;12281.877181228252;588498;605727;617447;622788;637169;121551;132123.33938330246;134603;138135.30932345273;139737;1130.112861403794;1155.624422062833;1214.441356975801;1278.6164150754737;1287.4721364240804;22725.636461812344;23249.418764531023;23402.53194936126;23462.530749384576;23521.764782352642;60761;62321;62486.37513624987;63001;63927.360726392144;73970;78087;78414.60792696;78870;79651.20348796438;16011.919940400223;16102;16106.919465402598;16206.108664023592;16273.511794645707;24696.876515617307;24785.752142478344;24880.25359239226;25005.87497062503;25081.87459062766;20405.183792648128;20428.285010024578;20533;20642;20646.58706825825;17971.191296391433;17988.370407036215;18038.90980545089;18421.078946052377;18697.439076827715;20671.17315307371;20897.1641134359;20958.371248862557;21194.89402553039;21354.466138346666;15947.362105516113;15993.920030399773;16082.839171608603;16094.919525402298;16212.35150593963;20579.4855128623;20608.690869636666;20726.170953161705;20809.79190208139;20828.1668733249 16:40:28 INFO - PID 6018 | |3;mootools.html;1448.9637759056022;1495.3271028037386;1506.088816266159;1511.9848801511982;1524.4969160177143;16690.165491725427;17350.219240134193;17357.566060848487;17358.652826943453;17366;16726;16922.661546769057;16935.49193524193;16967.74548381775;16995.66008679829;2726.999999999995;2772.487089888367;2777.916662500118;2787.6515435570554;2787.846668433235;2522.369407648088;2639.5644718621406;2643.7884969202514;2644.880980355889;2647.324932142301;2500.437401584647;2567.293994151614;2647.5499165141973;2671.1051797647715;2672.318558767521;2555.3611597100726;2562.6027965665353;2568.191019828748;2592.572225582786;2598.233521111277;2540.1490500682294;2621.187431896118;2623.7638612524775;2627.4351014531967;2639.261006918066;16584.17079146038;16826.07456589887;16840.74738878918;16847;16863.409780657617;7901.683932642687;8112.675492980274;8160;8162.632681529345;8181.140980197112;5481.178292150391;5536.252605898233;5584.46947539983;5670;5783.161441590988;2203.0967303405528;2207.23850271656;2222.9333120006427;2228.398332450229;2267.7505474397803;30645.540316895265;30765.230869228224;30797.538036929465;30818.22954426135;30899.69100309013;6910.7581234656545;6984;6986.847170216857;7224.349808517153;7324.597147156957;20601.278955236496;20666.483337916372;20769.89615051915;20805.063772129986;20811.271605493734;8216.383771217183;8223.383246256555;8228.547429891294;8228.588570571448;8240.670373185125;7389.076365454318;7519.774406767806;7529.849403011909;7545.773626791095;7550;5690.6301090429815;5926.822195334147;5980.970095149496;5984.820455386345;6023.909641355295;1675.0954484578192;1706.590418299624;1745.5199820049588;1751.684696754571;1759.2699029902703;1016.5577973581368;1017.4200705597887;1031.4945676618404;1038.4184856480395;1050.0497050169456;8925.598348074222;8946.329025323126;8964.282857371394;8964.68623598184;9041.457512549268;777.2266594738271;797.9760607181794;802.6789284286332;810.3638643664694;814.1166833985075;5405.702686352289;5605.8598535036135;6058.545609079337;6104.053871649901;6181.690915454209;24295.27114186577;25260.74739252584;25383.36541586438;25417.237482875542;25882.09412670585;24696.13563525304;24800.5039899201;25346.873265633552;25453.872730636227;25483.490330193294;12572.1199516033;12639.810402843965;12690.238585684889;12793.808092878615;12845.486180552673;9979.50102494887;10134.594616215269;10168.237382196512;10235.334703244265;10254.53854576531;20765.58468830645;20843.58312833765;21091.683624745336;21357.67963480518;21887.67168492506;22073.88963055239;22116.55766884621;22225.222117225818;22445;22761;12447.937760311503;12704.110712250054;12725.172863763826;12777;12841;15581.532554023397;15757.133357665438;15813.288402022166;15933.283002265158;15966.760498592297;12475;12592;12805.551805686757;12867.806982895077;12892.355382231039;12075.51697932108;12123.757524849278;12162.75674486523;12220.877791221974;12559.246445213317;10857.565697372333;10877;10895.564177432814;10902.618408355669;11028.834567481334;8219;8280.213379728915;8456.746297611082;8468.153184681483;8487.618057187565;8640.179182977607;8647.56762161902;8647.956760216159;8651.95674021626;8724.389292749447 16:40:28 INFO - PID 6018 | |4;prototype.html;555.8026900450343;562.9859253518663;565.3667891961004;588.982330530084;594.0524862843765;6070.392960703933;6205.379462053798;6258.874822503547;6317.652529110897;6343.143675603792;6234.719437625306;6258.561900666955;6261.718222679979;6269.338625264297;6274.3098259191565;5112.156494178456;5114.897702045966;5127.846164615067;5160.870978225536;5172.379314482268;4902.8038878444995;5020.447750747415;5064.328771505413;5085.66943148696;5100.591952643798;5049.368828896388;5055.140626093555;5057.898842023157;5062.873428164307;5079.949200508003;4988.750562471898;5040.815408379028;5041.193409054552;5058.519440653132;5073;4558.840440584597;4616.146012987608;4622.953770462286;4638.283834981079;4654.581087702123;6194.3584949987835;6263.655498947556;6296.9370306296805;6301.40136687014;6323.6521991290465;5872;5899.203607513016;5992.981193197167;6006.21919150512;6020.127081573191;6535.21577410709;6590.275069742324;6635.170603674541;6640.667966601699;6679.766208182739;4970.030843985424;5105.132127538327;5133.998870220308;5172.922406163911;5173.922391164136;6757.932420675828;6883.380495755356;6919.238883722786;6928.376446119823;7027.578345299298;5613.270274864241;5628.802991895264;5680.801171959044;5689.573282003784;5697.572682048863;5734.16854556087;5744.741486633112;5787.2187254720075;5787.768489260382;5822.505087067647;6175.96912015437;6182.6599537025895;6188.938110618927;6194.163787888668;6223.844403889849;6742.224644165885;6752.459803215829;6758.831029224309;6766.661666916634;6770.627615481196;1974.960500789976;1995.1520603743352;2018.4550171453625;2033.5526184239443;2037.826784723315;1435.3253970633784;1502.2038319690582;1528.5643591576347;1529.3041666041925;1551.371694463744;6148.1699970504305;6184.350643182401;6257.152995387088;6313.842153946096;6315.621062736251;6544.574602650812;6652.933470665232;6708.932910670928;6721.1598550181225;6800.9118541033195;6168.599041062316;6171.012637977902;6195.690215489208;6277.919352420963;6278.277998030194;3496.667816557423;3518.9120271993406;3551.378508761008;3581.5702115745758;3585.2829434113282;6962.860742785218;6972.267911869282;6979.8711393025615;7011.789646310517;7043.260457651975;7043.894341584881;7045.11936007999;7058.364747172779;7058.647067646597;7067.22260551339;7042.6126563039525;7046.753363632249;7106.253843346478;7112.893306600405;7132.679029443688;6637.336266373324;6746.595204287759;6761.3238676132;6762.154730658668;6840.794776156723;6631.972044333136;6682.398584127452;6695.196576410862;6695.799126026227;6697.732090716317;6982.301769823181;7004.929950700632;7023.578585284899;7064.304566904008;7084.36240738336;5671.8865622688145;5675.432456754292;5680.829575112753;5702.116171993348;5717.857053573527;6578.80263592093;6654.234763002317;6756.290589488033;6798.218204906301;6817.181938167451;6624.768133115318;6651.301613330724;6653.170378145855;6655.201375834931;6679.766208182885;6527.67361631926;6649.368310010541;6650.933490665031;6656.900146497903;6661.933380666325;6500.934990650033;6516.674166291761;6534.313897040743;6542.607443553402;6582.407583317525;6668.466522678077;6682.164729408824;6687.164104486939;6760.492963027694;6772.273070367025;6406.967965160145;6410.487161027013;6416.13382193398;6472.223333200046;6476.449501792212 16:40:28 INFO - PID 6018 | |5;yui.html;980.97547561311;993.1260490768123;1004.3220825942487;1026.7638443158075;1030.38691978273;21220.787792122075;21649.159821415178;21714.99999999998;21719.131234750592;21736.8913155434;18847.340343087995;19113.90443047786;19114;19136.617267654638;19191.61616767667;1015.1675625986694;1043.191526566913;1044.0134073300733;1044.039483675017;1044.7022598559413;1045.2944262622736;1050.6322787024558;1052.079430498314;1053;1053.6206965492418;1015.6343716262139;1088.5591335509132;1099.488737736952;1104.0560320925613;1105.022055480897;1099.0438318662734;1102.7132945434164;1104.3870651788254;1105.5854054729477;1106.9871067972836;774.5585016540574;799.2487062161549;801.4910531812283;803.4777394693438;805.4603415711429;21774;21969.780302197094;22037;22089.33731988027;22114;23201.419964500852;23677;24278;24482.14312499054;24540.754592454203;18805.341813036615;18863.62272754551;18945.242190312372;19092.71360929587;19095.331663391713;3924.058226025762;3947.723659343847;3949.960500395017;3953.525576930758;3955.0507878109333;153242;171145;171517;172187;176752;18440.723389149174;18899.90550047241;19016.52458688544;19034.048297585065;19039.61920761577;34156.48765268523;35343;35636;35649.82175089108;35923.82038089793;9907.603695852229;10010.599576017023;10040.096391324816;10086.747831304276;10121.949390253001;4639.396878405786;4672.08894265615;4705.153072446992;4708.317293992421;4708.6468514860835;6185.072239164161;6214.782482613087;6289.654069026156;6298;6304.369563043659;1256.9685757855943;1268.0616343905629;1276.846778386581;1287.9484820607258;1290.825738525306;735.2794261623638;740.5815714121504;745.7986343687174;760.3688938181407;768.3046842607449;13515.256660883746;14010.649733756738;14694.779578306334;15029.346771855087;15255.923720381326;701.5790525684548;703.6341102626606;704.2077662629541;715.1346870287011;716.4018044932435;6594.175728033996;6693.966530167416;6735.057092007123;6754.459643228628;6785.11793466856;149282.25358873137;150336.24831875772;152704;155283;157063.21468392585;137777;138591.30704346616;139272;140224;143065.28467357595;121854;124461;126368;126718.36640816736;127304.99999999815;12593.307368094476;12681.23912565249;12686.238825670489;12700.87299126997;12756.68108297263;55890.72054639863;57225.42774572201;57653.423465764805;57927.131093034484;58422.12366814416;74119.62940185264;74453.62773186316;74639;75267.62366188134;75434.62282688772;16835.7474637883;17142.40001599938;17257.223424946158;17280.481585552454;17373;18968;19320.32378866789;19467.22131114796;19693.606127877076;19743.605127897074;17600.207990640196;17625.82374176242;17715.822841771933;17731.822681773534;17863.46409607714;16150.67698645997;16272.023678579322;16414.425495107615;16420.507384778477;16546.751798722787;16340.019598824108;16596.751048734037;16625.168741562633;16655.75016374731;16801.41195058167;12891.16207446513;13273.867261327263;13424.865751342362;13471.595852124452;13542.526011589547;13312.800307995582;13397.598072057854;13456.730865382833;13471.528496502575;13492.93253533726 16:40:28 INFO - PID 6018 | __end_tp_report 16:40:28 INFO - PID 6018 | __start_cc_report 16:40:28 INFO - PID 6018 | _x_x_mozilla_cycle_collect,267 16:40:28 INFO - PID 6018 | __end_cc_report 16:40:28 INFO - PID 6018 | __startTimestamp1506642028861__endTimestamp 16:40:28 INFO - PID 6018 | 16:40:28 INFO - PID 6018 | ------- Summary: start ------- 16:40:28 INFO - PID 6018 | Number of tests: 6 16:40:28 INFO - PID 6018 | 16:40:28 INFO - PID 6018 | [#0] dojo.html Cycles:165 Average:6196.20 Median:6473.06 stddev:873.21 (13.5%) stddev-sans-first:855.21 16:40:28 INFO - PID 6018 | Values: 3788.6 3807.8 3813.3 3820.6 3831.6 6067.9 6173.0 6226.7 6236.8 6328.0 6165.2 6169.6 6176.4 6189.8 6256.7 5599.2 5643.0 5689.1 5694.9 5699.6 215.5 5666.4 5702.3 5753.5 5758.7 5208.5 5516.8 5521.5 5663.6 5667.7 5533.0 5601.1 5630.5 5662.0 5698.9 5577.2 5603.9 5675.6 5692.1 5695.2 6205.5 6205.8 6213.3 6257.0 6282.5 6543.7 6651.1 6763.4 6793.0 6873.1 6766.3 6809.1 6857.6 6858.0 6863.2 6314.9 6326.0 6353.0 6407.6 6414.6 7003.1 7017.9 7071.5 7075.3 7096.9 6447.7 6553.8 6556.8 6568.0 6672.5 6646.9 6667.3 6733.5 6824.0 6824.6 6749.8 6768.6 6810.4 6846.2 6847.1 6686.5 6697.7 6709.1 6779.5 6782.0 4829.4 4881.9 4921.0 4982.8 5001.2 4470.5 4518.9 4548.5 4557.8 4607.5 6191.1 6194.4 6198.5 6281.1 6352.9 6540.4 6651.5 6710.9 6713.2 6807.2 6286.9 6289.9 6374.0 6375.8 6387.8 5364.9 5476.8 5557.5 5563.4 5570.0 6847.9 6888.7 6902.8 6911.7 6916.8 6605.8 6721.9 6801.6 6829.2 6838.4 7067.7 7069.1 7129.1 7155.2 7165.6 6704.9 6715.5 6718.8 6809.8 6822.9 6601.9 6675.8 6748.6 6831.1 6836.0 6494.8 6616.8 6641.6 6643.8 6658.1 6530.6 6533.1 6618.3 6619.0 6634.8 6203.3 6429.0 6436.6 6503.6 6533.9 6416.4 6576.5 6614.0 6632.1 6634.4 6403.5 6426.6 6473.1 6474.4 6483.5 16:40:28 INFO - PID 6018 | 16:40:28 INFO - PID 6018 | [#1] ext.html Cycles:180 Average:43732.08 Median:35776.91 stddev:69515.31 (194.3%) stddev-sans-first:69636.09 16:40:28 INFO - PID 6018 | Values: 949.0 973.0 999.8 1004.4 1006.1 41622.2 42532.8 42569.0 42604.8 42689.1 39545.6 43068.0 43502.1 43537.8 43594.8 8227.2 8363.2 8365.8 8366.1 8366.4 8170.7 8307.2 8309.6 8342.3 8344.3 8374.2 8397.3 8399.7 8401.7 8404.8 8311.9 8322.6 8342.4 8358.8 8363.7 8165.2 8171.3 8236.7 8238.4 8253.1 39156.2 39448.8 39675.2 39780.4 39794.8 3675.0 3768.0 3771.1 3778.8 3786.3 32464.2 32533.2 32814.2 32950.5 33053.0 5211.5 5360.1 5402.8 5403.4 5491.2 228924.0 229506.0 229792.0 233437.0 235556.0 51143.7 51405.2 51584.5 51734.7 51775.2 53594.0 53638.0 53729.7 53815.7 53904.0 16579.1 16612.6 16747.1 16760.7 16854.9 13793.9 13872.7 13874.3 13877.8 13888.9 12807.4 12896.6 12915.9 12979.3 13117.0 5128.4 5157.5 5319.6 5319.8 5323.9 1094.7 1099.9 1101.4 1101.9 1112.2 24984.0 25527.4 25548.0 25561.9 25595.2 1185.5 1188.1 1191.2 1201.2 1209.1 13040.8 13421.8 13460.7 13507.0 13591.4 312465.0 314437.0 314586.0 315479.0 315569.0 57489.0 57522.1 57678.7 57679.7 57692.1 1473.2 1504.9 1510.0 1527.6 1547.8 24757.6 24782.8 24927.4 24947.4 24980.6 41268.6 41689.6 41700.6 41739.6 41739.6 245663.0 245923.0 246279.0 246323.0 247157.0 33580.8 34021.1 35239.8 35751.8 35802.0 46985.0 47363.3 47422.0 47895.3 48018.8 34805.8 35094.5 35191.3 35305.8 35491.3 34360.3 34690.3 34739.3 34889.1 35061.6 39399.4 40316.4 40420.4 40431.6 40507.6 33267.7 33557.8 33655.3 33733.5 34083.7 25608.6 25806.0 26118.9 26239.9 26365.6 16:40:28 INFO - PID 6018 | 16:40:28 INFO - PID 6018 | [#2] jquery.html Cycles:180 Average:40752.04 Median:22483.27 stddev:102993.26 (458.1%) stddev-sans-first:103238.01 16:40:28 INFO - PID 6018 | Values: 579.2 615.5 634.0 640.8 643.7 18608.3 18947.3 19046.0 24886.0 24973.3 25906.2 26357.9 27238.5 27527.6 27721.4 6368.9 6537.2 6563.3 6563.5 6568.5 6422.6 6524.5 6541.8 6546.3 6803.7 6791.7 6793.6 6795.7 6796.3 6797.4 6483.4 6776.7 6791.9 6797.3 6808.5 6343.6 6353.8 6361.5 6372.1 6377.9 32092.5 32654.5 32767.5 32821.3 32833.0 2318.5 2335.7 2344.7 2346.0 2346.0 21439.2 21447.5 22430.7 22457.2 22509.3 2544.8 2559.8 2606.5 2628.2 2641.5 144579.0 150832.0 165540.0 170359.1 170417.0 16601.8 17112.7 17352.5 17560.6 17605.3 27157.5 27197.7 27198.5 27225.5 27233.3 10959.6 11141.6 11210.7 11231.5 11271.5 10020.0 10034.2 10034.2 10065.3 10154.2 9823.9 10027.2 10213.7 10301.8 10343.0 2886.6 2936.8 2953.4 3038.3 3134.4 1049.5 1085.4 1087.9 1090.7 1091.9 21892.0 22150.9 22251.2 22315.4 22401.9 1124.8 1136.9 1140.9 1142.2 1151.5 11799.2 12092.9 12204.1 12210.4 12281.9 588498.0 605727.0 617447.0 622788.0 637169.0 121551.0 132123.3 134603.0 138135.3 139737.0 1130.1 1155.6 1214.4 1278.6 1287.5 22725.6 23249.4 23402.5 23462.5 23521.8 60761.0 62321.0 62486.4 63001.0 63927.4 73970.0 78087.0 78414.6 78870.0 79651.2 16011.9 16102.0 16106.9 16206.1 16273.5 24696.9 24785.8 24880.3 25005.9 25081.9 20405.2 20428.3 20533.0 20642.0 20646.6 17971.2 17988.4 18038.9 18421.1 18697.4 20671.2 20897.2 20958.4 21194.9 21354.5 15947.4 15993.9 16082.8 16094.9 16212.4 20579.5 20608.7 20726.2 20809.8 20828.2 16:40:28 INFO - PID 6018 | 16:40:28 INFO - PID 6018 | [#3] mootools.html Cycles:180 Average:10511.39 Median:25365.12 stddev:7844.40 (30.9%) stddev-sans-first:7836.85 16:40:28 INFO - PID 6018 | Values: 1449.0 1495.3 1506.1 1512.0 1524.5 16690.2 17350.2 17357.6 17358.7 17366.0 16726.0 16922.7 16935.5 16967.7 16995.7 2727.0 2772.5 2777.9 2787.7 2787.8 2522.4 2639.6 2643.8 2644.9 2647.3 2500.4 2567.3 2647.5 2671.1 2672.3 2555.4 2562.6 2568.2 2592.6 2598.2 2540.1 2621.2 2623.8 2627.4 2639.3 16584.2 16826.1 16840.7 16847.0 16863.4 7901.7 8112.7 8160.0 8162.6 8181.1 5481.2 5536.3 5584.5 5670.0 5783.2 2203.1 2207.2 2222.9 2228.4 2267.8 30645.5 30765.2 30797.5 30818.2 30899.7 6910.8 6984.0 6986.8 7224.3 7324.6 20601.3 20666.5 20769.9 20805.1 20811.3 8216.4 8223.4 8228.5 8228.6 8240.7 7389.1 7519.8 7529.8 7545.8 7550.0 5690.6 5926.8 5981.0 5984.8 6023.9 1675.1 1706.6 1745.5 1751.7 1759.3 1016.6 1017.4 1031.5 1038.4 1050.0 8925.6 8946.3 8964.3 8964.7 9041.5 777.2 798.0 802.7 810.4 814.1 5405.7 5605.9 6058.5 6104.1 6181.7 24295.3 25260.7 25383.4 25417.2 25882.1 24696.1 24800.5 25346.9 25453.9 25483.5 12572.1 12639.8 12690.2 12793.8 12845.5 9979.5 10134.6 10168.2 10235.3 10254.5 20765.6 20843.6 21091.7 21357.7 21887.7 22073.9 22116.6 22225.2 22445.0 22761.0 12447.9 12704.1 12725.2 12777.0 12841.0 15581.5 15757.1 15813.3 15933.3 15966.8 12475.0 12592.0 12805.6 12867.8 12892.4 12075.5 12123.8 12162.8 12220.9 12559.2 10857.6 10877.0 10895.6 10902.6 11028.8 8219.0 8280.2 8456.7 8468.2 8487.6 8640.2 8647.6 8648.0 8652.0 8724.4 16:40:28 INFO - PID 6018 | 16:40:28 INFO - PID 6018 | [#4] prototype.html Cycles:180 Average:5733.65 Median:6276.11 stddev:1548.06 (24.7%) stddev-sans-first:1502.83 16:40:28 INFO - PID 6018 | Values: 555.8 563.0 565.4 589.0 594.1 6070.4 6205.4 6258.9 6317.7 6343.1 6234.7 6258.6 6261.7 6269.3 6274.3 5112.2 5114.9 5127.8 5160.9 5172.4 4902.8 5020.4 5064.3 5085.7 5100.6 5049.4 5055.1 5057.9 5062.9 5079.9 4988.8 5040.8 5041.2 5058.5 5073.0 4558.8 4616.1 4623.0 4638.3 4654.6 6194.4 6263.7 6296.9 6301.4 6323.7 5872.0 5899.2 5993.0 6006.2 6020.1 6535.2 6590.3 6635.2 6640.7 6679.8 4970.0 5105.1 5134.0 5172.9 5173.9 6757.9 6883.4 6919.2 6928.4 7027.6 5613.3 5628.8 5680.8 5689.6 5697.6 5734.2 5744.7 5787.2 5787.8 5822.5 6176.0 6182.7 6188.9 6194.2 6223.8 6742.2 6752.5 6758.8 6766.7 6770.6 1975.0 1995.2 2018.5 2033.6 2037.8 1435.3 1502.2 1528.6 1529.3 1551.4 6148.2 6184.4 6257.2 6313.8 6315.6 6544.6 6652.9 6708.9 6721.2 6800.9 6168.6 6171.0 6195.7 6277.9 6278.3 3496.7 3518.9 3551.4 3581.6 3585.3 6962.9 6972.3 6979.9 7011.8 7043.3 7043.9 7045.1 7058.4 7058.6 7067.2 7042.6 7046.8 7106.3 7112.9 7132.7 6637.3 6746.6 6761.3 6762.2 6840.8 6632.0 6682.4 6695.2 6695.8 6697.7 6982.3 7004.9 7023.6 7064.3 7084.4 5671.9 5675.4 5680.8 5702.1 5717.9 6578.8 6654.2 6756.3 6798.2 6817.2 6624.8 6651.3 6653.2 6655.2 6679.8 6527.7 6649.4 6650.9 6656.9 6661.9 6500.9 6516.7 6534.3 6542.6 6582.4 6668.5 6682.2 6687.2 6760.5 6772.3 6407.0 6410.5 6416.1 6472.2 6476.4 16:40:28 INFO - PID 6018 | 16:40:28 INFO - PID 6018 | [#5] yui.html Cycles:180 Average:29467.15 Median:17797.64 stddev:44612.66 (250.7%) stddev-sans-first:44686.54 16:40:28 INFO - PID 6018 | Values: 981.0 993.1 1004.3 1026.8 1030.4 21220.8 21649.2 21715.0 21719.1 21736.9 18847.3 19113.9 19114.0 19136.6 19191.6 1015.2 1043.2 1044.0 1044.0 1044.7 1045.3 1050.6 1052.1 1053.0 1053.6 1015.6 1088.6 1099.5 1104.1 1105.0 1099.0 1102.7 1104.4 1105.6 1107.0 774.6 799.2 801.5 803.5 805.5 21774.0 21969.8 22037.0 22089.3 22114.0 23201.4 23677.0 24278.0 24482.1 24540.8 18805.3 18863.6 18945.2 19092.7 19095.3 3924.1 3947.7 3950.0 3953.5 3955.1 153242.0 171145.0 171517.0 172187.0 176752.0 18440.7 18899.9 19016.5 19034.0 19039.6 34156.5 35343.0 35636.0 35649.8 35923.8 9907.6 10010.6 10040.1 10086.7 10121.9 4639.4 4672.1 4705.2 4708.3 4708.6 6185.1 6214.8 6289.7 6298.0 6304.4 1257.0 1268.1 1276.8 1287.9 1290.8 735.3 740.6 745.8 760.4 768.3 13515.3 14010.6 14694.8 15029.3 15255.9 701.6 703.6 704.2 715.1 716.4 6594.2 6694.0 6735.1 6754.5 6785.1 149282.3 150336.2 152704.0 155283.0 157063.2 137777.0 138591.3 139272.0 140224.0 143065.3 121854.0 124461.0 126368.0 126718.4 127305.0 12593.3 12681.2 12686.2 12700.9 12756.7 55890.7 57225.4 57653.4 57927.1 58422.1 74119.6 74453.6 74639.0 75267.6 75434.6 16835.7 17142.4 17257.2 17280.5 17373.0 18968.0 19320.3 19467.2 19693.6 19743.6 17600.2 17625.8 17715.8 17731.8 17863.5 16150.7 16272.0 16414.4 16420.5 16546.8 16340.0 16596.8 16625.2 16655.8 16801.4 12891.2 13273.9 13424.9 13471.6 13542.5 13312.8 13397.6 13456.7 13471.5 13492.9 16:40:28 INFO - PID 6018 | -------- Summary: end -------- 16:40:28 INFO - PID 6018 | 16:40:29 INFO - TEST-INFO | 6018: exit 0 16:40:29 INFO - TEST-OK | dromaeo_css | took 1106547ms 16:40:29 INFO - TEST-START | kraken 16:40:29 INFO - Initialising browser for kraken test... 16:40:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45754/getInfo.html -profile /tmp/tmphjmteM/profile 16:40:29 INFO - TEST-INFO | started process 6383 (/builds/slave/test/build/application/firefox/firefox http://localhost:45754/getInfo.html) 16:40:34 INFO - TEST-INFO | 6383: exit 0 16:40:34 INFO - Browser initialized. 16:40:34 INFO - Running cycle 1/1 for kraken test... 16:40:34 INFO - Using env: {'DISPLAY': ':0', 16:40:34 INFO - 'HOME': '/home/cltbld', 16:40:34 INFO - 'JSGC_DISABLE_POISONING': '1', 16:40:34 INFO - 'LANG': 'en_US.UTF-8', 16:40:34 INFO - 'LANGUAGE': 'en_US:en', 16:40:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:40:34 INFO - 'LOGNAME': 'cltbld', 16:40:34 INFO - 'MAIL': '/var/mail/cltbld', 16:40:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:40:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:40:34 INFO - 'MOZ_CRASHREPORTER': '1', 16:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:40:34 INFO - 'MOZ_NO_REMOTE': '1', 16:40:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:40:34 INFO - 'NO_EM_RESTART': '1', 16:40:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:34 INFO - 'PWD': '/builds/slave/test', 16:40:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:40:34 INFO - 'RUST_BACKTRACE': 'full', 16:40:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:40:34 INFO - 'SHELL': '/bin/bash', 16:40:34 INFO - 'SHLVL': '1', 16:40:34 INFO - 'STYLO_FORCE_DISABLED': '1', 16:40:34 INFO - 'TERM': 'linux', 16:40:34 INFO - 'TMOUT': '86400', 16:40:34 INFO - 'USER': 'cltbld', 16:40:34 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782', 16:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:34 INFO - '_': '/tools/buildbot/bin/python'} 16:40:34 INFO - TEST-INFO | started process 6617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphjmteM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:40:35 INFO - PID 6617 | 16:40:35 INFO - PID 6617 | (/builds/slave/test/build/application/firefox/firefox:6666): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:40:35 INFO - PID 6617 | 16:40:45 INFO - PID 6617 | RSS: Main: 144891904 16:40:45 INFO - PID 6617 | 16:40:48 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45754/tests/kraken/driver.html?testName=audio-beat-detection) 16:40:48 INFO - PID 6617 | RSS: Main: 150257664 16:40:48 INFO - PID 6617 | 16:40:51 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45754/tests/kraken/driver.html?testName=audio-dft) 16:40:52 INFO - PID 6617 | RSS: Main: 150835200 16:40:52 INFO - PID 6617 | 16:40:55 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45754/tests/kraken/driver.html?testName=audio-fft) 16:40:55 INFO - PID 6617 | RSS: Main: 147988480 16:40:55 INFO - PID 6617 | 16:40:57 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45754/tests/kraken/driver.html?testName=audio-oscillator) 16:40:58 INFO - PID 6617 | RSS: Main: 148701184 16:40:58 INFO - PID 6617 | 16:41:00 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45754/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:41:00 INFO - PID 6617 | RSS: Main: 148516864 16:41:00 INFO - PID 6617 | 16:41:04 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45754/tests/kraken/driver.html?testName=imaging-darkroom) 16:41:04 INFO - PID 6617 | RSS: Main: 148369408 16:41:04 INFO - PID 6617 | 16:41:08 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45754/tests/kraken/driver.html?testName=imaging-desaturate) 16:41:08 INFO - PID 6617 | RSS: Main: 149639168 16:41:08 INFO - PID 6617 | 16:41:11 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45754/tests/kraken/driver.html?testName=json-parse-financial) 16:41:12 INFO - PID 6617 | RSS: Main: 151158784 16:41:12 INFO - PID 6617 | 16:41:13 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45754/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:41:14 INFO - PID 6617 | RSS: Main: 151248896 16:41:14 INFO - PID 6617 | 16:41:15 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45754/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:41:16 INFO - PID 6617 | RSS: Main: 151154688 16:41:16 INFO - PID 6617 | 16:41:18 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45754/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:41:19 INFO - PID 6617 | RSS: Main: 148365312 16:41:19 INFO - PID 6617 | 16:41:21 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:41:22 INFO - PID 6617 | RSS: Main: 148283392 16:41:22 INFO - PID 6617 | 16:41:24 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:41:25 INFO - PID 6617 | RSS: Main: 148680704 16:41:25 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | Cycle 1(1): loaded http://localhost:45754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45754/tests/kraken/driver.html?testName=ai-astar) 16:41:27 INFO - PID 6617 | RSS: Main: 150507520 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | __start_tp_report 16:41:27 INFO - PID 6617 | _x_x_mozilla_page_load 16:41:27 INFO - PID 6617 | _x_x_mozilla_page_load_details 16:41:27 INFO - PID 6617 | |i|pagename|runs| 16:41:27 INFO - PID 6617 | |0;ai-astar;106;103;104;104;104;105;113;104;104;105 16:41:27 INFO - PID 6617 | |1;audio-beat-detection;112;114;112;115;113;114;153;111;114;123 16:41:27 INFO - PID 6617 | |2;audio-dft;163;165;163;161;164;163;163;162;163;170 16:41:27 INFO - PID 6617 | |3;audio-fft;73;73;73;76;86;73;77;73;74;73 16:41:27 INFO - PID 6617 | |4;audio-oscillator;78;79;78;78;78;78;83;77;78;85 16:41:27 INFO - PID 6617 | |5;imaging-gaussian-blur;111;115;113;114;116;114;113;114;114;114 16:41:27 INFO - PID 6617 | |6;imaging-darkroom;149;150;151;150;150;149;148;150;152;150 16:41:27 INFO - PID 6617 | |7;imaging-desaturate;94;96;93;94;93;94;94;93;94;95 16:41:27 INFO - PID 6617 | |8;json-parse-financial;46;48;43;45;44;43;47;45;44;44 16:41:27 INFO - PID 6617 | |9;json-stringify-tinderbox;38;40;38;38;38;38;38;38;38;38 16:41:27 INFO - PID 6617 | |10;stanford-crypto-aes;74;72;71;71;69;72;69;69;70;71 16:41:27 INFO - PID 6617 | |11;stanford-crypto-ccm;106;108;108;106;107;109;108;107;109;108 16:41:27 INFO - PID 6617 | |12;stanford-crypto-pbkdf2;146;146;150;150;146;143;145;154;146;147 16:41:27 INFO - PID 6617 | |13;stanford-crypto-sha256-iterative;59;56;59;57;58;57;61;59;60;62 16:41:27 INFO - PID 6617 | __end_tp_report 16:41:27 INFO - PID 6617 | __start_cc_report 16:41:27 INFO - PID 6617 | _x_x_mozilla_cycle_collect,691 16:41:27 INFO - PID 6617 | __end_cc_report 16:41:27 INFO - PID 6617 | __startTimestamp1506642087380__endTimestamp 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | ------- Summary: start ------- 16:41:27 INFO - PID 6617 | Number of tests: 14 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#0] ai-astar Cycles:10 Average:105.20 Median:104.50 stddev:2.86 (2.7%) stddev-sans-first:3.02 16:41:27 INFO - PID 6617 | Values: 106.0 103.0 104.0 104.0 104.0 105.0 113.0 104.0 104.0 105.0 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#1] audio-beat-detection Cycles:10 Average:118.10 Median:114.00 stddev:12.71 (11.1%) stddev-sans-first:13.28 16:41:27 INFO - PID 6617 | Values: 112.0 114.0 112.0 115.0 113.0 114.0 153.0 111.0 114.0 123.0 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:2.45 (1.5%) stddev-sans-first:2.59 16:41:27 INFO - PID 6617 | Values: 163.0 165.0 163.0 161.0 164.0 163.0 163.0 162.0 163.0 170.0 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#3] audio-fft Cycles:10 Average:75.10 Median:73.50 stddev:4.09 (5.6%) stddev-sans-first:4.27 16:41:27 INFO - PID 6617 | Values: 73.0 73.0 73.0 76.0 86.0 73.0 77.0 73.0 74.0 73.0 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#4] audio-oscillator Cycles:10 Average:79.20 Median:78.00 stddev:2.62 (3.4%) stddev-sans-first:2.74 16:41:27 INFO - PID 6617 | Values: 78.0 79.0 78.0 78.0 78.0 78.0 83.0 77.0 78.0 85.0 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.32 (1.2%) stddev-sans-first:0.93 16:41:27 INFO - PID 6617 | Values: 111.0 115.0 113.0 114.0 116.0 114.0 113.0 114.0 114.0 114.0 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 16:41:27 INFO - PID 6617 | Values: 149.0 150.0 151.0 150.0 150.0 149.0 148.0 150.0 152.0 150.0 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 16:41:27 INFO - PID 6617 | Values: 94.0 96.0 93.0 94.0 93.0 94.0 94.0 93.0 94.0 95.0 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#8] json-parse-financial Cycles:10 Average:44.90 Median:45.00 stddev:1.66 (3.7%) stddev-sans-first:1.72 16:41:27 INFO - PID 6617 | Values: 46.0 48.0 43.0 45.0 44.0 43.0 47.0 45.0 44.0 44.0 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.63 (1.7%) stddev-sans-first:0.67 16:41:27 INFO - PID 6617 | Values: 38.0 40.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#10] stanford-crypto-aes Cycles:10 Average:70.80 Median:71.00 stddev:1.62 (2.3%) stddev-sans-first:1.24 16:41:27 INFO - PID 6617 | Values: 74.0 72.0 71.0 71.0 69.0 72.0 69.0 69.0 70.0 71.0 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#11] stanford-crypto-ccm Cycles:10 Average:107.60 Median:108.00 stddev:1.07 (1.0%) stddev-sans-first:0.97 16:41:27 INFO - PID 6617 | Values: 106.0 108.0 108.0 106.0 107.0 109.0 108.0 107.0 109.0 108.0 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:146.50 stddev:3.16 (2.2%) stddev-sans-first:3.32 16:41:27 INFO - PID 6617 | Values: 146.0 146.0 150.0 150.0 146.0 143.0 145.0 154.0 146.0 147.0 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.80 Median:59.00 stddev:1.87 (3.2%) stddev-sans-first:1.99 16:41:27 INFO - PID 6617 | Values: 59.0 56.0 59.0 57.0 58.0 57.0 61.0 59.0 60.0 62.0 16:41:27 INFO - PID 6617 | -------- Summary: end -------- 16:41:27 INFO - PID 6617 | 16:41:27 INFO - PID 6617 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:41:27 INFO - TEST-INFO | 6617: exit 0 16:41:28 INFO - TEST-OK | kraken | took 58619ms 16:41:28 INFO - SUITE-END | took 1165s 16:41:28 INFO - Completed test suite (00:19:25) 16:41:28 INFO - javascript benchmark 16:41:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9145.742651203122, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3788.5832558418574, 3807.752496087754, 3813.2564149990744, 3820.5988371221006, 3831.6359945805157, 6067.878642427148, 6172.969135154329, 6226.719797609107, 6236.844078898024, 6327.987521996487, 6165.16770236018, 6169.568130230886, 6176.351483094267, 6189.845253868644, 6256.6871656417225, 5599.216109744639, 5643.040683083886, 5689.089745640698, 5694.914576281349, 5699.629524080921, 215.51724137931046, 5666.433356664342, 5702.344230413493, 5753.482186603205, 5758.654480731148, 5208.479152084799, 5516.7517461714315, 5521.503064724174, 5663.575231857586, 5667.688277144755, 5533.00405926933, 5601.131824567158, 5630.493255606974, 5661.971690141564, 5698.886022279573, 5577.163425486209, 5603.943960560383, 5675.5743319250805, 5692.0608099663505, 5695.1741997410145, 6205.5345849061505, 6205.81382558524, 6213.316535181127, 6257.030160325156, 6282.465990390822, 6543.672816359163, 6651.135352404156, 6763.391294783493, 6792.966035169792, 6873.072135261726, 6766.28953959837, 6809.148856392951, 6857.588544687334, 6858.039874417585, 6863.210730765926, 6314.873702525923, 6325.968370158166, 6353.047042943549, 6407.583507072025, 6414.583052101599, 7003.054587630605, 7017.92982070183, 7071.469639777038, 7075.292470752986, 7096.92903070973, 6447.709853056624, 6553.836154096186, 6556.8360790980605, 6568.014797780275, 6672.466202703772, 6646.933530664728, 6667.33326667339, 6733.46132309414, 6824.0, 6824.556403833735, 6749.763758268437, 6768.56004359715, 6810.387065164159, 6846.178458584902, 6847.144106986627, 6686.531942764057, 6697.698603562754, 6709.127813384229, 6779.5254332197255, 6781.966090169518, 4829.420469543607, 4881.926771098437, 4921.040397122527, 4982.825601104017, 5001.249812528077, 4470.485894122217, 4518.864434066983, 4548.476925153584, 4557.772111394417, 4607.539246075366, 6191.071339299141, 6194.4115309045565, 6198.473129784019, 6281.057841323746, 6352.936470635234, 6540.411362977355, 6651.501137414713, 6710.865782684319, 6713.227978782503, 6807.18313802337, 6286.874262514724, 6289.8742025159245, 6374.0, 6375.808725738235, 6387.840303992344, 5364.865878353073, 5476.835694929158, 5557.499825015768, 5563.360213575491, 5569.972150139304, 6847.897281540781, 6888.724451021903, 6902.827429314308, 6911.688973996082, 6916.757913473004, 6605.834854128685, 6721.8655626887185, 6801.591904485746, 6829.248782634006, 6838.384545390939, 7067.717291308496, 7069.116360454943, 7129.108861392326, 7155.177154627077, 7165.641717914188, 6704.899426508508, 6715.4627629790475, 6718.798436046926, 6809.829754255985, 6822.8635427292165, 6601.9009714853355, 6675.7997260082275, 6748.561343512656, 6831.146106736658, 6836.0, 6494.805155845333, 6616.768413105518, 6641.601503909781, 6643.833904152435, 6658.134442522635, 6530.575512591667, 6533.118029066015, 6618.2719900811835, 6619.0071489277, 6634.834129146617, 6203.2556093269095, 6428.971364581645, 6436.581622194542, 6503.642299673564, 6533.901991470037, 6416.358364163733, 6576.506761992774, 6614.0, 6632.071509988509, 6634.369734875179, 6403.519736019724, 6426.646534440651, 6473.061406095995, 6474.417302442803, 6483.481321494363], "value": 6139.605181256069, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [948.9810203795925, 972.9854052189216, 999.7800483893545, 1004.352192835621, 1006.1498034161141, 41622.16755664885, 42532.78733606335, 42569.0, 42604.78697606515, 42689.14621707568, 39545.60454395455, 43068.0, 43502.12995740083, 43537.78231108848, 43594.78202608982, 8227.218414250652, 8363.16368363162, 8365.832683346329, 8366.121557236494, 8366.37252206087, 8170.714025009126, 8307.210814972597, 8309.584520773968, 8342.29090527306, 8344.290735287508, 8374.162583741607, 8397.328213742885, 8399.664013439455, 8401.705940292091, 8404.789880253013, 8311.875321870146, 8322.625481853302, 8342.37432192588, 8358.791030224233, 8363.707270245573, 8165.2243036911395, 8171.264586187212, 8236.670533178725, 8238.423310368276, 8253.133420990769, 39156.21687566261, 39448.802755986326, 39675.20649587021, 39780.40329395032, 39794.80102599497, 3674.963250367489, 3768.0, 3771.076086358832, 3778.7732736035928, 3786.280606684749, 32464.18839529007, 32533.18667033343, 32814.17964550881, 32950.50574241388, 33053.0, 5211.5049070338255, 5360.061989151922, 5402.837914862521, 5403.378611459693, 5491.2312276281355, 228924.0, 229506.0, 229792.0, 233437.0, 235556.0, 51143.7442812791, 51405.22892156621, 51584.48415515797, 51734.74132629313, 51775.22337164945, 53594.0, 53638.0, 53729.73135134378, 53815.73092134592, 53904.0, 16579.088150151856, 16612.58468538296, 16747.078910659788, 16760.664786704197, 16854.904431211933, 13793.86206137946, 13872.722545549033, 13874.306284685927, 13877.791833122512, 13888.861111388756, 12807.423665935055, 12896.613101606967, 12915.870841291468, 12979.286139262242, 13117.0, 5128.435872054071, 5157.535821775983, 5319.627626066215, 5319.840404787863, 5323.893522129536, 1094.6770702642739, 1099.8515200447837, 1101.432762127505, 1101.8843021482628, 1112.2436743014828, 24984.0, 25527.36181595475, 25548.0, 25561.87219063893, 25595.232143035737, 1185.5317149725981, 1188.1207906149386, 1191.2018947305153, 1201.1831954271179, 1209.0629761934572, 13040.80438793419, 13421.798673019912, 13460.730785384434, 13507.0, 13591.388387522586, 312465.0, 314437.0, 314586.0, 315479.0, 315569.0, 57489.0, 57522.13716794168, 57678.7116064417, 57679.711601441726, 57692.134617980766, 1473.1750219876903, 1504.8720858727131, 1509.9698006039819, 1527.5570084675542, 1547.81426228851, 24757.589216649914, 24782.752172478045, 24927.376815579755, 24947.376315592257, 24980.644645684282, 41268.587314126475, 41689.58310416857, 41700.58299416967, 41739.58260417357, 41739.582604174786, 245663.0, 245923.0, 246279.0, 246323.0, 247157.0, 33580.83209583937, 34021.149471263416, 35239.82380088083, 35751.82124089363, 35802.0, 46985.0, 47363.28955065746, 47422.0, 47895.281570777166, 48018.75990620025, 34805.825970869984, 35094.47358289679, 35191.29617407586, 35305.82347088248, 35491.29017419689, 34360.31279374449, 34690.30619387649, 34739.30521389507, 34889.12777180591, 35061.64938350686, 39399.40900886431, 40316.3952540718, 40420.393694094026, 40431.59568404278, 40507.59492405038, 33267.66732332646, 33557.83221083879, 33655.326893461504, 33733.49399759054, 34083.65916340805, 25608.615870762325, 25806.0, 26118.86940565285, 26239.868800656637, 26365.604515931893], "value": 18507.601902388593, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.2469789273943, 615.5168192968517, 633.9809805705828, 640.7565125252403, 643.7392855893363, 18608.34870779523, 18947.33684321051, 19046.047697615115, 24886.0, 24973.250802475955, 25906.222813315584, 26357.86821065892, 27238.45523089537, 27527.587086193722, 27721.445571088567, 6368.8726225475575, 6537.248216455121, 6563.343665633446, 6563.54055216135, 6568.507361947873, 6422.614643121405, 6524.543281970264, 6541.7710380136705, 6546.3126371731, 6803.693833777467, 6791.660416979132, 6793.592384456949, 6795.728170873183, 6796.25241223465, 6797.354251346114, 6483.448906842924, 6776.695048722795, 6791.864162716743, 6797.28628494006, 6808.523403361766, 6343.555951083426, 6353.8411539711415, 6361.459275961549, 6372.076048972919, 6377.872442551123, 32092.518612220836, 32654.510182347283, 32767.50848737271, 32821.343573128644, 32833.0, 2318.501522172741, 2335.708036495438, 2344.7303560090636, 2346.0381243690003, 2346.0381243690176, 21439.249626263005, 21447.463813404633, 22430.663540046913, 22457.213997510007, 22509.324720258417, 2544.770970612654, 2559.846409215453, 2606.527312068675, 2628.2378110347977, 2641.4585010073083, 144579.0, 150832.0, 165540.0, 170359.14820425943, 170417.0, 16601.750973735405, 17112.663030708893, 17352.47942561725, 17560.648787024187, 17605.29578816833, 27157.456850862873, 27197.728022719915, 27198.45603087927, 27225.45549089007, 27233.31916702098, 10959.56161753521, 11141.610043648434, 11210.66368008961, 11231.494582743797, 11271.549138034386, 10020.0, 10034.197264218845, 10034.24743144267, 10065.34575252621, 10154.187664986783, 9823.852642210373, 10027.247956403298, 10213.74465638365, 10301.846078884653, 10343.0, 2886.585573069181, 2936.7797415193945, 2953.3797902440297, 3038.3315670552442, 3134.4044631519937, 1049.459528342904, 1085.4464223246043, 1087.9184061195442, 1090.6946055104584, 1091.8689757229183, 21892.0, 22150.88924555399, 22251.221207257993, 22315.44211394728, 22401.887990559942, 1124.820028795389, 1136.852209212797, 1140.8573928258968, 1142.1548054439654, 1151.4588143572507, 11799.233049851731, 12092.87907120935, 12204.145709800228, 12210.389480525939, 12281.877181228252, 588498.0, 605727.0, 617447.0, 622788.0, 637169.0, 121551.0, 132123.33938330246, 134603.0, 138135.30932345273, 139737.0, 1130.112861403794, 1155.624422062833, 1214.441356975801, 1278.6164150754737, 1287.4721364240804, 22725.636461812344, 23249.418764531023, 23402.53194936126, 23462.530749384576, 23521.764782352642, 60761.0, 62321.0, 62486.37513624987, 63001.0, 63927.360726392144, 73970.0, 78087.0, 78414.60792696, 78870.0, 79651.20348796438, 16011.919940400223, 16102.0, 16106.919465402598, 16206.108664023592, 16273.511794645707, 24696.876515617307, 24785.752142478344, 24880.25359239226, 25005.87497062503, 25081.87459062766, 20405.183792648128, 20428.285010024578, 20533.0, 20642.0, 20646.58706825825, 17971.191296391433, 17988.370407036215, 18038.90980545089, 18421.078946052377, 18697.439076827715, 20671.17315307371, 20897.1641134359, 20958.371248862557, 21194.89402553039, 21354.466138346666, 15947.362105516113, 15993.920030399773, 16082.839171608603, 16094.919525402298, 16212.35150593963, 20579.4855128623, 20608.690869636666, 20726.170953161705, 20809.79190208139, 20828.1668733249], "value": 13159.071337464515, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.9637759056022, 1495.3271028037386, 1506.088816266159, 1511.9848801511982, 1524.4969160177143, 16690.165491725427, 17350.219240134193, 17357.566060848487, 17358.652826943453, 17366.0, 16726.0, 16922.661546769057, 16935.49193524193, 16967.74548381775, 16995.66008679829, 2726.999999999995, 2772.487089888367, 2777.916662500118, 2787.6515435570554, 2787.846668433235, 2522.369407648088, 2639.5644718621406, 2643.7884969202514, 2644.880980355889, 2647.324932142301, 2500.437401584647, 2567.293994151614, 2647.5499165141973, 2671.1051797647715, 2672.318558767521, 2555.3611597100726, 2562.6027965665353, 2568.191019828748, 2592.572225582786, 2598.233521111277, 2540.1490500682294, 2621.187431896118, 2623.7638612524775, 2627.4351014531967, 2639.261006918066, 16584.17079146038, 16826.07456589887, 16840.74738878918, 16847.0, 16863.409780657617, 7901.683932642687, 8112.675492980274, 8160.0, 8162.632681529345, 8181.140980197112, 5481.178292150391, 5536.252605898233, 5584.46947539983, 5670.0, 5783.161441590988, 2203.0967303405528, 2207.23850271656, 2222.9333120006427, 2228.398332450229, 2267.7505474397803, 30645.540316895265, 30765.230869228224, 30797.538036929465, 30818.22954426135, 30899.69100309013, 6910.7581234656545, 6984.0, 6986.847170216857, 7224.349808517153, 7324.597147156957, 20601.278955236496, 20666.483337916372, 20769.89615051915, 20805.063772129986, 20811.271605493734, 8216.383771217183, 8223.383246256555, 8228.547429891294, 8228.588570571448, 8240.670373185125, 7389.076365454318, 7519.774406767806, 7529.849403011909, 7545.773626791095, 7550.0, 5690.6301090429815, 5926.822195334147, 5980.970095149496, 5984.820455386345, 6023.909641355295, 1675.0954484578192, 1706.590418299624, 1745.5199820049588, 1751.684696754571, 1759.2699029902703, 1016.5577973581368, 1017.4200705597887, 1031.4945676618404, 1038.4184856480395, 1050.0497050169456, 8925.598348074222, 8946.329025323126, 8964.282857371394, 8964.68623598184, 9041.457512549268, 777.2266594738271, 797.9760607181794, 802.6789284286332, 810.3638643664694, 814.1166833985075, 5405.702686352289, 5605.8598535036135, 6058.545609079337, 6104.053871649901, 6181.690915454209, 24295.27114186577, 25260.74739252584, 25383.36541586438, 25417.237482875542, 25882.09412670585, 24696.13563525304, 24800.5039899201, 25346.873265633552, 25453.872730636227, 25483.490330193294, 12572.1199516033, 12639.810402843965, 12690.238585684889, 12793.808092878615, 12845.486180552673, 9979.50102494887, 10134.594616215269, 10168.237382196512, 10235.334703244265, 10254.53854576531, 20765.58468830645, 20843.58312833765, 21091.683624745336, 21357.67963480518, 21887.67168492506, 22073.88963055239, 22116.55766884621, 22225.222117225818, 22445.0, 22761.0, 12447.937760311503, 12704.110712250054, 12725.172863763826, 12777.0, 12841.0, 15581.532554023397, 15757.133357665438, 15813.288402022166, 15933.283002265158, 15966.760498592297, 12475.0, 12592.0, 12805.551805686757, 12867.806982895077, 12892.355382231039, 12075.51697932108, 12123.757524849278, 12162.75674486523, 12220.877791221974, 12559.246445213317, 10857.565697372333, 10877.0, 10895.564177432814, 10902.618408355669, 11028.834567481334, 8219.0, 8280.213379728915, 8456.746297611082, 8468.153184681483, 8487.618057187565, 8640.179182977607, 8647.56762161902, 8647.956760216159, 8651.95674021626, 8724.389292749447], "value": 7287.479191462381, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.8026900450343, 562.9859253518663, 565.3667891961004, 588.982330530084, 594.0524862843765, 6070.392960703933, 6205.379462053798, 6258.874822503547, 6317.652529110897, 6343.143675603792, 6234.719437625306, 6258.561900666955, 6261.718222679979, 6269.338625264297, 6274.3098259191565, 5112.156494178456, 5114.897702045966, 5127.846164615067, 5160.870978225536, 5172.379314482268, 4902.8038878444995, 5020.447750747415, 5064.328771505413, 5085.66943148696, 5100.591952643798, 5049.368828896388, 5055.140626093555, 5057.898842023157, 5062.873428164307, 5079.949200508003, 4988.750562471898, 5040.815408379028, 5041.193409054552, 5058.519440653132, 5073.0, 4558.840440584597, 4616.146012987608, 4622.953770462286, 4638.283834981079, 4654.581087702123, 6194.3584949987835, 6263.655498947556, 6296.9370306296805, 6301.40136687014, 6323.6521991290465, 5872.0, 5899.203607513016, 5992.981193197167, 6006.21919150512, 6020.127081573191, 6535.21577410709, 6590.275069742324, 6635.170603674541, 6640.667966601699, 6679.766208182739, 4970.030843985424, 5105.132127538327, 5133.998870220308, 5172.922406163911, 5173.922391164136, 6757.932420675828, 6883.380495755356, 6919.238883722786, 6928.376446119823, 7027.578345299298, 5613.270274864241, 5628.802991895264, 5680.801171959044, 5689.573282003784, 5697.572682048863, 5734.16854556087, 5744.741486633112, 5787.2187254720075, 5787.768489260382, 5822.505087067647, 6175.96912015437, 6182.6599537025895, 6188.938110618927, 6194.163787888668, 6223.844403889849, 6742.224644165885, 6752.459803215829, 6758.831029224309, 6766.661666916634, 6770.627615481196, 1974.960500789976, 1995.1520603743352, 2018.4550171453625, 2033.5526184239443, 2037.826784723315, 1435.3253970633784, 1502.2038319690582, 1528.5643591576347, 1529.3041666041925, 1551.371694463744, 6148.1699970504305, 6184.350643182401, 6257.152995387088, 6313.842153946096, 6315.621062736251, 6544.574602650812, 6652.933470665232, 6708.932910670928, 6721.1598550181225, 6800.9118541033195, 6168.599041062316, 6171.012637977902, 6195.690215489208, 6277.919352420963, 6278.277998030194, 3496.667816557423, 3518.9120271993406, 3551.378508761008, 3581.5702115745758, 3585.2829434113282, 6962.860742785218, 6972.267911869282, 6979.8711393025615, 7011.789646310517, 7043.260457651975, 7043.894341584881, 7045.11936007999, 7058.364747172779, 7058.647067646597, 7067.22260551339, 7042.6126563039525, 7046.753363632249, 7106.253843346478, 7112.893306600405, 7132.679029443688, 6637.336266373324, 6746.595204287759, 6761.3238676132, 6762.154730658668, 6840.794776156723, 6631.972044333136, 6682.398584127452, 6695.196576410862, 6695.799126026227, 6697.732090716317, 6982.301769823181, 7004.929950700632, 7023.578585284899, 7064.304566904008, 7084.36240738336, 5671.8865622688145, 5675.432456754292, 5680.829575112753, 5702.116171993348, 5717.857053573527, 6578.80263592093, 6654.234763002317, 6756.290589488033, 6798.218204906301, 6817.181938167451, 6624.768133115318, 6651.301613330724, 6653.170378145855, 6655.201375834931, 6679.766208182885, 6527.67361631926, 6649.368310010541, 6650.933490665031, 6656.900146497903, 6661.933380666325, 6500.934990650033, 6516.674166291761, 6534.313897040743, 6542.607443553402, 6582.407583317525, 6668.466522678077, 6682.164729408824, 6687.164104486939, 6760.492963027694, 6772.273070367025, 6406.967965160145, 6410.487161027013, 6416.13382193398, 6472.223333200046, 6476.449501792212], "value": 5302.524584511871, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [980.97547561311, 993.1260490768123, 1004.3220825942487, 1026.7638443158075, 1030.38691978273, 21220.787792122075, 21649.159821415178, 21714.99999999998, 21719.131234750592, 21736.8913155434, 18847.340343087995, 19113.90443047786, 19114.0, 19136.617267654638, 19191.61616767667, 1015.1675625986694, 1043.191526566913, 1044.0134073300733, 1044.039483675017, 1044.7022598559413, 1045.2944262622736, 1050.6322787024558, 1052.079430498314, 1053.0, 1053.6206965492418, 1015.6343716262139, 1088.5591335509132, 1099.488737736952, 1104.0560320925613, 1105.022055480897, 1099.0438318662734, 1102.7132945434164, 1104.3870651788254, 1105.5854054729477, 1106.9871067972836, 774.5585016540574, 799.2487062161549, 801.4910531812283, 803.4777394693438, 805.4603415711429, 21774.0, 21969.780302197094, 22037.0, 22089.33731988027, 22114.0, 23201.419964500852, 23677.0, 24278.0, 24482.14312499054, 24540.754592454203, 18805.341813036615, 18863.62272754551, 18945.242190312372, 19092.71360929587, 19095.331663391713, 3924.058226025762, 3947.723659343847, 3949.960500395017, 3953.525576930758, 3955.0507878109333, 153242.0, 171145.0, 171517.0, 172187.0, 176752.0, 18440.723389149174, 18899.90550047241, 19016.52458688544, 19034.048297585065, 19039.61920761577, 34156.48765268523, 35343.0, 35636.0, 35649.82175089108, 35923.82038089793, 9907.603695852229, 10010.599576017023, 10040.096391324816, 10086.747831304276, 10121.949390253001, 4639.396878405786, 4672.08894265615, 4705.153072446992, 4708.317293992421, 4708.6468514860835, 6185.072239164161, 6214.782482613087, 6289.654069026156, 6298.0, 6304.369563043659, 1256.9685757855943, 1268.0616343905629, 1276.846778386581, 1287.9484820607258, 1290.825738525306, 735.2794261623638, 740.5815714121504, 745.7986343687174, 760.3688938181407, 768.3046842607449, 13515.256660883746, 14010.649733756738, 14694.779578306334, 15029.346771855087, 15255.923720381326, 701.5790525684548, 703.6341102626606, 704.2077662629541, 715.1346870287011, 716.4018044932435, 6594.175728033996, 6693.966530167416, 6735.057092007123, 6754.459643228628, 6785.11793466856, 149282.25358873137, 150336.24831875772, 152704.0, 155283.0, 157063.21468392585, 137777.0, 138591.30704346616, 139272.0, 140224.0, 143065.28467357595, 121854.0, 124461.0, 126368.0, 126718.36640816736, 127304.99999999815, 12593.307368094476, 12681.23912565249, 12686.238825670489, 12700.87299126997, 12756.68108297263, 55890.72054639863, 57225.42774572201, 57653.423465764805, 57927.131093034484, 58422.12366814416, 74119.62940185264, 74453.62773186316, 74639.0, 75267.62366188134, 75434.62282688772, 16835.7474637883, 17142.40001599938, 17257.223424946158, 17280.481585552454, 17373.0, 18968.0, 19320.32378866789, 19467.22131114796, 19693.606127877076, 19743.605127897074, 17600.207990640196, 17625.82374176242, 17715.822841771933, 17731.822681773534, 17863.46409607714, 16150.67698645997, 16272.023678579322, 16414.425495107615, 16420.507384778477, 16546.751798722787, 16340.019598824108, 16596.751048734037, 16625.168741562633, 16655.75016374731, 16801.41195058167, 12891.16207446513, 13273.867261327263, 13424.865751342362, 13471.595852124452, 13542.526011589547, 13312.800307995582, 13397.598072057854, 13456.730865382833, 13471.528496502575, 13492.93253533726], "value": 10127.71202529224, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1366.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 103.0, 104.0, 104.0, 104.0, 105.0, 113.0, 104.0, 104.0, 105.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 112.0, 115.0, 113.0, 114.0, 153.0, 111.0, 114.0, 123.0], "value": 118.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 161.0, 164.0, 163.0, 163.0, 162.0, 163.0, 170.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 76.0, 86.0, 73.0, 77.0, 73.0, 74.0, 73.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 78.0, 78.0, 78.0, 83.0, 77.0, 78.0, 85.0], "value": 79.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 113.0, 114.0, 116.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 151.0, 150.0, 150.0, 149.0, 148.0, 150.0, 152.0, 150.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 93.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 95.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 48.0, 43.0, 45.0, 44.0, 43.0, 47.0, 45.0, 44.0, 44.0], "value": 44.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 40.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 71.0, 71.0, 69.0, 72.0, 69.0, 69.0, 70.0, 71.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 108.0, 108.0, 106.0, 107.0, 109.0, 108.0, 107.0, 109.0, 108.0], "value": 107.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 150.0, 150.0, 146.0, 143.0, 145.0, 154.0, 146.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 59.0, 57.0, 58.0, 57.0, 61.0, 59.0, 60.0, 62.0], "value": 58.8, "unit": "score"}]}]} 16:41:28 INFO - Return code: 0 16:41:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:41:28 INFO - # TBPL SUCCESS # 16:41:28 INFO - Running post-action listener: _package_coverage_data 16:41:28 INFO - Running post-action listener: _resource_record_post_action 16:41:28 INFO - [mozharness: 2017-09-28 23:41:28.201899Z] Finished run-tests step (success) 16:41:28 INFO - Running post-run listener: _resource_record_post_run 16:41:28 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 325644288; Read time: 12; Write time: 196684 16:41:28 INFO - TinderboxPrint: CPU usage
13.1% 16:41:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:41:28 INFO - TinderboxPrint: I/O write bytes / time
325,644,288 / 196,684 16:41:28 INFO - TinderboxPrint: CPU idle
8,199.7 (86.9%) 16:41:28 INFO - TinderboxPrint: CPU user
1,185.3 (12.6%) 16:41:28 INFO - TinderboxPrint: Swap in / out
0 / 0 16:41:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 11833344; Read time: 0; Write time: 1096 16:41:28 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:41:28 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 4096; Write bytes: 312528896; Read time: 12; Write time: 195524 16:41:28 INFO - Running post-run listener: _upload_blobber_files 16:41:28 INFO - Blob upload gear active. 16:41:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:41:28 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 16:41:28 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'] 16:41:28 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 16:41:29 INFO - (blobuploader) - INFO - Open directory for files ... 16:41:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:41:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:41:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:36 INFO - (blobuploader) - INFO - Done attempting. 16:41:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:41:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:41:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:37 INFO - (blobuploader) - INFO - Done attempting. 16:41:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:41:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:41:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:38 INFO - (blobuploader) - INFO - Done attempting. 16:41:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:41:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:41:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:39 INFO - (blobuploader) - INFO - Done attempting. 16:41:39 INFO - (blobuploader) - INFO - Iteration through files over. 16:41:39 INFO - Return code: 0 16:41:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:41:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:41:39 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf36c47a4644416e9ae4bdf0321793cefc9dbf1d2ac517143175ee7d279ab5a1d429c4b01346ede3f4523069b8d3ee0afae47fe86047757e890f2f195c1500b0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16cdd0f2e2b876000be8b54173301420cca1cc4498e2dc23ea9e0c413d1c5b21eef932ac9cee685cb42aa8adf19edf1cebb23edf032dc1d02c0a07d5648970af", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8997e1b061d898dfbf13ac79bd5efef808c23a4e09c92e0511b4670ad80897756ab7b9256bade9ae551d9e0e1aae26de269679b8d7ae9a47b98e0e9f0e61a514", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ddfafb0c22a02ed656d1e1df640f4cbd30fd58c9d3eec12bffb3cf0a932b8cdd35566b318000dfb3e77a3f5308f27f46828bb67dfc37c479660bb9bafdcd38"} 16:41:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:41:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:41:39 INFO - Contents: 16:41:39 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf36c47a4644416e9ae4bdf0321793cefc9dbf1d2ac517143175ee7d279ab5a1d429c4b01346ede3f4523069b8d3ee0afae47fe86047757e890f2f195c1500b0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16cdd0f2e2b876000be8b54173301420cca1cc4498e2dc23ea9e0c413d1c5b21eef932ac9cee685cb42aa8adf19edf1cebb23edf032dc1d02c0a07d5648970af", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8997e1b061d898dfbf13ac79bd5efef808c23a4e09c92e0511b4670ad80897756ab7b9256bade9ae551d9e0e1aae26de269679b8d7ae9a47b98e0e9f0e61a514", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ddfafb0c22a02ed656d1e1df640f4cbd30fd58c9d3eec12bffb3cf0a932b8cdd35566b318000dfb3e77a3f5308f27f46828bb67dfc37c479660bb9bafdcd38"} 16:41:39 INFO - Running post-run listener: copy_logs_to_upload_dir 16:41:39 INFO - Copying logs to upload dir... 16:41:39 INFO - mkdir: /builds/slave/test/build/upload/logs 16:41:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.614854 ========= master_lag: -0.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-28 16:41:38.851816) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 16:41:38.858899) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782 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/cf36c47a4644416e9ae4bdf0321793cefc9dbf1d2ac517143175ee7d279ab5a1d429c4b01346ede3f4523069b8d3ee0afae47fe86047757e890f2f195c1500b0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16cdd0f2e2b876000be8b54173301420cca1cc4498e2dc23ea9e0c413d1c5b21eef932ac9cee685cb42aa8adf19edf1cebb23edf032dc1d02c0a07d5648970af", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8997e1b061d898dfbf13ac79bd5efef808c23a4e09c92e0511b4670ad80897756ab7b9256bade9ae551d9e0e1aae26de269679b8d7ae9a47b98e0e9f0e61a514", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ddfafb0c22a02ed656d1e1df640f4cbd30fd58c9d3eec12bffb3cf0a932b8cdd35566b318000dfb3e77a3f5308f27f46828bb67dfc37c479660bb9bafdcd38"} build_url:https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/cmYlyjEDRk2IOAJ-a13Uqg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf36c47a4644416e9ae4bdf0321793cefc9dbf1d2ac517143175ee7d279ab5a1d429c4b01346ede3f4523069b8d3ee0afae47fe86047757e890f2f195c1500b0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16cdd0f2e2b876000be8b54173301420cca1cc4498e2dc23ea9e0c413d1c5b21eef932ac9cee685cb42aa8adf19edf1cebb23edf032dc1d02c0a07d5648970af", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8997e1b061d898dfbf13ac79bd5efef808c23a4e09c92e0511b4670ad80897756ab7b9256bade9ae551d9e0e1aae26de269679b8d7ae9a47b98e0e9f0e61a514", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ddfafb0c22a02ed656d1e1df640f4cbd30fd58c9d3eec12bffb3cf0a932b8cdd35566b318000dfb3e77a3f5308f27f46828bb67dfc37c479660bb9bafdcd38"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 16:41:38.889931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 16:41:38.890226) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1506639803.12052-190495782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 16:41:38.970112) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 16:41:38.970398) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 16:41:38.973685) ========= ========= Total master_lag: -0.07 =========