builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1506450705.29 results: success (0) revision: b30ae5a455367f336ded1052081e4c54a139fa81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:45.292168) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:45.292679) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:45.292967) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:45.313100) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:45.313596) ========= 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=03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 11:31:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2017-09-26 11:31:45 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129084 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:45.459955) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:45.460311) ========= 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=03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015684 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:45.514908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:45.515291) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b30ae5a455367f336ded1052081e4c54a139fa81 --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 b30ae5a455367f336ded1052081e4c54a139fa81 --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=03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 11:31:45,570 truncating revision to first 12 chars 2017-09-26 11:31:45,570 Setting DEBUG logging. 2017-09-26 11:31:45,570 attempt 1/10 2017-09-26 11:31:45,570 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b30ae5a45536?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 11:31:46,026 unpacking tar archive at: mozilla-central-b30ae5a45536/testing/mozharness/ program finished with exit code 0 elapsedTime=0.738863 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:46.280985) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:46.285820) ========= script_repo_revision: b30ae5a455367f336ded1052081e4c54a139fa81 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:46.286599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:46.287014) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:46.309867) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-26 11:31:46.310579) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:31:46 INFO - MultiFileLogger online at 20170926 11:31:46 in /builds/slave/test 11:31:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:31:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:31:46 INFO - {'append_to_log': False, 11:31:46 INFO - 'base_work_dir': '/builds/slave/test', 11:31:46 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:31:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:31:46 INFO - 'branch': 'Firefox-Non-PGO', 11:31:46 INFO - 'buildbot_json_path': 'buildprops.json', 11:31:46 INFO - 'code_coverage': False, 11:31:46 INFO - 'config_files': ('talos/linux_config.py',), 11:31:46 INFO - 'default_actions': ('clobber', 11:31:46 INFO - 'read-buildbot-config', 11:31:46 INFO - 'download-and-extract', 11:31:46 INFO - 'populate-webroot', 11:31:46 INFO - 'create-virtualenv', 11:31:46 INFO - 'install', 11:31:46 INFO - 'setup-mitmproxy', 11:31:46 INFO - 'run-tests'), 11:31:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:31:46 INFO - 'disable_ccov_upload': False, 11:31:46 INFO - 'disable_stylo': False, 11:31:46 INFO - 'download_minidump_stackwalk': True, 11:31:46 INFO - 'download_symbols': 'ondemand', 11:31:46 INFO - 'enable_stylo': False, 11:31:46 INFO - 'enable_webrender': False, 11:31:46 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:31:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:31:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:31:46 INFO - 'gecko_profile': False, 11:31:46 INFO - 'gecko_profile_interval': 0, 11:31:46 INFO - 'installer_path': 'installer.exe', 11:31:46 INFO - 'log_level': 'info', 11:31:46 INFO - 'log_name': 'talos', 11:31:46 INFO - 'log_to_console': True, 11:31:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:31:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:31:46 INFO - 'opt_config_files': (), 11:31:46 INFO - 'pip_index': False, 11:31:46 INFO - 'suite': 'dromaeojs-e10s', 11:31:46 INFO - 'system_bits': '32', 11:31:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:31:46 INFO - 'title': 'talos-linux64-ix-047', 11:31:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:31:46 INFO - 'use_talos_json': True, 11:31:46 INFO - 'verify': 'False', 11:31:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:31:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:31:46 INFO - 'work_dir': 'build'} 11:31:46 INFO - [mozharness: 2017-09-26 18:31:46.500750Z] Running clobber step. 11:31:46 INFO - Running pre-action listener: _resource_record_pre_action 11:31:46 INFO - Running main action method: clobber 11:31:46 INFO - rmtree: /builds/slave/test/build 11:31:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:31:48 INFO - Running post-action listener: _resource_record_post_action 11:31:48 INFO - [mozharness: 2017-09-26 18:31:48.021648Z] Finished clobber step (success) 11:31:48 INFO - [mozharness: 2017-09-26 18:31:48.021745Z] Running read-buildbot-config step. 11:31:48 INFO - Running pre-action listener: _resource_record_pre_action 11:31:48 INFO - Running main action method: read_buildbot_config 11:31:48 INFO - Using buildbot properties: 11:31:48 INFO - { 11:31:48 INFO - "project": "", 11:31:48 INFO - "product": "firefox", 11:31:48 INFO - "who": "ffxbld@noreply.mozilla.org", 11:31:48 INFO - "installer_path": "public/build/target.tar.bz2", 11:31:48 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:31:48 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:31:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:31:48 INFO - "stage_platform": "linux64", 11:31:48 INFO - "basedir": "/builds/slave/test", 11:31:48 INFO - "buildnumber": 1178, 11:31:48 INFO - "platform": "ubuntu64_hw", 11:31:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:31:48 INFO - "slavebuilddir": "test", 11:31:48 INFO - "taskId": "AyUJrhBCTCaf-IHWd6kGGQ", 11:31:48 INFO - "branch": "mozilla-central", 11:31:48 INFO - "script_repo_revision": "production", 11:31:48 INFO - "revision": "b30ae5a455367f336ded1052081e4c54a139fa81", 11:31:48 INFO - "slavename": "talos-linux64-ix-047", 11:31:48 INFO - "repo_path": "mozilla-central" 11:31:48 INFO - } 11:31:48 INFO - Finding installer, test and symbols from parent task. 11:31:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AyUJrhBCTCaf-IHWd6kGGQ'}, attempt #1 11:31:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AyUJrhBCTCaf-IHWd6kGGQ'}, attempt #1 11:31:49 INFO - Task dependencies: OiaXjfiURii_c_az-GohGA 11:31:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA'}, attempt #1 11:31:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 11:31:49 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.test_packages.json 11:31:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.crashreporter-symbols.zip 11:31:49 INFO - Running post-action listener: _resource_record_post_action 11:31:49 INFO - [mozharness: 2017-09-26 18:31:49.495226Z] Finished read-buildbot-config step (success) 11:31:49 INFO - [mozharness: 2017-09-26 18:31:49.495443Z] Running download-and-extract step. 11:31:49 INFO - Running pre-action listener: _resource_record_pre_action 11:31:49 INFO - Running main action method: download_and_extract 11:31:49 INFO - mkdir: /builds/slave/test/build/tests 11:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:49 INFO - trying https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.test_packages.json 11:31:49 INFO - Downloading https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:31:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:31:50 INFO - Downloaded 989 bytes. 11:31:50 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:31:50 INFO - Using the following test package requirements: 11:31:50 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:31:50 INFO - u'common': [u'target.common.tests.zip'], 11:31:50 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:31:50 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:31:50 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:31:50 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:31:50 INFO - u'mozbase': [u'target.common.tests.zip'], 11:31:50 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:31:50 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:31:50 INFO - u'web-platform': [u'target.common.tests.zip', 11:31:50 INFO - u'target.web-platform.tests.tar.gz'], 11:31:50 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:31:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:31:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.common.tests.zip 11:31:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:31:50 INFO - Fetch https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.common.tests.zip into memory 11:31:51 INFO - Content-Length response header: 54943939 11:31:51 INFO - Bytes received: 54943939 11:32:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.talos.tests.zip 11:32:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:32:02 INFO - Fetch https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.talos.tests.zip into memory 11:32:02 INFO - Content-Length response header: 14513823 11:32:02 INFO - Bytes received: 14513823 11:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:03 INFO - trying https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 11:32:03 INFO - Downloading https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:32:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:32:04 INFO - Downloaded 61654855 bytes. 11:32:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 11:32:04 INFO - mkdir: /builds/slave/test/properties 11:32:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:32:04 INFO - Writing to file /builds/slave/test/properties/build_url 11:32:04 INFO - Contents: 11:32:04 INFO - build_url:https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 11:32:04 INFO - Running post-action listener: _resource_record_post_action 11:32:04 INFO - Running post-action listener: find_tests_for_verification 11:32:04 INFO - Running post-action listener: set_extra_try_arguments 11:32:04 INFO - [mozharness: 2017-09-26 18:32:04.269983Z] Finished download-and-extract step (success) 11:32:04 INFO - [mozharness: 2017-09-26 18:32:04.270082Z] Running populate-webroot step. 11:32:04 INFO - Running pre-action listener: _resource_record_pre_action 11:32:04 INFO - Running main action method: populate_webroot 11:32:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:32:04 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:32:04 INFO - 'tests': ['tresize', 11:32:04 INFO - 'tcanvasmark']}, 11:32:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:32:04 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:32:04 INFO - 'tests': ['dromaeo_css', 11:32:04 INFO - 'kraken']}, 11:32:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:32:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:04 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:32:04 INFO - 'talos_options': ['--disable-stylo'], 11:32:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:32:04 INFO - 'tests': ['damp', 'tps']}, 11:32:04 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:32:04 INFO - 'talos_options': ['--disable-stylo'], 11:32:04 INFO - 'tests': ['damp', 'tps']}, 11:32:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:32:04 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:32:04 INFO - 'tests': ['dromaeo_dom']}, 11:32:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:32:04 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:32:04 INFO - 'tests': ['basic_compositor_video', 11:32:04 INFO - 'glvideo']}, 11:32:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:32:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:32:04 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:32:04 INFO - 'talos_options': ['--disable-stylo'], 11:32:04 INFO - 'tests': ['ts_paint_webext', 11:32:04 INFO - 'tp5o_webext']}, 11:32:04 INFO - 'other-e10s': {'tests': ['a11yr', 11:32:04 INFO - 'ts_paint', 11:32:04 INFO - 'tpaint', 11:32:04 INFO - 'sessionrestore', 11:32:04 INFO - 'sessionrestore_many_windows', 11:32:04 INFO - 'sessionrestore_no_auto_restore', 11:32:04 INFO - 'tabpaint']}, 11:32:04 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:32:04 INFO - 'tests': ['a11yr', 11:32:04 INFO - 'ts_paint', 11:32:04 INFO - 'tpaint', 11:32:04 INFO - 'sessionrestore', 11:32:04 INFO - 'sessionrestore_many_windows', 11:32:04 INFO - 'sessionrestore_no_auto_restore', 11:32:04 INFO - 'tabpaint']}, 11:32:04 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:32:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:32:04 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:32:04 INFO - 'tests': ['perf_reftest_singletons']}, 11:32:04 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:32:04 INFO - 'tests': ['perf_reftest']}, 11:32:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:32:04 INFO - 'tsvgr_opacity', 11:32:04 INFO - 'tart', 11:32:04 INFO - 'tscrollx', 11:32:04 INFO - 'tsvg_static']}, 11:32:04 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:32:04 INFO - 'tests': ['tsvgx', 11:32:04 INFO - 'tsvgr_opacity', 11:32:04 INFO - 'tart', 11:32:04 INFO - 'tscrollx', 11:32:04 INFO - 'tsvg_static']}, 11:32:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:32:04 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:32:04 INFO - 'talos_options': ['--disable-stylo'], 11:32:04 INFO - 'tests': ['tp5o']}, 11:32:04 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:32:04 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:32:04 INFO - 'talos_options': ['--mitmproxy', 11:32:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:32:04 INFO - '--firstNonBlankPaint'], 11:32:04 INFO - 'tests': ['tp6_google', 11:32:04 INFO - 'tp6_youtube', 11:32:04 INFO - 'tp6_amazon', 11:32:04 INFO - 'tp6_facebook']}, 11:32:04 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:32:04 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:32:04 INFO - 'talos_options': ['--disable-stylo', 11:32:04 INFO - '--mitmproxy', 11:32:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:32:04 INFO - '--firstNonBlankPaint'], 11:32:04 INFO - 'tests': ['tp6_google', 11:32:04 INFO - 'tp6_youtube', 11:32:04 INFO - 'tp6_amazon', 11:32:04 INFO - 'tp6_facebook']}, 11:32:04 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:32:04 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:32:04 INFO - 'talos_options': ['--stylo-threads=1', 11:32:04 INFO - '--mitmproxy', 11:32:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:32:04 INFO - '--firstNonBlankPaint'], 11:32:04 INFO - 'tests': ['tp6_google', 11:32:04 INFO - 'tp6_youtube', 11:32:04 INFO - 'tp6_amazon', 11:32:04 INFO - 'tp6_facebook']}, 11:32:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:32:04 INFO - 'talos_options': ['--xperf_path', 11:32:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:04 INFO - 'tests': ['tp5n']}, 11:32:04 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:32:04 INFO - 'talos_options': ['--disable-stylo', 11:32:04 INFO - '--xperf_path', 11:32:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:04 INFO - 'tests': ['tp5n']}}} 11:32:04 INFO - Running post-action listener: _resource_record_post_action 11:32:04 INFO - [mozharness: 2017-09-26 18:32:04.285397Z] Finished populate-webroot step (success) 11:32:04 INFO - [mozharness: 2017-09-26 18:32:04.285486Z] Running create-virtualenv step. 11:32:04 INFO - Running pre-action listener: _resource_record_pre_action 11:32:04 INFO - Running main action method: create_virtualenv 11:32:04 INFO - Creating virtualenv /builds/slave/test/build/venv 11:32:04 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:32:04 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:32:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:32:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:32:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:32:04 INFO - Installing distribute.............................................................................................................................................................................................done. 11:32:05 INFO - Installing pip...............done. 11:32:05 INFO - Return code: 0 11:32:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:32:05 INFO - Reading from file tmpfile_stdout 11:32:05 INFO - Output received: 11:32:05 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:32:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:05 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 0x11291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14969c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1493d60>, '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 0x1494a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', '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 11:32:05 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 11:32:05 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 11:32:05 INFO - Using env: {'DISPLAY': ':0', 11:32:05 INFO - 'HOME': '/home/cltbld', 11:32:05 INFO - 'LANG': 'en_US.UTF-8', 11:32:05 INFO - 'LANGUAGE': 'en_US:en', 11:32:05 INFO - 'LOGNAME': 'cltbld', 11:32:05 INFO - 'MAIL': '/var/mail/cltbld', 11:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:05 INFO - 'MOZ_NO_REMOTE': '1', 11:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:05 INFO - 'NO_EM_RESTART': '1', 11:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:05 INFO - 'PWD': '/builds/slave/test', 11:32:05 INFO - 'SHELL': '/bin/bash', 11:32:05 INFO - 'SHLVL': '1', 11:32:05 INFO - 'TERM': 'linux', 11:32:05 INFO - 'TMOUT': '86400', 11:32:05 INFO - 'USER': 'cltbld', 11:32:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', 11:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:05 INFO - '_': '/tools/buildbot/bin/python'} 11:32:06 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:32:06 INFO - Downloading/unpacking pip>=1.5 11:32:06 INFO - Running setup.py egg_info for package pip 11:32:06 INFO - warning: no files found matching 'pip/cacert.pem' 11:32:06 INFO - warning: no files found matching '*.html' under directory 'docs' 11:32:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:32:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:32:06 INFO - Installing collected packages: pip 11:32:06 INFO - Found existing installation: pip 1.1 11:32:06 INFO - Uninstalling pip: 11:32:06 INFO - Successfully uninstalled pip 11:32:06 INFO - Running setup.py install for pip 11:32:06 INFO - warning: no files found matching 'pip/cacert.pem' 11:32:06 INFO - warning: no files found matching '*.html' under directory 'docs' 11:32:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:32:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:32:06 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:32:06 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:32:06 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:32:06 INFO - Successfully installed pip 11:32:06 INFO - Cleaning up... 11:32:06 INFO - Return code: 0 11:32:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:06 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 0x11291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14969c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1493d60>, '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 0x1494a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', '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 11:32:06 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 11:32:06 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 11:32:06 INFO - Using env: {'DISPLAY': ':0', 11:32:06 INFO - 'HOME': '/home/cltbld', 11:32:06 INFO - 'LANG': 'en_US.UTF-8', 11:32:06 INFO - 'LANGUAGE': 'en_US:en', 11:32:06 INFO - 'LOGNAME': 'cltbld', 11:32:06 INFO - 'MAIL': '/var/mail/cltbld', 11:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:06 INFO - 'MOZ_NO_REMOTE': '1', 11:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:06 INFO - 'NO_EM_RESTART': '1', 11:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:06 INFO - 'PWD': '/builds/slave/test', 11:32:06 INFO - 'SHELL': '/bin/bash', 11:32:06 INFO - 'SHLVL': '1', 11:32:06 INFO - 'TERM': 'linux', 11:32:06 INFO - 'TMOUT': '86400', 11:32:06 INFO - 'USER': 'cltbld', 11:32:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', 11:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:06 INFO - '_': '/tools/buildbot/bin/python'} 11:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:06 INFO - Downloading/unpacking psutil>=3.1.1 11:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:32:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:08 INFO - Installing collected packages: psutil 11:32:08 INFO - Running setup.py install for psutil 11:32:08 INFO - building 'psutil._psutil_linux' extension 11:32:08 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 11:32:08 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 11:32:08 INFO - building 'psutil._psutil_posix' extension 11:32:08 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 11:32:08 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 11:32:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:08 INFO - Successfully installed psutil 11:32:08 INFO - Cleaning up... 11:32:08 INFO - Return code: 0 11:32:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14969c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1493d60>, '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 0x1494a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', '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 11:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:32:08 INFO - Using env: {'DISPLAY': ':0', 11:32:08 INFO - 'HOME': '/home/cltbld', 11:32:08 INFO - 'LANG': 'en_US.UTF-8', 11:32:08 INFO - 'LANGUAGE': 'en_US:en', 11:32:08 INFO - 'LOGNAME': 'cltbld', 11:32:08 INFO - 'MAIL': '/var/mail/cltbld', 11:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:08 INFO - 'MOZ_NO_REMOTE': '1', 11:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:08 INFO - 'NO_EM_RESTART': '1', 11:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:08 INFO - 'PWD': '/builds/slave/test', 11:32:08 INFO - 'SHELL': '/bin/bash', 11:32:08 INFO - 'SHLVL': '1', 11:32:08 INFO - 'TERM': 'linux', 11:32:08 INFO - 'TMOUT': '86400', 11:32:08 INFO - 'USER': 'cltbld', 11:32:08 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', 11:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:08 INFO - '_': '/tools/buildbot/bin/python'} 11:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:32:08 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 11:32:08 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 11:32:08 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 11:32:08 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 11:32:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:32:09 INFO - Installing collected packages: mozsystemmonitor 11:32:09 INFO - Running setup.py install for mozsystemmonitor 11:32:10 INFO - Successfully installed mozsystemmonitor 11:32:10 INFO - Cleaning up... 11:32:10 INFO - Return code: 0 11:32:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:32:10 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')]} 11:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:10 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')]} 11:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:10 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 0x11291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14969c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1493d60>, '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 0x1494a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', '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 11:32:10 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 11:32:10 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 11:32:10 INFO - Using env: {'DISPLAY': ':0', 11:32:10 INFO - 'HOME': '/home/cltbld', 11:32:10 INFO - 'LANG': 'en_US.UTF-8', 11:32:10 INFO - 'LANGUAGE': 'en_US:en', 11:32:10 INFO - 'LOGNAME': 'cltbld', 11:32:10 INFO - 'MAIL': '/var/mail/cltbld', 11:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:10 INFO - 'MOZ_NO_REMOTE': '1', 11:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:10 INFO - 'NO_EM_RESTART': '1', 11:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:10 INFO - 'PWD': '/builds/slave/test', 11:32:10 INFO - 'SHELL': '/bin/bash', 11:32:10 INFO - 'SHLVL': '1', 11:32:10 INFO - 'TERM': 'linux', 11:32:10 INFO - 'TMOUT': '86400', 11:32:10 INFO - 'USER': 'cltbld', 11:32:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', 11:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:10 INFO - '_': '/tools/buildbot/bin/python'} 11:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:10 INFO - Downloading/unpacking jsonschema==2.5.1 11:32:10 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 11:32:10 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 11:32:10 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 11:32:10 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 11:32:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:32:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:32:13 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 11:32:13 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 11:32:13 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 11:32:13 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 11:32:13 INFO - Downloading functools32-3.2.3-2.tar.gz 11:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:32:13 INFO - warning: no files found matching '*.txt' 11:32:13 INFO - no previously-included directories found matching 'build' 11:32:13 INFO - no previously-included directories found matching 'dist' 11:32:13 INFO - no previously-included directories found matching '.git*' 11:32:13 INFO - Installing collected packages: jsonschema, functools32 11:32:13 INFO - Running setup.py install for functools32 11:32:13 INFO - warning: no files found matching '*.txt' 11:32:13 INFO - no previously-included directories found matching 'build' 11:32:13 INFO - no previously-included directories found matching 'dist' 11:32:13 INFO - no previously-included directories found matching '.git*' 11:32:13 INFO - Successfully installed jsonschema functools32 11:32:13 INFO - Cleaning up... 11:32:13 INFO - Return code: 0 11:32:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:13 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 0x11291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14969c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1493d60>, '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 0x1494a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', '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 11:32:13 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 11:32:13 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 11:32:13 INFO - Using env: {'DISPLAY': ':0', 11:32:13 INFO - 'HOME': '/home/cltbld', 11:32:13 INFO - 'LANG': 'en_US.UTF-8', 11:32:13 INFO - 'LANGUAGE': 'en_US:en', 11:32:13 INFO - 'LOGNAME': 'cltbld', 11:32:13 INFO - 'MAIL': '/var/mail/cltbld', 11:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:13 INFO - 'MOZ_NO_REMOTE': '1', 11:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:13 INFO - 'NO_EM_RESTART': '1', 11:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:13 INFO - 'PWD': '/builds/slave/test', 11:32:13 INFO - 'SHELL': '/bin/bash', 11:32:13 INFO - 'SHLVL': '1', 11:32:13 INFO - 'TERM': 'linux', 11:32:13 INFO - 'TMOUT': '86400', 11:32:13 INFO - 'USER': 'cltbld', 11:32:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', 11:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:13 INFO - '_': '/tools/buildbot/bin/python'} 11:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:32:14 INFO - Cleaning up... 11:32:14 INFO - Return code: 0 11:32:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:14 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 0x11291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14969c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1493d60>, '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 0x1494a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', '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 11:32:14 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 11:32:14 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 11:32:14 INFO - Using env: {'DISPLAY': ':0', 11:32:14 INFO - 'HOME': '/home/cltbld', 11:32:14 INFO - 'LANG': 'en_US.UTF-8', 11:32:14 INFO - 'LANGUAGE': 'en_US:en', 11:32:14 INFO - 'LOGNAME': 'cltbld', 11:32:14 INFO - 'MAIL': '/var/mail/cltbld', 11:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:14 INFO - 'MOZ_NO_REMOTE': '1', 11:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:14 INFO - 'NO_EM_RESTART': '1', 11:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:14 INFO - 'PWD': '/builds/slave/test', 11:32:14 INFO - 'SHELL': '/bin/bash', 11:32:14 INFO - 'SHLVL': '1', 11:32:14 INFO - 'TERM': 'linux', 11:32:14 INFO - 'TMOUT': '86400', 11:32:14 INFO - 'USER': 'cltbld', 11:32:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', 11:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:14 INFO - '_': '/tools/buildbot/bin/python'} 11:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:14 INFO - Downloading/unpacking blobuploader==1.2.4 11:32:14 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 11:32:14 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 11:32:14 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 11:32:14 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 11:32:15 INFO - Downloading blobuploader-1.2.4.tar.gz 11:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:32:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:32:15 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 11:32:15 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 11:32:15 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 11:32:15 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 11:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:32:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:32:15 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 11:32:15 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 11:32:15 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 11:32:15 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 11:32:15 INFO - Downloading docopt-0.6.1.tar.gz 11:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:32:16 INFO - Installing collected packages: blobuploader, requests, docopt 11:32:16 INFO - Running setup.py install for blobuploader 11:32:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:32:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:32:16 INFO - Running setup.py install for requests 11:32:16 INFO - Running setup.py install for docopt 11:32:16 INFO - Successfully installed blobuploader requests docopt 11:32:16 INFO - Cleaning up... 11:32:16 INFO - Return code: 0 11:32:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:16 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')]} 11:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:16 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')]} 11:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:16 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 0x11291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14969c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1493d60>, '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 0x1494a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', '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 11:32:16 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 11:32:16 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 11:32:16 INFO - Using env: {'DISPLAY': ':0', 11:32:16 INFO - 'HOME': '/home/cltbld', 11:32:16 INFO - 'LANG': 'en_US.UTF-8', 11:32:16 INFO - 'LANGUAGE': 'en_US:en', 11:32:16 INFO - 'LOGNAME': 'cltbld', 11:32:16 INFO - 'MAIL': '/var/mail/cltbld', 11:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:16 INFO - 'MOZ_NO_REMOTE': '1', 11:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:16 INFO - 'NO_EM_RESTART': '1', 11:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:16 INFO - 'PWD': '/builds/slave/test', 11:32:16 INFO - 'SHELL': '/bin/bash', 11:32:16 INFO - 'SHLVL': '1', 11:32:16 INFO - 'TERM': 'linux', 11:32:16 INFO - 'TMOUT': '86400', 11:32:16 INFO - 'USER': 'cltbld', 11:32:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', 11:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:16 INFO - '_': '/tools/buildbot/bin/python'} 11:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:16 INFO - Running setup.py (path:/tmp/pip-PeCVAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:16 INFO - Running setup.py (path:/tmp/pip-i_3Lb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:16 INFO - Running setup.py (path:/tmp/pip-EYSAhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:17 INFO - Running setup.py (path:/tmp/pip-XfCJtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:17 INFO - Running setup.py (path:/tmp/pip-RJXuC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:17 INFO - Running setup.py (path:/tmp/pip-tFxRWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:17 INFO - Running setup.py (path:/tmp/pip-IBe_a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:17 INFO - Running setup.py (path:/tmp/pip-obBqWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:17 INFO - Running setup.py (path:/tmp/pip-furPsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:17 INFO - Running setup.py (path:/tmp/pip-iDVXQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:17 INFO - Running setup.py (path:/tmp/pip-K67Lwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:17 INFO - Running setup.py (path:/tmp/pip-oND3ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:17 INFO - Running setup.py (path:/tmp/pip-6BnrkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:17 INFO - Running setup.py (path:/tmp/pip-ncvJsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:17 INFO - Running setup.py (path:/tmp/pip-0IXheq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:17 INFO - Running setup.py (path:/tmp/pip-eHOdQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:17 INFO - Running setup.py (path:/tmp/pip-ic2dp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:32:18 INFO - Running setup.py install for manifestparser 11:32:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:32:18 INFO - Running setup.py install for mozcrash 11:32:18 INFO - Running setup.py install for mozdebug 11:32:18 INFO - Running setup.py install for mozdevice 11:32:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:32:18 INFO - Running setup.py install for mozfile 11:32:18 INFO - Running setup.py install for mozhttpd 11:32:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:32:18 INFO - Running setup.py install for mozinfo 11:32:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:32:18 INFO - Running setup.py install for mozInstall 11:32:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:32:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:32:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:32:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:32:18 INFO - Running setup.py install for mozleak 11:32:18 INFO - Running setup.py install for mozlog 11:32:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:32:19 INFO - Running setup.py install for moznetwork 11:32:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:32:19 INFO - Running setup.py install for mozprocess 11:32:19 INFO - Running setup.py install for mozprofile 11:32:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:32:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:32:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:32:19 INFO - Running setup.py install for mozrunner 11:32:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:32:19 INFO - Running setup.py install for mozscreenshot 11:32:19 INFO - Running setup.py install for moztest 11:32:19 INFO - Running setup.py install for mozversion 11:32:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:32:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:32:19 INFO - Cleaning up... 11:32:19 INFO - Return code: 0 11:32:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:19 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 0x11291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14969c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1493d60>, '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 0x1494a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', '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 11:32:19 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 11:32:19 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 11:32:19 INFO - Using env: {'DISPLAY': ':0', 11:32:19 INFO - 'HOME': '/home/cltbld', 11:32:19 INFO - 'LANG': 'en_US.UTF-8', 11:32:19 INFO - 'LANGUAGE': 'en_US:en', 11:32:19 INFO - 'LOGNAME': 'cltbld', 11:32:19 INFO - 'MAIL': '/var/mail/cltbld', 11:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:19 INFO - 'MOZ_NO_REMOTE': '1', 11:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:19 INFO - 'NO_EM_RESTART': '1', 11:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:19 INFO - 'PWD': '/builds/slave/test', 11:32:19 INFO - 'SHELL': '/bin/bash', 11:32:19 INFO - 'SHLVL': '1', 11:32:19 INFO - 'TERM': 'linux', 11:32:19 INFO - 'TMOUT': '86400', 11:32:19 INFO - 'USER': 'cltbld', 11:32:19 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', 11:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:19 INFO - '_': '/tools/buildbot/bin/python'} 11:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:19 INFO - Running setup.py (path:/tmp/pip-UhlQrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:20 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)) 11:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:20 INFO - Running setup.py (path:/tmp/pip-Vl7g1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:20 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)) 11:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:20 INFO - Running setup.py (path:/tmp/pip-rFEvN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:20 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)) 11:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:20 INFO - Running setup.py (path:/tmp/pip-GQDQgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:20 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)) 11:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:20 INFO - Running setup.py (path:/tmp/pip-xkhhwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:20 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)) 11:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:20 INFO - Running setup.py (path:/tmp/pip-X8EUKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:20 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)) 11:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:20 INFO - Running setup.py (path:/tmp/pip-QxSXtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:20 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)) 11:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:20 INFO - Running setup.py (path:/tmp/pip-H20M3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:20 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)) 11:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:20 INFO - Running setup.py (path:/tmp/pip-ojP5qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:20 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)) 11:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:20 INFO - Running setup.py (path:/tmp/pip-Nl0nVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:20 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)) 11:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:20 INFO - Running setup.py (path:/tmp/pip-NmDfax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:20 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)) 11:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:20 INFO - Running setup.py (path:/tmp/pip-nAML9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:20 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)) 11:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:20 INFO - Running setup.py (path:/tmp/pip-f9hShP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:20 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)) 11:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:20 INFO - Running setup.py (path:/tmp/pip-7GKj6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:21 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)) 11:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:21 INFO - Running setup.py (path:/tmp/pip-gC5tAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:21 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)) 11:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:21 INFO - Running setup.py (path:/tmp/pip-mWMoz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:21 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)) 11:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:21 INFO - Running setup.py (path:/tmp/pip-nN1lUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:21 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)) 11:32:21 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)) 11:32:21 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)) 11:32:21 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)) 11:32:21 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)) 11:32:21 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)) 11:32:21 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)) 11:32:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:21 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 11:32:21 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 11:32:21 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 11:32:21 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 11:32:22 INFO - Downloading blessings-1.6.tar.gz 11:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:32:22 INFO - Installing collected packages: blessings 11:32:22 INFO - Running setup.py install for blessings 11:32:22 INFO - Successfully installed blessings 11:32:22 INFO - Cleaning up... 11:32:22 INFO - Return code: 0 11:32:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:22 INFO - Reading from file tmpfile_stdout 11:32:22 INFO - Current package versions: 11:32:22 INFO - argparse == 1.2.1 11:32:22 INFO - blessings == 1.6 11:32:22 INFO - blobuploader == 1.2.4 11:32:22 INFO - docopt == 0.6.1 11:32:22 INFO - functools32 == 3.2.3-2 11:32:22 INFO - jsonschema == 2.5.1 11:32:22 INFO - manifestparser == 1.1 11:32:22 INFO - mozInstall == 1.13 11:32:22 INFO - mozcrash == 1.0 11:32:22 INFO - mozdebug == 0.1 11:32:22 INFO - mozdevice == 0.51 11:32:22 INFO - mozfile == 1.2 11:32:22 INFO - mozhttpd == 0.7 11:32:22 INFO - mozinfo == 0.10 11:32:22 INFO - mozleak == 0.1 11:32:22 INFO - mozlog == 3.5 11:32:22 INFO - moznetwork == 0.27 11:32:22 INFO - mozprocess == 0.25 11:32:22 INFO - mozprofile == 0.28 11:32:22 INFO - mozrunner == 6.13 11:32:22 INFO - mozscreenshot == 0.1 11:32:22 INFO - mozsystemmonitor == 0.3 11:32:22 INFO - moztest == 0.8 11:32:22 INFO - mozversion == 1.4 11:32:22 INFO - psutil == 3.1.1 11:32:22 INFO - requests == 1.2.3 11:32:22 INFO - wsgiref == 0.1.2 11:32:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:22 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')]} 11:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:22 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')]} 11:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:22 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 0x11291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14969c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1493d60>, '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 0x1494a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', '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 11:32:22 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 11:32:22 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 11:32:22 INFO - Using env: {'DISPLAY': ':0', 11:32:22 INFO - 'HOME': '/home/cltbld', 11:32:22 INFO - 'LANG': 'en_US.UTF-8', 11:32:22 INFO - 'LANGUAGE': 'en_US:en', 11:32:22 INFO - 'LOGNAME': 'cltbld', 11:32:22 INFO - 'MAIL': '/var/mail/cltbld', 11:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:22 INFO - 'MOZ_NO_REMOTE': '1', 11:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:22 INFO - 'NO_EM_RESTART': '1', 11:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:22 INFO - 'PWD': '/builds/slave/test', 11:32:22 INFO - 'SHELL': '/bin/bash', 11:32:22 INFO - 'SHLVL': '1', 11:32:22 INFO - 'TERM': 'linux', 11:32:22 INFO - 'TMOUT': '86400', 11:32:22 INFO - 'USER': 'cltbld', 11:32:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', 11:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:22 INFO - '_': '/tools/buildbot/bin/python'} 11:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:22 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)) 11:32:22 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)) 11:32:22 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)) 11:32:22 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)) 11:32:22 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)) 11:32:22 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)) 11:32:22 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)) 11:32:22 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)) 11:32:22 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)) 11:32:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:32:22 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 11:32:22 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 11:32:22 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 11:32:22 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 11:32:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:32:24 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)) 11:32:24 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)) 11:32:24 INFO - Installing collected packages: simplejson 11:32:24 INFO - Running setup.py install for simplejson 11:32:24 INFO - building 'simplejson._speedups' extension 11:32:24 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 11:32:25 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 11:32:25 INFO - Successfully installed simplejson 11:32:25 INFO - Cleaning up... 11:32:25 INFO - Return code: 0 11:32:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32: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')]} 11:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14969c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1493d60>, '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 0x1494a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', '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 11:32: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', 'jsonschema'] in /builds/slave/test/build 11:32: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 jsonschema 11:32:25 INFO - Using env: {'DISPLAY': ':0', 11:32:25 INFO - 'HOME': '/home/cltbld', 11:32:25 INFO - 'LANG': 'en_US.UTF-8', 11:32:25 INFO - 'LANGUAGE': 'en_US:en', 11:32:25 INFO - 'LOGNAME': 'cltbld', 11:32:25 INFO - 'MAIL': '/var/mail/cltbld', 11:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:25 INFO - 'MOZ_NO_REMOTE': '1', 11:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:25 INFO - 'NO_EM_RESTART': '1', 11:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:25 INFO - 'PWD': '/builds/slave/test', 11:32:25 INFO - 'SHELL': '/bin/bash', 11:32:25 INFO - 'SHLVL': '1', 11:32:25 INFO - 'TERM': 'linux', 11:32:25 INFO - 'TMOUT': '86400', 11:32:25 INFO - 'USER': 'cltbld', 11:32:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', 11:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:25 INFO - '_': '/tools/buildbot/bin/python'} 11:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:32:25 INFO - Cleaning up... 11:32:25 INFO - Return code: 0 11:32:25 INFO - Running post-action listener: _resource_record_post_action 11:32:25 INFO - Running post-action listener: _start_resource_monitoring 11:32:25 INFO - Starting resource monitoring. 11:32:25 INFO - [mozharness: 2017-09-26 18:32:25.508641Z] Finished create-virtualenv step (success) 11:32:25 INFO - [mozharness: 2017-09-26 18:32:25.509169Z] Running install step. 11:32:25 INFO - Running pre-action listener: _resource_record_pre_action 11:32:25 INFO - Running main action method: install 11:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:25 INFO - Reading from file tmpfile_stdout 11:32:25 INFO - Detecting whether we're running mozinstall >=1.0... 11:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:32:25 INFO - Reading from file tmpfile_stdout 11:32:25 INFO - Output received: 11:32:25 INFO - Usage: mozinstall [options] installer 11:32:25 INFO - Options: 11:32:25 INFO - -h, --help show this help message and exit 11:32:25 INFO - -d DEST, --destination=DEST 11:32:25 INFO - Directory to install application into. [default: 11:32:25 INFO - "/builds/slave/test"] 11:32:25 INFO - --app=APP Application being installed. [default: firefox] 11:32:25 INFO - mkdir: /builds/slave/test/build/application 11:32:25 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'] 11:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:32:43 INFO - Reading from file tmpfile_stdout 11:32:43 INFO - Output received: 11:32:43 INFO - /builds/slave/test/build/application/firefox/firefox 11:32:43 INFO - Running post-action listener: _resource_record_post_action 11:32:43 INFO - [mozharness: 2017-09-26 18:32:43.673228Z] Finished install step (success) 11:32:43 INFO - [mozharness: 2017-09-26 18:32:43.673481Z] Running setup-mitmproxy step. 11:32:43 INFO - Running pre-action listener: _resource_record_pre_action 11:32:43 INFO - Running main action method: setup_mitmproxy 11:32:43 INFO - Skipping: mitmproxy is not required 11:32:43 INFO - Running post-action listener: _resource_record_post_action 11:32:43 INFO - [mozharness: 2017-09-26 18:32:43.674604Z] Finished setup-mitmproxy step (success) 11:32:43 INFO - [mozharness: 2017-09-26 18:32:43.674895Z] Running run-tests step. 11:32:43 INFO - Running pre-action listener: _resource_record_pre_action 11:32:43 INFO - Running pre-action listener: _set_gcov_prefix 11:32:43 INFO - Running main action method: run_tests 11:32:43 WARNING - Try message not found. 11:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:32:43 INFO - Python 2.7.3 11:32:43 INFO - Return code: 0 11:32:43 INFO - grabbing minidump binary from tooltool 11:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:43 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 0x1493d60>, '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 0x1494a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:32:43 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 11:32:43 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 11:32:43 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 11:32:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:32:43 INFO - Return code: 0 11:32:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:32:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:32:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:32:43 INFO - ENV: RUST_BACKTRACE is now full 11:32:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:32:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:32:43 INFO - Using env: {'DISPLAY': ':0', 11:32:43 INFO - 'HOME': '/home/cltbld', 11:32:43 INFO - 'LANG': 'en_US.UTF-8', 11:32:43 INFO - 'LANGUAGE': 'en_US:en', 11:32:43 INFO - 'LOGNAME': 'cltbld', 11:32:43 INFO - 'MAIL': '/var/mail/cltbld', 11:32:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:43 INFO - 'MOZ_NO_REMOTE': '1', 11:32:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:43 INFO - 'NO_EM_RESTART': '1', 11:32:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:43 INFO - 'PWD': '/builds/slave/test', 11:32:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:43 INFO - 'RUST_BACKTRACE': 'full', 11:32:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:43 INFO - 'SHELL': '/bin/bash', 11:32:43 INFO - 'SHLVL': '1', 11:32:43 INFO - 'TERM': 'linux', 11:32:43 INFO - 'TMOUT': '86400', 11:32:43 INFO - 'USER': 'cltbld', 11:32:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', 11:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:43 INFO - '_': '/tools/buildbot/bin/python'} 11:32:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:32:44 INFO - mozversion application_buildid: 20170926173447 11:32:44 INFO - mozversion application_changeset: b30ae5a455367f336ded1052081e4c54a139fa81 11:32:44 INFO - mozversion application_display_name: Nightly 11:32:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:32:44 INFO - mozversion application_name: Firefox 11:32:44 INFO - mozversion application_remotingname: firefox 11:32:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:32:44 INFO - mozversion application_vendor: Mozilla 11:32:44 INFO - mozversion application_version: 58.0a1 11:32:44 INFO - mozversion platform_buildid: 20170926173447 11:32:44 INFO - mozversion platform_changeset: b30ae5a455367f336ded1052081e4c54a139fa81 11:32:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:32:44 INFO - mozversion platform_version: 58.0a1 11:32:44 INFO - using testdate: 1506450764 11:32:44 INFO - actual date: 1506450764 11:32:44 INFO - starting webserver on 'localhost:33725' 11:32:44 INFO - SUITE-START | Running 2 tests 11:32:44 INFO - TEST-START | dromaeo_css 11:32:44 INFO - Initialising browser for dromaeo_css test... 11:32:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33725/getInfo.html -profile /tmp/tmpfJXNiB/profile 11:32:44 INFO - TEST-INFO | started process 8442 (/builds/slave/test/build/application/firefox/firefox http://localhost:33725/getInfo.html) 11:32:50 INFO - TEST-INFO | 8442: exit 0 11:32:50 INFO - Browser initialized. 11:32:50 INFO - Running cycle 1/1 for dromaeo_css test... 11:32:50 INFO - Using env: {'DISPLAY': ':0', 11:32:50 INFO - 'HOME': '/home/cltbld', 11:32:50 INFO - 'JSGC_DISABLE_POISONING': '1', 11:32:50 INFO - 'LANG': 'en_US.UTF-8', 11:32:50 INFO - 'LANGUAGE': 'en_US:en', 11:32:50 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:32:50 INFO - 'LOGNAME': 'cltbld', 11:32:50 INFO - 'MAIL': '/var/mail/cltbld', 11:32:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:50 INFO - 'MOZ_CRASHREPORTER': '1', 11:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:50 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:32:50 INFO - 'MOZ_NO_REMOTE': '1', 11:32:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:50 INFO - 'NO_EM_RESTART': '1', 11:32:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:50 INFO - 'PWD': '/builds/slave/test', 11:32:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:50 INFO - 'RUST_BACKTRACE': 'full', 11:32:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:50 INFO - 'SHELL': '/bin/bash', 11:32:50 INFO - 'SHLVL': '1', 11:32:50 INFO - 'TERM': 'linux', 11:32:50 INFO - 'TMOUT': '86400', 11:32:50 INFO - 'USER': 'cltbld', 11:32:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', 11:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:50 INFO - '_': '/tools/buildbot/bin/python'} 11:32:50 INFO - TEST-INFO | started process 8674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfJXNiB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:50 INFO - PID 8674 | 11:32:50 INFO - PID 8674 | (/builds/slave/test/build/application/firefox/firefox:8723): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:32:50 INFO - PID 8674 | 11:33:01 INFO - PID 8674 | RSS: Main: 151347200 11:33:01 INFO - PID 8674 | 11:35:58 INFO - PID 8674 | Cycle 1(1): loaded http://localhost:33725/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33725/tests/dromaeo/cssquery-ext.html) 11:36:00 INFO - PID 8674 | RSS: Main: 153346048 11:36:00 INFO - PID 8674 | 11:39:01 INFO - PID 8674 | Cycle 1(1): loaded http://localhost:33725/tests/dromaeo/cssquery-ext.html (next: http://localhost:33725/tests/dromaeo/cssquery-jquery.html) 11:39:02 INFO - PID 8674 | RSS: Main: 153505792 11:39:02 INFO - PID 8674 | 11:42:04 INFO - PID 8674 | Cycle 1(1): loaded http://localhost:33725/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33725/tests/dromaeo/cssquery-mootools.html) 11:42:04 INFO - PID 8674 | RSS: Main: 155258880 11:42:04 INFO - PID 8674 | 11:45:06 INFO - PID 8674 | Cycle 1(1): loaded http://localhost:33725/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33725/tests/dromaeo/cssquery-prototype.html) 11:45:06 INFO - PID 8674 | RSS: Main: 151916544 11:45:06 INFO - PID 8674 | 11:48:10 INFO - PID 8674 | Cycle 1(1): loaded http://localhost:33725/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33725/tests/dromaeo/cssquery-yui.html) 11:48:10 INFO - PID 8674 | RSS: Main: 155115520 11:48:10 INFO - PID 8674 | 11:51:12 INFO - PID 8674 | Cycle 1(1): loaded http://localhost:33725/tests/dromaeo/cssquery-yui.html (next: http://localhost:33725/tests/dromaeo/cssquery-dojo.html) 11:51:12 INFO - PID 8674 | RSS: Main: 156938240 11:51:12 INFO - PID 8674 | 11:51:12 INFO - PID 8674 | __start_tp_report 11:51:12 INFO - PID 8674 | _x_x_mozilla_page_load 11:51:12 INFO - PID 8674 | _x_x_mozilla_page_load_details 11:51:12 INFO - PID 8674 | |i|pagename|runs| 11:51:12 INFO - PID 8674 | |0;dojo.html;3105.6428510721266;3132.608423947006;3153.8580763865625;3164.5095010273385;3176.1741947093747;6210;6340.207474065742;6383.1063651088825;6409.935900640992;6492.15601971743;6270.749170033205;6308.243010838706;6411.1986001749665;6435.806925792233;6453.515986301035;1313.6344487173428;5867.119932010211;5893.057110862263;5915.822525324247;5938.4952279056115;5769.769209231626;5785.421457854202;5814.302283725959;5906.084556893688;5931.347551769302;5819.534437245032;5840.561957853178;5874;5892.175095486636;5903.026000709878;5794.101914203306;5813;5875.294964604275;5877.617954832922;5900.409959004065;5779.87292477967;5814.622049566807;5874.295084589877;5887.70561471929;5897.233359663259;6315.463185629227;6346.9682651586445;6361.9045714314325;6413.486921046305;6429;6562.376574225441;6617.50368722343;6717.093192419059;6737.898931516032;6740.494462915252;6802.4217941475035;6809.795706128824;6812.863742725167;6817.659117044128;6825.283345248727;6129.264488261437;6212.068189771525;6329.398707122816;6396.040593910904;6397.168368112116;6998.195207551095;7077.327653872874;7085.96457017722;7114.288571142844;7125.714971401086;6606.438452731475;6606.537542372084;6667.166604174478;6701.765438209639;6726.764563240263;6654.900176497356;6705.564138330993;6735.932640673531;6811.659417029228;6846.931530684729;6678.432333251728;6682.83292917681;6689.866202675919;6696.961970894519;6702.0282059101155;6760.763373281911;6815.829604259933;6818.079559259437;6828.795136145924;6885.483588730865;5252.65857719247;5265.4997775211295;5296.523312901857;5335.199720042025;5335.919961200585;4568.383268258809;4606.700564463299;4619.976900115478;4647.16351056813;4658.813647454064;5698.230738850202;5809.390014048548;5824.184614154022;5897.292324921037;5898.64608123514;6835.384815366541;6888.138982627172;6897.41371983387;6910.378065974087;6918.654067296716;5806.506446951972;5864.03243464832;5880.382559831241;5885.411458854166;5891.587588868823;5835.35811060783;5852.7030168725105;5924.140999555127;5927.229460170151;5936.22829032223;6409.583377080475;6511.804645860631;6590.044443555657;6601.3068627794355;6683.331666833375;6707.8993815091835;6846.760363387258;6863.519553631198;6880.518363714492;6887.449004079562;6556.311587283267;6560.803175904731;6615.338466153346;6663.400293973566;6666.699998500176;6673.466122710074;6712.295209002984;6772.0857684212;6776.119104516381;6795.25252222265;6645.368689974444;6715.1941766988275;6766.120404347404;6829.658517074027;6925.58446493212;6517.9348206517325;6524.902126468011;6548.8362790930605;6558.540902136995;6666.799996000128;6554.541182117206;6620;6692.76575319881;6703.530752847254;6715.764948226789;6508.284088750328;6522.739090436329;6525.184351956005;6605.768798092044;6611.834704132243;6448;6600.966995164993;6653.600783952978;6715.0263211833035;6736;6488.675566221765;6535.2811190768025;6538.803835884931;6549.4760419165395;6549.7380104795275 11:51:12 INFO - PID 8674 | |1;ext.html;836.7489753074076;886.6409104312753;908.1327332397559;909.6997990663077;912.8904531456226;39425.802870985644;40180.59819401805;40376.1924761505;40513;40569.39145912806;36817.63182368175;37173.25653486929;37321.25357492849;37363.813180934056;37416;7192.640367981606;7290.088738907637;7334.193238743734;7334.339909408152;7347.2652734726635;7215.494915355927;7323.48735588509;7326.377257933082;7327.377172940306;7331.8533629327385;7290.890636640454;7299.562026278414;7330.963345183267;7332.30343117403;7334.889976650355;7733.45865789395;7978.800529986796;7980.201979802031;7985.441019128663;7993.880091798627;7874.72438464651;7956.761297161094;7957.005374328209;7965.123836377994;7965.322947549465;36367.454488182695;37567.436488452695;38064.23871522554;38220.80889595562;38263.808680956696;3506.6668666476644;3522.771019883725;3533.717302615785;3579.46308053794;3579.6420357964257;30562.84718576393;30725.846370768228;30971;30982.845085774654;31073.68926310753;5112.335396398482;5157.381114266312;5167.457416971201;5192.766325515323;5272.393674727417;188266;192433;193864;194028;194094;47948.52051479441;47949.28076078861;47991;48072;48103;50015;50096.49903500918;50294.497055029715;50487.74756126196;50666.24000639993;15704.921475392779;16005.599860003593;16054.598635033984;16062.75905861413;16092;13009.804852927213;13050.673733156556;13078.346082695827;13083.345832708517;13103.01727370432;14304.499342522962;14351.282435878164;14355.85644143566;14520.273986300643;14534.418623255162;5861.824145275648;5895.498882595028;5902.911456328158;5910.881782364415;5965.850853728604;1004.4977511244377;1005.5475036233724;1016.4003238089563;1024.7950409918046;1029.1663752360612;22773.772262277496;22810.973506192262;22918.885405573197;22942.770572294397;23103.306900793003;1120.8038593246313;1129.5989923577013;1131.666158483233;1136.1762722026465;1138.4990604134155;12256.571020014257;12296.323702196287;12343.876561234272;12352.814707779391;12399.814002789966;216502;218334;218593;218994;219321;51639.74180129075;51762.48237517652;52090.21864672033;56139.438605613424;56794.43205567974;1440.6182361673955;1445.638590352412;1446.978295325592;1459.7518421868308;1465.2966576043345;26625.003124766106;27313.044043458383;27455.86272068627;27582.3104422383;27685.307867302672;38582;38964.220715586096;39024.80487597544;39044;39048.41427378535;199345;200443;201149;201157;201304;32552.51171232386;33955.49066763951;33961.66038339684;33983.320333592696;34026.14934626654;42833.5716642842;43232;43381;43478.13043739171;44187;31165;31539;31545.36909261756;31706.841465792524;32204;30540.84729576338;30894.53658195084;31208;31429.528557071204;31431;35492.82253588716;35577.82211088928;35760.463593045606;35857;35964.4605330915;30521.542176866922;30562.388752225277;30593.694063059083;30830.845845771524;30842.383152337276;22983.655245171;23143.421414464774;23404.7106010917;23423.06307747671;23745.05019799258 11:51:12 INFO - PID 8674 | |2;jquery.html;575.2952633024546;583.3495652347634;597.3727586034665;600.3786081405744;624.0919462182525;21494.462638434048;22245.44386390341;22286.665700014513;22328.106875724952;22409.3277201684;21963.450913727163;23405.414864628394;23650.29049128529;23788.76211237887;23802;6677.966610166966;6709.362610552014;6746.055552222692;6747.08914296571;6760.39156475917;6665.300143484937;6757.425618822406;6795.7961261162245;7106.933959906004;7109.8222544436285;7105.928940710578;7107.431405487574;7108.466864985121;7111.32442417972;7112.822179445504;7088.822779430504;7099.89350159748;7115.53749006313;7123.2520585338825;7143.392811611019;6664.200295964467;6969.372756451893;6985.3713165815325;6989;7009.193942696605;29126;29622.963196288027;29658.40683186324;29669.554956675667;29733;2056.208359781495;2067.4831292176955;2078.199893041175;2090.5818836232816;2090.790920907912;19559;19890.20439182431;20331.491712707153;20695.8965205173;20895.37313880586;2466.161505088279;2505.7494250574796;2541.504406640706;2542.2627438043132;2569.3191304304373;120714;127251.36374318162;136516.31741841327;141075.29462352622;147487;20079;20136.899315503328;20245;21088.78911210899;21148.57702845965;40490.19019619591;41284.1743165141;41291.58708412937;41348.58651413448;41648.583514165075;10996.835047474295;11109.111271098292;11194.272372295938;11258.155638327158;11287.379194144236;9128.178463938277;9154;9173.495457749754;9186.586603602855;9246.537673116452;10696;10948.562057517769;10977.615783447542;11156.497957591928;11188.832167517494;4206.936895946563;4239.788010599519;4241.384999175102;4259.55810571195;4395.560443955579;939.8825146856643;975.3903810118676;977.1596427072711;980.6371642492323;986.5757724178528;18056.90971545134;18226.63546729058;18530.536736581424;18581.25674973013;18728.906355468407;1007.3200589601989;1020.260311274335;1023.2683631203726;1024.933379330341;1025.5795123999274;10279.691609251735;10346.275760696679;10412.167026637851;10536.473176341153;10621.787564248672;482632;492097;492330;493103;498938;105977.47011264894;107166;109725.45137274262;112004.43997779959;112568.43715781369;1162;1167.480471190312;1187.5784096645566;1187.6733898177897;1188.9464974076013;16818.713216558783;16916.915415423337;16939.644828413944;17006.48980530586;17335.566610834325;55652.72173639106;55812.72093639506;56116.43883561112;57220.42779572151;57546;70376.64811675908;70759;71089;71121.28878711353;71320;18873.245070197037;19204;19331.4200573983;19415.70876436883;19428.90285548563;21311.041003155206;21368;21486.892565537073;21621.891890540446;21903.890480547496;17404.73892891633;17481.213345399232;17573.384931527336;17749.29002839872;17837.286508539513;15497.992850152585;15506.302216400514;15866;16233.107179105262;16351.427700030441;17720.734188986917;17727.911360443115;17860.55348616295;18054;18256.634867302313;18802.153903074668;18841.340553080576;18846.811531885054;18855.90572047186;19057.428277151706;17219.22513486871;17230.569235768704;17477.300907964047;17550.12249387551;17563.209655565784 11:51:12 INFO - PID 8674 | |3;mootools.html;1321.9206847589146;1372.9862701372983;1374.0519041861114;1376.064276292121;1378.8690074442925;15534;16186.91906540467;16193.676126477463;16201.594960126004;16213.513594592152;15650.765238521431;15652;15760.527184184493;15782.368705251805;15793.84206157938;2733.4259805440834;2865.1977446315063;2866.125831621355;2868.168231212956;2870.712928707123;2697.784177265824;2765.5989881467176;2781.5271403861393;2791.8743656535503;2793.050362876632;2736.1107640016976;2765.308672831792;2767.1006922750084;2775.111964171456;2777.05580102765;2659.654244948154;2680.11556186458;2694.986525067372;2708.5530887403556;2710.2682275785623;2667.186508115024;2688.2472907585907;2707.6073969274544;2720.279126031603;2774.5838124281318;15211.391544338214;15320;15336.309866056054;15344.846551534454;15358.001729887521;7923.286904178594;8201.343892488587;8203.05664848544;8213.95893020531;8229.506229626182;5268.420473747885;5388.811391601314;5464.180372944051;5508.091164957777;5517.44825517449;2006.067178761868;2024.3965740981077;2039.1231770338748;2045.1512622261891;2067.5451400691823;27516;27643;27746.306342341402;27767.16698499028;27800.860995695093;6813.481805527918;6831.11195544576;6860.348266914635;6919.204291506541;6953.269906659829;17635.470935871945;17635.647287054187;17646.911765441346;17687.91156044237;17707;8094.392920530866;8246.546439945741;8271.627776750061;8275.54484503358;8287.544185069879;7211.495195336381;7432.405407567381;7476.476646634684;7571.280728330799;7617.961910190414;5204.9739751301;5372.704501252469;5396.217548455452;5433.809816656398;5440.836774896759;1418.390092260338;1440.6470414748244;1600.4158482154162;1610.8308627594167;1614;897.4839467306325;906.1844340093836;911.8085202107632;912.808310254854;921.3458444504342;8738;8763.342749293828;8797.560121993874;8889.977652569907;9035.277177825757;951.6098399656246;960.711786464058;976.3751199232497;987.1461186074138;990.6978371596588;4956.157453232959;5422.7017514036315;5446.428125046813;5483.862903427446;5545.639533430314;21488.14047438116;22466.213682521033;22497;22502.774972250067;22546.436339091324;20792.48018799512;21588.028538715796;21733.67399489009;21935.78064219369;22004.669929951062;12012.579559715368;12194.695132621579;12204.32876191818;12208.938955305344;12225.205361651464;8484.448510846774;8511.702090426805;8553;8749.737507874519;8825.779355516164;18904.52738681544;19150;19238.03809809476;19254.903725481283;19685.21259149618;19059.618807623494;19828.70256946118;19881.502962426053;19893.303734369227;19970.60058798845;11160.10719142483;11362.659120226406;11486.138539609396;11489.82765258505;11516.94241528787;14007.579772606838;14068.08557443763;14135.575932722035;14219.075760075562;14223.857761422254;11317.943410282896;11424.714382140513;11744.58893938708;11787.823182652439;11814.704632384259;11320.716982075513;11432.485538150637;11440.71398215018;11545.769084618092;11850.940745296219;10191.694249172537;10493.265471416928;10497.16022718196;10502.68491945243;10513.632022879163;7575.128860180929;7586.089669239726;7631.732889348847;7632.19861914491;7654.15804261542;7320.743773967885;7495.550266983998;7533.472656914183;7542.2834830691;7637.656305466378 11:51:12 INFO - PID 8674 | |4;prototype.html;508.065160105406;533.0990625842326;535.7615860941883;540.2598440137012;544.8910217956409;6312.147860038894;6325.240971083471;6360.745570177193;6385.361463853612;6411.230652321722;6225.937740622592;6239.625622462655;6257.435641089727;6274.56078074535;6311.558190926637;5208.9218661719915;5210.921836172461;5215.765290561933;5229.241759944805;5264.657797243167;4898.608111351101;5061.16490779021;5150.871228219287;5185.792568297264;5224;4989.57588604969;5027.748612569375;5028.899422011576;5043.949560504385;5058.114829904752;4981.7582088060335;4998.600111991032;5007.198848184291;5051.873703157414;5052.8484145475695;4471.2398892188085;4513.7066090704;4533.818647254106;4534.909301813946;4561.156186105548;6126.203593532812;6175.795719834634;6188.47397971173;6192.535559832985;6259.342769009279;5788.450097240755;5810.506106980912;5821.417858214187;5849.327327357366;5856.092305692625;6612;6612.669366531654;6614.86770264592;6644.235912870034;6678.532502724811;5005.324281222025;5005.399352077738;5006.69959802413;5019.447860735316;5019.694879331364;6680.7661731839635;6732.865342693168;6891.586504809728;6932.757353492654;6959.478039147034;5023.447420783711;5028.949710502921;5041.193409054534;5044.621653376012;5123.846284611468;5089.185730283137;5102;5132.435432102466;5200.323957885451;5212.244224587414;5773.538116950634;5774.538036957118;5787.8553036174435;5815.156802263733;5815.244018277597;6643.169603799525;6660.6336651484635;6736.326367363225;6745.865082698417;6747.190337159573;1794.228481752859;1800.820462597001;1815.7730283714536;1817.1822679794145;1821.3807305516189;1186.2467333243453;1223.2721530689403;1224.2776761710634;1236.993815030919;1262.3435813377175;5663.575231857627;5700.82897513067;5744.569157313218;5779.306483222041;5813.59304848665;6731.932680673229;6735.797926062226;6743.583847392103;6796.150481189851;6831.965840170867;5707.145177817143;5745.1669507921115;5751.683657398883;5754.251947246915;5782.942170578324;3511.9297614047578;3551.6448355164275;3563.467708885204;3614.8192590370377;3629.364861149288;6128.17269668598;6436.292007879129;6553;6558.639274839834;6562.442192413603;6691.431228345645;6800.965995169992;6887.896681549781;6903.1716194057035;6911.92196604006;6319.314291426217;6397.52018598607;6451.870962580816;6467.547271690936;6475.384838440341;6647.567908085959;6697.732090716317;6807.5575087619145;6818.897716534157;6824;6730.259671436236;6762.628734679027;6770.661466926733;6780.38976492118;6817.522773405814;6378.958733205515;6407;6459.773907913201;6491.772787952399;6589.17635295588;5072.721000345016;5089.465606111453;5093.159628661378;5099.311592934906;5134.383873935151;6372.840678983062;6605.471562275103;6629.933700662931;6706.396424321834;6791.151106111736;6525.3800888915475;6568.901466477911;6569.146011018537;6572.605643661395;6583.572067815577;6393.424591786761;6420.2937676856445;6449.580777249464;6571.178602674666;6620.06106366711;6231.719572619152;6478.708458119301;6509.349065093453;6509.837254068686;6537.986612075136;6435.81182397987;6584.637844918576;6659.600423974577;6681.29846366144;6688.933110669026;6271.43557079865;6276.717547710273;6293.40212679813;6360.236771587254;6381.564148066648 11:51:12 INFO - PID 8674 | |5;yui.html;906.4742449379361;925.453982150531;940.2524992630857;940.2900809888533;941.2234906202381;19205.42383728487;20066.49833754157;20070.89964550177;20100.396988090364;22760.88619556904;21941.561168776614;21965.780342196573;22070.33788986329;22136.225232116878;22331.888340558315;973.956171972263;981.5975450065474;983.6360546597768;983.7098056073439;985.1576901748973;928.9210417114554;972.7227740094074;978.838491648877;979.7844474215697;987.9555420006117;1034.8085604163216;1035.1201478743083;1035.6841163445147;1036.1710631494775;1038.9584416623327;1017.9643712470103;1019.9541020654088;1026.491886516172;1026.630413051301;1029.8815636201857;752.947293689442;755.0599503618031;757.6666266842627;759.3052357093253;760.3764912771529;20294.594108117904;20686.965651717503;20753.066112024993;20873.269435569833;20873.373798786062;21876.781232187794;22033;22660.320190394315;22674;22681.2061577844;17462.825371746247;17629.55926101845;17650.558736031573;17652.205650745746;17652.646947060988;3569.5894972078286;3646.7994260315672;3709.888703338904;3734.73856830022;3736.4582135590185;141259.29370353185;141789;145236.27381863235;145421;147248;16860.91569542169;16970.490885273462;17155.970641761534;17172.141392930305;17505.824941750674;31133;32013.359732805213;32033;32083;32150.678493214768;8451.873221901553;8582.055973842873;8592;8594.957025214959;8602.225799678059;4127.442795222667;4156.314208155621;4157.625813676784;4167.229062623424;4185.97907010463;5043.445221025684;5281.313429254173;6114.510839132948;6226.377362263828;6322.178116844872;1210.6731182580654;1213.769383817072;1244.0793812578627;1249.2504497301547;1251.455616806692;682.0962225051826;702.6170736948376;709.8793205155137;714.9821254468576;723.6996646391793;11841.763164736656;11895.226810257478;12376;12704.618861434172;13120.475180992653;686.9587824730432;689.2934741889503;700.1283402164338;700.7232143303366;707.7947395255318;5781.71091445426;5786.537077033827;5815.621984570989;5861.853453663693;5882.764689412461;122343;122532;124010;125985.37007315089;126479;109870;109941;111174;115487;116337.41831290789;95684;95708;96740;96746.51626741962;99938;10567.313124646873;10660;10735.785284294427;10918.56325746993;10951.83572246401;44231.33652995272;45358.880323328565;45840.31239531343;46702.766486167355;47337.28994065161;57545;57614.423855760906;58274.4172558269;58406;59762.40237597568;15044.097354158786;15350.462733804263;15446.922765386551;15462.690746185239;15615.219239037775;17403.303867845145;17470.30118795234;17644.294228230727;17650;17907.641847162722;15580.143092130042;15829.604259893595;15880.682386352439;15978.60053498672;15993.760093598838;15695.764563531784;15875.603109922344;15913.840861591236;16034.278457469209;16053.438129665406;15515.922420387826;15630.687386251984;15768.60578485547;15888.285027174035;15927;11341.432928353714;11352.205345626056;11456.140789440658;11528.884711152781;11531.654050378502;11960.282383057045;11964.46159922823;11967.581134660246;12068.456919438471;12201.755964880831 11:51:12 INFO - PID 8674 | __end_tp_report 11:51:12 INFO - PID 8674 | __start_cc_report 11:51:12 INFO - PID 8674 | _x_x_mozilla_cycle_collect,321 11:51:12 INFO - PID 8674 | __end_cc_report 11:51:12 INFO - PID 8674 | __startTimestamp1506451872678__endTimestamp 11:51:12 INFO - PID 8674 | 11:51:12 INFO - PID 8674 | ------- Summary: start ------- 11:51:12 INFO - PID 8674 | Number of tests: 6 11:51:12 INFO - PID 8674 | 11:51:12 INFO - PID 8674 | [#0] dojo.html Cycles:165 Average:6221.46 Median:6524.90 stddev:848.18 (13.0%) stddev-sans-first:814.80 11:51:12 INFO - PID 8674 | Values: 3105.6 3132.6 3153.9 3164.5 3176.2 6210.0 6340.2 6383.1 6409.9 6492.2 6270.7 6308.2 6411.2 6435.8 6453.5 1313.6 5867.1 5893.1 5915.8 5938.5 5769.8 5785.4 5814.3 5906.1 5931.3 5819.5 5840.6 5874.0 5892.2 5903.0 5794.1 5813.0 5875.3 5877.6 5900.4 5779.9 5814.6 5874.3 5887.7 5897.2 6315.5 6347.0 6361.9 6413.5 6429.0 6562.4 6617.5 6717.1 6737.9 6740.5 6802.4 6809.8 6812.9 6817.7 6825.3 6129.3 6212.1 6329.4 6396.0 6397.2 6998.2 7077.3 7086.0 7114.3 7125.7 6606.4 6606.5 6667.2 6701.8 6726.8 6654.9 6705.6 6735.9 6811.7 6846.9 6678.4 6682.8 6689.9 6697.0 6702.0 6760.8 6815.8 6818.1 6828.8 6885.5 5252.7 5265.5 5296.5 5335.2 5335.9 4568.4 4606.7 4620.0 4647.2 4658.8 5698.2 5809.4 5824.2 5897.3 5898.6 6835.4 6888.1 6897.4 6910.4 6918.7 5806.5 5864.0 5880.4 5885.4 5891.6 5835.4 5852.7 5924.1 5927.2 5936.2 6409.6 6511.8 6590.0 6601.3 6683.3 6707.9 6846.8 6863.5 6880.5 6887.4 6556.3 6560.8 6615.3 6663.4 6666.7 6673.5 6712.3 6772.1 6776.1 6795.3 6645.4 6715.2 6766.1 6829.7 6925.6 6517.9 6524.9 6548.8 6558.5 6666.8 6554.5 6620.0 6692.8 6703.5 6715.8 6508.3 6522.7 6525.2 6605.8 6611.8 6448.0 6601.0 6653.6 6715.0 6736.0 6488.7 6535.3 6538.8 6549.5 6549.7 11:51:12 INFO - PID 8674 | 11:51:12 INFO - PID 8674 | [#1] ext.html Cycles:180 Average:37251.34 Median:3514.72 stddev:52815.02 (1502.7%) stddev-sans-first:52892.40 11:51:12 INFO - PID 8674 | Values: 836.7 886.6 908.1 909.7 912.9 39425.8 40180.6 40376.2 40513.0 40569.4 36817.6 37173.3 37321.3 37363.8 37416.0 7192.6 7290.1 7334.2 7334.3 7347.3 7215.5 7323.5 7326.4 7327.4 7331.9 7290.9 7299.6 7331.0 7332.3 7334.9 7733.5 7978.8 7980.2 7985.4 7993.9 7874.7 7956.8 7957.0 7965.1 7965.3 36367.5 37567.4 38064.2 38220.8 38263.8 3506.7 3522.8 3533.7 3579.5 3579.6 30562.8 30725.8 30971.0 30982.8 31073.7 5112.3 5157.4 5167.5 5192.8 5272.4 188266.0 192433.0 193864.0 194028.0 194094.0 47948.5 47949.3 47991.0 48072.0 48103.0 50015.0 50096.5 50294.5 50487.7 50666.2 15704.9 16005.6 16054.6 16062.8 16092.0 13009.8 13050.7 13078.3 13083.3 13103.0 14304.5 14351.3 14355.9 14520.3 14534.4 5861.8 5895.5 5902.9 5910.9 5965.9 1004.5 1005.5 1016.4 1024.8 1029.2 22773.8 22811.0 22918.9 22942.8 23103.3 1120.8 1129.6 1131.7 1136.2 1138.5 12256.6 12296.3 12343.9 12352.8 12399.8 216502.0 218334.0 218593.0 218994.0 219321.0 51639.7 51762.5 52090.2 56139.4 56794.4 1440.6 1445.6 1447.0 1459.8 1465.3 26625.0 27313.0 27455.9 27582.3 27685.3 38582.0 38964.2 39024.8 39044.0 39048.4 199345.0 200443.0 201149.0 201157.0 201304.0 32552.5 33955.5 33961.7 33983.3 34026.1 42833.6 43232.0 43381.0 43478.1 44187.0 31165.0 31539.0 31545.4 31706.8 32204.0 30540.8 30894.5 31208.0 31429.5 31431.0 35492.8 35577.8 35760.5 35857.0 35964.5 30521.5 30562.4 30593.7 30830.8 30842.4 22983.7 23143.4 23404.7 23423.1 23745.1 11:51:12 INFO - PID 8674 | 11:51:12 INFO - PID 8674 | [#2] jquery.html Cycles:180 Average:35374.80 Median:21339.52 stddev:82464.31 (386.4%) stddev-sans-first:82654.25 11:51:12 INFO - PID 8674 | Values: 575.3 583.3 597.4 600.4 624.1 21494.5 22245.4 22286.7 22328.1 22409.3 21963.5 23405.4 23650.3 23788.8 23802.0 6678.0 6709.4 6746.1 6747.1 6760.4 6665.3 6757.4 6795.8 7106.9 7109.8 7105.9 7107.4 7108.5 7111.3 7112.8 7088.8 7099.9 7115.5 7123.3 7143.4 6664.2 6969.4 6985.4 6989.0 7009.2 29126.0 29623.0 29658.4 29669.6 29733.0 2056.2 2067.5 2078.2 2090.6 2090.8 19559.0 19890.2 20331.5 20695.9 20895.4 2466.2 2505.7 2541.5 2542.3 2569.3 120714.0 127251.4 136516.3 141075.3 147487.0 20079.0 20136.9 20245.0 21088.8 21148.6 40490.2 41284.2 41291.6 41348.6 41648.6 10996.8 11109.1 11194.3 11258.2 11287.4 9128.2 9154.0 9173.5 9186.6 9246.5 10696.0 10948.6 10977.6 11156.5 11188.8 4206.9 4239.8 4241.4 4259.6 4395.6 939.9 975.4 977.2 980.6 986.6 18056.9 18226.6 18530.5 18581.3 18728.9 1007.3 1020.3 1023.3 1024.9 1025.6 10279.7 10346.3 10412.2 10536.5 10621.8 482632.0 492097.0 492330.0 493103.0 498938.0 105977.5 107166.0 109725.5 112004.4 112568.4 1162.0 1167.5 1187.6 1187.7 1188.9 16818.7 16916.9 16939.6 17006.5 17335.6 55652.7 55812.7 56116.4 57220.4 57546.0 70376.6 70759.0 71089.0 71121.3 71320.0 18873.2 19204.0 19331.4 19415.7 19428.9 21311.0 21368.0 21486.9 21621.9 21903.9 17404.7 17481.2 17573.4 17749.3 17837.3 15498.0 15506.3 15866.0 16233.1 16351.4 17720.7 17727.9 17860.6 18054.0 18256.6 18802.2 18841.3 18846.8 18855.9 19057.4 17219.2 17230.6 17477.3 17550.1 17563.2 11:51:12 INFO - PID 8674 | 11:51:12 INFO - PID 8674 | [#3] mootools.html Cycles:180 Average:9630.87 Median:2702.70 stddev:6888.07 (254.9%) stddev-sans-first:6879.10 11:51:12 INFO - PID 8674 | Values: 1321.9 1373.0 1374.1 1376.1 1378.9 15534.0 16186.9 16193.7 16201.6 16213.5 15650.8 15652.0 15760.5 15782.4 15793.8 2733.4 2865.2 2866.1 2868.2 2870.7 2697.8 2765.6 2781.5 2791.9 2793.1 2736.1 2765.3 2767.1 2775.1 2777.1 2659.7 2680.1 2695.0 2708.6 2710.3 2667.2 2688.2 2707.6 2720.3 2774.6 15211.4 15320.0 15336.3 15344.8 15358.0 7923.3 8201.3 8203.1 8214.0 8229.5 5268.4 5388.8 5464.2 5508.1 5517.4 2006.1 2024.4 2039.1 2045.2 2067.5 27516.0 27643.0 27746.3 27767.2 27800.9 6813.5 6831.1 6860.3 6919.2 6953.3 17635.5 17635.6 17646.9 17687.9 17707.0 8094.4 8246.5 8271.6 8275.5 8287.5 7211.5 7432.4 7476.5 7571.3 7618.0 5205.0 5372.7 5396.2 5433.8 5440.8 1418.4 1440.6 1600.4 1610.8 1614.0 897.5 906.2 911.8 912.8 921.3 8738.0 8763.3 8797.6 8890.0 9035.3 951.6 960.7 976.4 987.1 990.7 4956.2 5422.7 5446.4 5483.9 5545.6 21488.1 22466.2 22497.0 22502.8 22546.4 20792.5 21588.0 21733.7 21935.8 22004.7 12012.6 12194.7 12204.3 12208.9 12225.2 8484.4 8511.7 8553.0 8749.7 8825.8 18904.5 19150.0 19238.0 19254.9 19685.2 19059.6 19828.7 19881.5 19893.3 19970.6 11160.1 11362.7 11486.1 11489.8 11516.9 14007.6 14068.1 14135.6 14219.1 14223.9 11317.9 11424.7 11744.6 11787.8 11814.7 11320.7 11432.5 11440.7 11545.8 11850.9 10191.7 10493.3 10497.2 10502.7 10513.6 7575.1 7586.1 7631.7 7632.2 7654.2 7320.7 7495.6 7533.5 7542.3 7637.7 11:51:12 INFO - PID 8674 | 11:51:12 INFO - PID 8674 | [#4] prototype.html Cycles:180 Average:5554.94 Median:6228.83 stddev:1538.80 (24.7%) stddev-sans-first:1495.76 11:51:12 INFO - PID 8674 | Values: 508.1 533.1 535.8 540.3 544.9 6312.1 6325.2 6360.7 6385.4 6411.2 6225.9 6239.6 6257.4 6274.6 6311.6 5208.9 5210.9 5215.8 5229.2 5264.7 4898.6 5061.2 5150.9 5185.8 5224.0 4989.6 5027.7 5028.9 5043.9 5058.1 4981.8 4998.6 5007.2 5051.9 5052.8 4471.2 4513.7 4533.8 4534.9 4561.2 6126.2 6175.8 6188.5 6192.5 6259.3 5788.5 5810.5 5821.4 5849.3 5856.1 6612.0 6612.7 6614.9 6644.2 6678.5 5005.3 5005.4 5006.7 5019.4 5019.7 6680.8 6732.9 6891.6 6932.8 6959.5 5023.4 5028.9 5041.2 5044.6 5123.8 5089.2 5102.0 5132.4 5200.3 5212.2 5773.5 5774.5 5787.9 5815.2 5815.2 6643.2 6660.6 6736.3 6745.9 6747.2 1794.2 1800.8 1815.8 1817.2 1821.4 1186.2 1223.3 1224.3 1237.0 1262.3 5663.6 5700.8 5744.6 5779.3 5813.6 6731.9 6735.8 6743.6 6796.2 6832.0 5707.1 5745.2 5751.7 5754.3 5782.9 3511.9 3551.6 3563.5 3614.8 3629.4 6128.2 6436.3 6553.0 6558.6 6562.4 6691.4 6801.0 6887.9 6903.2 6911.9 6319.3 6397.5 6451.9 6467.5 6475.4 6647.6 6697.7 6807.6 6818.9 6824.0 6730.3 6762.6 6770.7 6780.4 6817.5 6379.0 6407.0 6459.8 6491.8 6589.2 5072.7 5089.5 5093.2 5099.3 5134.4 6372.8 6605.5 6629.9 6706.4 6791.2 6525.4 6568.9 6569.1 6572.6 6583.6 6393.4 6420.3 6449.6 6571.2 6620.1 6231.7 6478.7 6509.3 6509.8 6538.0 6435.8 6584.6 6659.6 6681.3 6688.9 6271.4 6276.7 6293.4 6360.2 6381.6 11:51:12 INFO - PID 8674 | 11:51:12 INFO - PID 8674 | [#5] yui.html Cycles:180 Average:24942.81 Median:20720.02 stddev:36201.91 (174.7%) stddev-sans-first:36258.48 11:51:12 INFO - PID 8674 | Values: 906.5 925.5 940.3 940.3 941.2 19205.4 20066.5 20070.9 20100.4 22760.9 21941.6 21965.8 22070.3 22136.2 22331.9 974.0 981.6 983.6 983.7 985.2 928.9 972.7 978.8 979.8 988.0 1034.8 1035.1 1035.7 1036.2 1039.0 1018.0 1020.0 1026.5 1026.6 1029.9 752.9 755.1 757.7 759.3 760.4 20294.6 20687.0 20753.1 20873.3 20873.4 21876.8 22033.0 22660.3 22674.0 22681.2 17462.8 17629.6 17650.6 17652.2 17652.6 3569.6 3646.8 3709.9 3734.7 3736.5 141259.3 141789.0 145236.3 145421.0 147248.0 16860.9 16970.5 17156.0 17172.1 17505.8 31133.0 32013.4 32033.0 32083.0 32150.7 8451.9 8582.1 8592.0 8595.0 8602.2 4127.4 4156.3 4157.6 4167.2 4186.0 5043.4 5281.3 6114.5 6226.4 6322.2 1210.7 1213.8 1244.1 1249.3 1251.5 682.1 702.6 709.9 715.0 723.7 11841.8 11895.2 12376.0 12704.6 13120.5 687.0 689.3 700.1 700.7 707.8 5781.7 5786.5 5815.6 5861.9 5882.8 122343.0 122532.0 124010.0 125985.4 126479.0 109870.0 109941.0 111174.0 115487.0 116337.4 95684.0 95708.0 96740.0 96746.5 99938.0 10567.3 10660.0 10735.8 10918.6 10951.8 44231.3 45358.9 45840.3 46702.8 47337.3 57545.0 57614.4 58274.4 58406.0 59762.4 15044.1 15350.5 15446.9 15462.7 15615.2 17403.3 17470.3 17644.3 17650.0 17907.6 15580.1 15829.6 15880.7 15978.6 15993.8 15695.8 15875.6 15913.8 16034.3 16053.4 15515.9 15630.7 15768.6 15888.3 15927.0 11341.4 11352.2 11456.1 11528.9 11531.7 11960.3 11964.5 11967.6 12068.5 12201.8 11:51:12 INFO - PID 8674 | -------- Summary: end -------- 11:51:12 INFO - PID 8674 | 11:51:13 INFO - TEST-INFO | 8674: exit 0 11:51:13 INFO - TEST-OK | dromaeo_css | took 1109335ms 11:51:13 INFO - TEST-START | kraken 11:51:13 INFO - Initialising browser for kraken test... 11:51:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33725/getInfo.html -profile /tmp/tmpw0CIpo/profile 11:51:13 INFO - TEST-INFO | started process 9046 (/builds/slave/test/build/application/firefox/firefox http://localhost:33725/getInfo.html) 11:51:18 INFO - TEST-INFO | 9046: exit 0 11:51:18 INFO - Browser initialized. 11:51:18 INFO - Running cycle 1/1 for kraken test... 11:51:18 INFO - Using env: {'DISPLAY': ':0', 11:51:18 INFO - 'HOME': '/home/cltbld', 11:51:18 INFO - 'JSGC_DISABLE_POISONING': '1', 11:51:18 INFO - 'LANG': 'en_US.UTF-8', 11:51:18 INFO - 'LANGUAGE': 'en_US:en', 11:51:18 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:51:18 INFO - 'LOGNAME': 'cltbld', 11:51:18 INFO - 'MAIL': '/var/mail/cltbld', 11:51:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:51:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:51:18 INFO - 'MOZ_CRASHREPORTER': '1', 11:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:18 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:51:18 INFO - 'MOZ_NO_REMOTE': '1', 11:51:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:18 INFO - 'NO_EM_RESTART': '1', 11:51:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:18 INFO - 'PWD': '/builds/slave/test', 11:51:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:51:18 INFO - 'RUST_BACKTRACE': 'full', 11:51:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:51:18 INFO - 'SHELL': '/bin/bash', 11:51:18 INFO - 'SHLVL': '1', 11:51:18 INFO - 'TERM': 'linux', 11:51:18 INFO - 'TMOUT': '86400', 11:51:18 INFO - 'USER': 'cltbld', 11:51:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556', 11:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:18 INFO - '_': '/tools/buildbot/bin/python'} 11:51:18 INFO - TEST-INFO | started process 9280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw0CIpo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:19 INFO - PID 9280 | 11:51:19 INFO - PID 9280 | (/builds/slave/test/build/application/firefox/firefox:9329): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:51:19 INFO - PID 9280 | 11:51:29 INFO - PID 9280 | RSS: Main: 153214976 11:51:29 INFO - PID 9280 | 11:51:32 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33725/tests/kraken/driver.html?testName=audio-beat-detection) 11:51:33 INFO - PID 9280 | RSS: Main: 159232000 11:51:33 INFO - PID 9280 | 11:51:36 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33725/tests/kraken/driver.html?testName=audio-dft) 11:51:36 INFO - PID 9280 | RSS: Main: 159203328 11:51:36 INFO - PID 9280 | 11:51:39 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33725/tests/kraken/driver.html?testName=audio-fft) 11:51:40 INFO - PID 9280 | RSS: Main: 156311552 11:51:40 INFO - PID 9280 | 11:51:42 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33725/tests/kraken/driver.html?testName=audio-oscillator) 11:51:42 INFO - PID 9280 | RSS: Main: 156389376 11:51:42 INFO - PID 9280 | 11:51:45 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33725/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:51:45 INFO - PID 9280 | RSS: Main: 156807168 11:51:45 INFO - PID 9280 | 11:51:48 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33725/tests/kraken/driver.html?testName=imaging-darkroom) 11:51:49 INFO - PID 9280 | RSS: Main: 159047680 11:51:49 INFO - PID 9280 | 11:51:53 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33725/tests/kraken/driver.html?testName=imaging-desaturate) 11:51:53 INFO - PID 9280 | RSS: Main: 159543296 11:51:53 INFO - PID 9280 | 11:51:56 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33725/tests/kraken/driver.html?testName=json-parse-financial) 11:51:57 INFO - PID 9280 | RSS: Main: 159866880 11:51:57 INFO - PID 9280 | 11:51:58 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33725/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:51:59 INFO - PID 9280 | RSS: Main: 159752192 11:51:59 INFO - PID 9280 | 11:52:01 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33725/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:52:01 INFO - PID 9280 | RSS: Main: 159883264 11:52:01 INFO - PID 9280 | 11:52:03 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33725/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:52:04 INFO - PID 9280 | RSS: Main: 156651520 11:52:04 INFO - PID 9280 | 11:52:07 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33725/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:52:07 INFO - PID 9280 | RSS: Main: 157085696 11:52:07 INFO - PID 9280 | 11:52:10 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33725/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:52:11 INFO - PID 9280 | RSS: Main: 157167616 11:52:11 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:33725/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33725/tests/kraken/driver.html?testName=ai-astar) 11:52:13 INFO - PID 9280 | RSS: Main: 158146560 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | __start_tp_report 11:52:13 INFO - PID 9280 | _x_x_mozilla_page_load 11:52:13 INFO - PID 9280 | _x_x_mozilla_page_load_details 11:52:13 INFO - PID 9280 | |i|pagename|runs| 11:52:13 INFO - PID 9280 | |0;ai-astar;107;106;106;109;110;111;109;109;109;107 11:52:13 INFO - PID 9280 | |1;audio-beat-detection;117;120;118;115;129;120;146;124;120;117 11:52:13 INFO - PID 9280 | |2;audio-dft;162;161;161;165;165;167;163;166;175;165 11:52:13 INFO - PID 9280 | |3;audio-fft;74;73;76;78;79;78;74;76;74;75 11:52:13 INFO - PID 9280 | |4;audio-oscillator;80;80;79;79;78;79;79;79;80;81 11:52:13 INFO - PID 9280 | |5;imaging-gaussian-blur;114;115;114;110;109;114;114;114;115;115 11:52:13 INFO - PID 9280 | |6;imaging-darkroom;156;148;149;151;148;149;147;150;148;148 11:52:13 INFO - PID 9280 | |7;imaging-desaturate;99;94;94;94;94;94;94;94;96;95 11:52:13 INFO - PID 9280 | |8;json-parse-financial;54;57;57;53;57;54;55;55;54;54 11:52:13 INFO - PID 9280 | |9;json-stringify-tinderbox;39;40;38;39;38;38;39;39;39;39 11:52:13 INFO - PID 9280 | |10;stanford-crypto-aes;78;71;74;74;76;78;74;75;72;75 11:52:13 INFO - PID 9280 | |11;stanford-crypto-ccm;111;112;112;113;114;113;119;112;119;119 11:52:13 INFO - PID 9280 | |12;stanford-crypto-pbkdf2;177;171;175;171;166;182;176;168;171;169 11:52:13 INFO - PID 9280 | |13;stanford-crypto-sha256-iterative;68;64;64;66;66;70;68;72;65;66 11:52:13 INFO - PID 9280 | __end_tp_report 11:52:13 INFO - PID 9280 | __start_cc_report 11:52:13 INFO - PID 9280 | _x_x_mozilla_cycle_collect,738 11:52:13 INFO - PID 9280 | __end_cc_report 11:52:13 INFO - PID 9280 | __startTimestamp1506451933487__endTimestamp 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | ------- Summary: start ------- 11:52:13 INFO - PID 9280 | Number of tests: 14 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:1.70 (1.6%) stddev-sans-first:1.74 11:52:13 INFO - PID 9280 | Values: 107.0 106.0 106.0 109.0 110.0 111.0 109.0 109.0 109.0 107.0 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#1] audio-beat-detection Cycles:10 Average:122.60 Median:120.00 stddev:9.14 (7.6%) stddev-sans-first:9.47 11:52:13 INFO - PID 9280 | Values: 117.0 120.0 118.0 115.0 129.0 120.0 146.0 124.0 120.0 117.0 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:4.08 (2.5%) stddev-sans-first:4.18 11:52:13 INFO - PID 9280 | Values: 162.0 161.0 161.0 165.0 165.0 167.0 163.0 166.0 175.0 165.0 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#3] audio-fft Cycles:10 Average:75.70 Median:76.00 stddev:2.06 (2.7%) stddev-sans-first:2.09 11:52:13 INFO - PID 9280 | Values: 74.0 73.0 76.0 78.0 79.0 78.0 74.0 76.0 74.0 75.0 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:79.50 stddev:0.84 (1.1%) stddev-sans-first:0.87 11:52:13 INFO - PID 9280 | Values: 80.0 80.0 79.0 79.0 78.0 79.0 79.0 79.0 80.0 81.0 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:114.00 stddev:2.12 (1.9%) stddev-sans-first:2.24 11:52:13 INFO - PID 9280 | Values: 114.0 115.0 114.0 110.0 109.0 114.0 114.0 114.0 115.0 115.0 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.00 stddev:2.59 (1.7%) stddev-sans-first:1.22 11:52:13 INFO - PID 9280 | Values: 156.0 148.0 149.0 151.0 148.0 149.0 147.0 150.0 148.0 148.0 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:1.62 (1.7%) stddev-sans-first:0.71 11:52:13 INFO - PID 9280 | Values: 99.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 96.0 95.0 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.49 (2.7%) stddev-sans-first:1.54 11:52:13 INFO - PID 9280 | Values: 54.0 57.0 57.0 53.0 57.0 54.0 55.0 55.0 54.0 54.0 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#9] json-stringify-tinderbox Cycles:10 Average:38.80 Median:39.00 stddev:0.63 (1.6%) stddev-sans-first:0.67 11:52:13 INFO - PID 9280 | Values: 39.0 40.0 38.0 39.0 38.0 38.0 39.0 39.0 39.0 39.0 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:75.00 stddev:2.26 (3.0%) stddev-sans-first:2.06 11:52:13 INFO - PID 9280 | Values: 78.0 71.0 74.0 74.0 76.0 78.0 74.0 75.0 72.0 75.0 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#11] stanford-crypto-ccm Cycles:10 Average:114.40 Median:113.50 stddev:3.27 (2.9%) stddev-sans-first:3.23 11:52:13 INFO - PID 9280 | Values: 111.0 112.0 112.0 113.0 114.0 113.0 119.0 112.0 119.0 119.0 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:173.00 stddev:4.84 (2.8%) stddev-sans-first:4.86 11:52:13 INFO - PID 9280 | Values: 177.0 171.0 175.0 171.0 166.0 182.0 176.0 168.0 171.0 169.0 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:2.60 (3.9%) stddev-sans-first:2.73 11:52:13 INFO - PID 9280 | Values: 68.0 64.0 64.0 66.0 66.0 70.0 68.0 72.0 65.0 66.0 11:52:13 INFO - PID 9280 | -------- Summary: end -------- 11:52:13 INFO - PID 9280 | 11:52:13 INFO - PID 9280 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:52:14 INFO - TEST-INFO | 9280: exit 0 11:52:14 INFO - TEST-OK | kraken | took 60783ms 11:52:14 INFO - SUITE-END | took 1170s 11:52:14 INFO - Completed test suite (00:19:30) 11:52:14 INFO - javascript benchmark 11:52:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8681.287611700798, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.6428510721266, 3132.608423947006, 3153.8580763865625, 3164.5095010273385, 3176.1741947093747, 6210.0, 6340.207474065742, 6383.1063651088825, 6409.935900640992, 6492.15601971743, 6270.749170033205, 6308.243010838706, 6411.1986001749665, 6435.806925792233, 6453.515986301035, 1313.6344487173428, 5867.119932010211, 5893.057110862263, 5915.822525324247, 5938.4952279056115, 5769.769209231626, 5785.421457854202, 5814.302283725959, 5906.084556893688, 5931.347551769302, 5819.534437245032, 5840.561957853178, 5874.0, 5892.175095486636, 5903.026000709878, 5794.101914203306, 5813.0, 5875.294964604275, 5877.617954832922, 5900.409959004065, 5779.87292477967, 5814.622049566807, 5874.295084589877, 5887.70561471929, 5897.233359663259, 6315.463185629227, 6346.9682651586445, 6361.9045714314325, 6413.486921046305, 6429.0, 6562.376574225441, 6617.50368722343, 6717.093192419059, 6737.898931516032, 6740.494462915252, 6802.4217941475035, 6809.795706128824, 6812.863742725167, 6817.659117044128, 6825.283345248727, 6129.264488261437, 6212.068189771525, 6329.398707122816, 6396.040593910904, 6397.168368112116, 6998.195207551095, 7077.327653872874, 7085.96457017722, 7114.288571142844, 7125.714971401086, 6606.438452731475, 6606.537542372084, 6667.166604174478, 6701.765438209639, 6726.764563240263, 6654.900176497356, 6705.564138330993, 6735.932640673531, 6811.659417029228, 6846.931530684729, 6678.432333251728, 6682.83292917681, 6689.866202675919, 6696.961970894519, 6702.0282059101155, 6760.763373281911, 6815.829604259933, 6818.079559259437, 6828.795136145924, 6885.483588730865, 5252.65857719247, 5265.4997775211295, 5296.523312901857, 5335.199720042025, 5335.919961200585, 4568.383268258809, 4606.700564463299, 4619.976900115478, 4647.16351056813, 4658.813647454064, 5698.230738850202, 5809.390014048548, 5824.184614154022, 5897.292324921037, 5898.64608123514, 6835.384815366541, 6888.138982627172, 6897.41371983387, 6910.378065974087, 6918.654067296716, 5806.506446951972, 5864.03243464832, 5880.382559831241, 5885.411458854166, 5891.587588868823, 5835.35811060783, 5852.7030168725105, 5924.140999555127, 5927.229460170151, 5936.22829032223, 6409.583377080475, 6511.804645860631, 6590.044443555657, 6601.3068627794355, 6683.331666833375, 6707.8993815091835, 6846.760363387258, 6863.519553631198, 6880.518363714492, 6887.449004079562, 6556.311587283267, 6560.803175904731, 6615.338466153346, 6663.400293973566, 6666.699998500176, 6673.466122710074, 6712.295209002984, 6772.0857684212, 6776.119104516381, 6795.25252222265, 6645.368689974444, 6715.1941766988275, 6766.120404347404, 6829.658517074027, 6925.58446493212, 6517.9348206517325, 6524.902126468011, 6548.8362790930605, 6558.540902136995, 6666.799996000128, 6554.541182117206, 6620.0, 6692.76575319881, 6703.530752847254, 6715.764948226789, 6508.284088750328, 6522.739090436329, 6525.184351956005, 6605.768798092044, 6611.834704132243, 6448.0, 6600.966995164993, 6653.600783952978, 6715.0263211833035, 6736.0, 6488.675566221765, 6535.2811190768025, 6538.803835884931, 6549.4760419165395, 6549.7380104795275], "value": 6158.912202717752, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [836.7489753074076, 886.6409104312753, 908.1327332397559, 909.6997990663077, 912.8904531456226, 39425.802870985644, 40180.59819401805, 40376.1924761505, 40513.0, 40569.39145912806, 36817.63182368175, 37173.25653486929, 37321.25357492849, 37363.813180934056, 37416.0, 7192.640367981606, 7290.088738907637, 7334.193238743734, 7334.339909408152, 7347.2652734726635, 7215.494915355927, 7323.48735588509, 7326.377257933082, 7327.377172940306, 7331.8533629327385, 7290.890636640454, 7299.562026278414, 7330.963345183267, 7332.30343117403, 7334.889976650355, 7733.45865789395, 7978.800529986796, 7980.201979802031, 7985.441019128663, 7993.880091798627, 7874.72438464651, 7956.761297161094, 7957.005374328209, 7965.123836377994, 7965.322947549465, 36367.454488182695, 37567.436488452695, 38064.23871522554, 38220.80889595562, 38263.808680956696, 3506.6668666476644, 3522.771019883725, 3533.717302615785, 3579.46308053794, 3579.6420357964257, 30562.84718576393, 30725.846370768228, 30971.0, 30982.845085774654, 31073.68926310753, 5112.335396398482, 5157.381114266312, 5167.457416971201, 5192.766325515323, 5272.393674727417, 188266.0, 192433.0, 193864.0, 194028.0, 194094.0, 47948.52051479441, 47949.28076078861, 47991.0, 48072.0, 48103.0, 50015.0, 50096.49903500918, 50294.497055029715, 50487.74756126196, 50666.24000639993, 15704.921475392779, 16005.599860003593, 16054.598635033984, 16062.75905861413, 16092.0, 13009.804852927213, 13050.673733156556, 13078.346082695827, 13083.345832708517, 13103.01727370432, 14304.499342522962, 14351.282435878164, 14355.85644143566, 14520.273986300643, 14534.418623255162, 5861.824145275648, 5895.498882595028, 5902.911456328158, 5910.881782364415, 5965.850853728604, 1004.4977511244377, 1005.5475036233724, 1016.4003238089563, 1024.7950409918046, 1029.1663752360612, 22773.772262277496, 22810.973506192262, 22918.885405573197, 22942.770572294397, 23103.306900793003, 1120.8038593246313, 1129.5989923577013, 1131.666158483233, 1136.1762722026465, 1138.4990604134155, 12256.571020014257, 12296.323702196287, 12343.876561234272, 12352.814707779391, 12399.814002789966, 216502.0, 218334.0, 218593.0, 218994.0, 219321.0, 51639.74180129075, 51762.48237517652, 52090.21864672033, 56139.438605613424, 56794.43205567974, 1440.6182361673955, 1445.638590352412, 1446.978295325592, 1459.7518421868308, 1465.2966576043345, 26625.003124766106, 27313.044043458383, 27455.86272068627, 27582.3104422383, 27685.307867302672, 38582.0, 38964.220715586096, 39024.80487597544, 39044.0, 39048.41427378535, 199345.0, 200443.0, 201149.0, 201157.0, 201304.0, 32552.51171232386, 33955.49066763951, 33961.66038339684, 33983.320333592696, 34026.14934626654, 42833.5716642842, 43232.0, 43381.0, 43478.13043739171, 44187.0, 31165.0, 31539.0, 31545.36909261756, 31706.841465792524, 32204.0, 30540.84729576338, 30894.53658195084, 31208.0, 31429.528557071204, 31431.0, 35492.82253588716, 35577.82211088928, 35760.463593045606, 35857.0, 35964.4605330915, 30521.542176866922, 30562.388752225277, 30593.694063059083, 30830.845845771524, 30842.383152337276, 22983.655245171, 23143.421414464774, 23404.7106010917, 23423.06307747671, 23745.05019799258], "value": 17115.937726619253, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.2952633024546, 583.3495652347634, 597.3727586034665, 600.3786081405744, 624.0919462182525, 21494.462638434048, 22245.44386390341, 22286.665700014513, 22328.106875724952, 22409.3277201684, 21963.450913727163, 23405.414864628394, 23650.29049128529, 23788.76211237887, 23802.0, 6677.966610166966, 6709.362610552014, 6746.055552222692, 6747.08914296571, 6760.39156475917, 6665.300143484937, 6757.425618822406, 6795.7961261162245, 7106.933959906004, 7109.8222544436285, 7105.928940710578, 7107.431405487574, 7108.466864985121, 7111.32442417972, 7112.822179445504, 7088.822779430504, 7099.89350159748, 7115.53749006313, 7123.2520585338825, 7143.392811611019, 6664.200295964467, 6969.372756451893, 6985.3713165815325, 6989.0, 7009.193942696605, 29126.0, 29622.963196288027, 29658.40683186324, 29669.554956675667, 29733.0, 2056.208359781495, 2067.4831292176955, 2078.199893041175, 2090.5818836232816, 2090.790920907912, 19559.0, 19890.20439182431, 20331.491712707153, 20695.8965205173, 20895.37313880586, 2466.161505088279, 2505.7494250574796, 2541.504406640706, 2542.2627438043132, 2569.3191304304373, 120714.0, 127251.36374318162, 136516.31741841327, 141075.29462352622, 147487.0, 20079.0, 20136.899315503328, 20245.0, 21088.78911210899, 21148.57702845965, 40490.19019619591, 41284.1743165141, 41291.58708412937, 41348.58651413448, 41648.583514165075, 10996.835047474295, 11109.111271098292, 11194.272372295938, 11258.155638327158, 11287.379194144236, 9128.178463938277, 9154.0, 9173.495457749754, 9186.586603602855, 9246.537673116452, 10696.0, 10948.562057517769, 10977.615783447542, 11156.497957591928, 11188.832167517494, 4206.936895946563, 4239.788010599519, 4241.384999175102, 4259.55810571195, 4395.560443955579, 939.8825146856643, 975.3903810118676, 977.1596427072711, 980.6371642492323, 986.5757724178528, 18056.90971545134, 18226.63546729058, 18530.536736581424, 18581.25674973013, 18728.906355468407, 1007.3200589601989, 1020.260311274335, 1023.2683631203726, 1024.933379330341, 1025.5795123999274, 10279.691609251735, 10346.275760696679, 10412.167026637851, 10536.473176341153, 10621.787564248672, 482632.0, 492097.0, 492330.0, 493103.0, 498938.0, 105977.47011264894, 107166.0, 109725.45137274262, 112004.43997779959, 112568.43715781369, 1162.0, 1167.480471190312, 1187.5784096645566, 1187.6733898177897, 1188.9464974076013, 16818.713216558783, 16916.915415423337, 16939.644828413944, 17006.48980530586, 17335.566610834325, 55652.72173639106, 55812.72093639506, 56116.43883561112, 57220.42779572151, 57546.0, 70376.64811675908, 70759.0, 71089.0, 71121.28878711353, 71320.0, 18873.245070197037, 19204.0, 19331.4200573983, 19415.70876436883, 19428.90285548563, 21311.041003155206, 21368.0, 21486.892565537073, 21621.891890540446, 21903.890480547496, 17404.73892891633, 17481.213345399232, 17573.384931527336, 17749.29002839872, 17837.286508539513, 15497.992850152585, 15506.302216400514, 15866.0, 16233.107179105262, 16351.427700030441, 17720.734188986917, 17727.911360443115, 17860.55348616295, 18054.0, 18256.634867302313, 18802.153903074668, 18841.340553080576, 18846.811531885054, 18855.90572047186, 19057.428277151706, 17219.22513486871, 17230.569235768704, 17477.300907964047, 17550.12249387551, 17563.209655565784], "value": 12660.235309991614, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.9206847589146, 1372.9862701372983, 1374.0519041861114, 1376.064276292121, 1378.8690074442925, 15534.0, 16186.91906540467, 16193.676126477463, 16201.594960126004, 16213.513594592152, 15650.765238521431, 15652.0, 15760.527184184493, 15782.368705251805, 15793.84206157938, 2733.4259805440834, 2865.1977446315063, 2866.125831621355, 2868.168231212956, 2870.712928707123, 2697.784177265824, 2765.5989881467176, 2781.5271403861393, 2791.8743656535503, 2793.050362876632, 2736.1107640016976, 2765.308672831792, 2767.1006922750084, 2775.111964171456, 2777.05580102765, 2659.654244948154, 2680.11556186458, 2694.986525067372, 2708.5530887403556, 2710.2682275785623, 2667.186508115024, 2688.2472907585907, 2707.6073969274544, 2720.279126031603, 2774.5838124281318, 15211.391544338214, 15320.0, 15336.309866056054, 15344.846551534454, 15358.001729887521, 7923.286904178594, 8201.343892488587, 8203.05664848544, 8213.95893020531, 8229.506229626182, 5268.420473747885, 5388.811391601314, 5464.180372944051, 5508.091164957777, 5517.44825517449, 2006.067178761868, 2024.3965740981077, 2039.1231770338748, 2045.1512622261891, 2067.5451400691823, 27516.0, 27643.0, 27746.306342341402, 27767.16698499028, 27800.860995695093, 6813.481805527918, 6831.11195544576, 6860.348266914635, 6919.204291506541, 6953.269906659829, 17635.470935871945, 17635.647287054187, 17646.911765441346, 17687.91156044237, 17707.0, 8094.392920530866, 8246.546439945741, 8271.627776750061, 8275.54484503358, 8287.544185069879, 7211.495195336381, 7432.405407567381, 7476.476646634684, 7571.280728330799, 7617.961910190414, 5204.9739751301, 5372.704501252469, 5396.217548455452, 5433.809816656398, 5440.836774896759, 1418.390092260338, 1440.6470414748244, 1600.4158482154162, 1610.8308627594167, 1614.0, 897.4839467306325, 906.1844340093836, 911.8085202107632, 912.808310254854, 921.3458444504342, 8738.0, 8763.342749293828, 8797.560121993874, 8889.977652569907, 9035.277177825757, 951.6098399656246, 960.711786464058, 976.3751199232497, 987.1461186074138, 990.6978371596588, 4956.157453232959, 5422.7017514036315, 5446.428125046813, 5483.862903427446, 5545.639533430314, 21488.14047438116, 22466.213682521033, 22497.0, 22502.774972250067, 22546.436339091324, 20792.48018799512, 21588.028538715796, 21733.67399489009, 21935.78064219369, 22004.669929951062, 12012.579559715368, 12194.695132621579, 12204.32876191818, 12208.938955305344, 12225.205361651464, 8484.448510846774, 8511.702090426805, 8553.0, 8749.737507874519, 8825.779355516164, 18904.52738681544, 19150.0, 19238.03809809476, 19254.903725481283, 19685.21259149618, 19059.618807623494, 19828.70256946118, 19881.502962426053, 19893.303734369227, 19970.60058798845, 11160.10719142483, 11362.659120226406, 11486.138539609396, 11489.82765258505, 11516.94241528787, 14007.579772606838, 14068.08557443763, 14135.575932722035, 14219.075760075562, 14223.857761422254, 11317.943410282896, 11424.714382140513, 11744.58893938708, 11787.823182652439, 11814.704632384259, 11320.716982075513, 11432.485538150637, 11440.71398215018, 11545.769084618092, 11850.940745296219, 10191.694249172537, 10493.265471416928, 10497.16022718196, 10502.68491945243, 10513.632022879163, 7575.128860180929, 7586.089669239726, 7631.732889348847, 7632.19861914491, 7654.15804261542, 7320.743773967885, 7495.550266983998, 7533.472656914183, 7542.2834830691, 7637.656305466378], "value": 6868.840875227074, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.065160105406, 533.0990625842326, 535.7615860941883, 540.2598440137012, 544.8910217956409, 6312.147860038894, 6325.240971083471, 6360.745570177193, 6385.361463853612, 6411.230652321722, 6225.937740622592, 6239.625622462655, 6257.435641089727, 6274.56078074535, 6311.558190926637, 5208.9218661719915, 5210.921836172461, 5215.765290561933, 5229.241759944805, 5264.657797243167, 4898.608111351101, 5061.16490779021, 5150.871228219287, 5185.792568297264, 5224.0, 4989.57588604969, 5027.748612569375, 5028.899422011576, 5043.949560504385, 5058.114829904752, 4981.7582088060335, 4998.600111991032, 5007.198848184291, 5051.873703157414, 5052.8484145475695, 4471.2398892188085, 4513.7066090704, 4533.818647254106, 4534.909301813946, 4561.156186105548, 6126.203593532812, 6175.795719834634, 6188.47397971173, 6192.535559832985, 6259.342769009279, 5788.450097240755, 5810.506106980912, 5821.417858214187, 5849.327327357366, 5856.092305692625, 6612.0, 6612.669366531654, 6614.86770264592, 6644.235912870034, 6678.532502724811, 5005.324281222025, 5005.399352077738, 5006.69959802413, 5019.447860735316, 5019.694879331364, 6680.7661731839635, 6732.865342693168, 6891.586504809728, 6932.757353492654, 6959.478039147034, 5023.447420783711, 5028.949710502921, 5041.193409054534, 5044.621653376012, 5123.846284611468, 5089.185730283137, 5102.0, 5132.435432102466, 5200.323957885451, 5212.244224587414, 5773.538116950634, 5774.538036957118, 5787.8553036174435, 5815.156802263733, 5815.244018277597, 6643.169603799525, 6660.6336651484635, 6736.326367363225, 6745.865082698417, 6747.190337159573, 1794.228481752859, 1800.820462597001, 1815.7730283714536, 1817.1822679794145, 1821.3807305516189, 1186.2467333243453, 1223.2721530689403, 1224.2776761710634, 1236.993815030919, 1262.3435813377175, 5663.575231857627, 5700.82897513067, 5744.569157313218, 5779.306483222041, 5813.59304848665, 6731.932680673229, 6735.797926062226, 6743.583847392103, 6796.150481189851, 6831.965840170867, 5707.145177817143, 5745.1669507921115, 5751.683657398883, 5754.251947246915, 5782.942170578324, 3511.9297614047578, 3551.6448355164275, 3563.467708885204, 3614.8192590370377, 3629.364861149288, 6128.17269668598, 6436.292007879129, 6553.0, 6558.639274839834, 6562.442192413603, 6691.431228345645, 6800.965995169992, 6887.896681549781, 6903.1716194057035, 6911.92196604006, 6319.314291426217, 6397.52018598607, 6451.870962580816, 6467.547271690936, 6475.384838440341, 6647.567908085959, 6697.732090716317, 6807.5575087619145, 6818.897716534157, 6824.0, 6730.259671436236, 6762.628734679027, 6770.661466926733, 6780.38976492118, 6817.522773405814, 6378.958733205515, 6407.0, 6459.773907913201, 6491.772787952399, 6589.17635295588, 5072.721000345016, 5089.465606111453, 5093.159628661378, 5099.311592934906, 5134.383873935151, 6372.840678983062, 6605.471562275103, 6629.933700662931, 6706.396424321834, 6791.151106111736, 6525.3800888915475, 6568.901466477911, 6569.146011018537, 6572.605643661395, 6583.572067815577, 6393.424591786761, 6420.2937676856445, 6449.580777249464, 6571.178602674666, 6620.06106366711, 6231.719572619152, 6478.708458119301, 6509.349065093453, 6509.837254068686, 6537.986612075136, 6435.81182397987, 6584.637844918576, 6659.600423974577, 6681.29846366144, 6688.933110669026, 6271.43557079865, 6276.717547710273, 6293.40212679813, 6360.236771587254, 6381.564148066648], "value": 5105.3317474513615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.4742449379361, 925.453982150531, 940.2524992630857, 940.2900809888533, 941.2234906202381, 19205.42383728487, 20066.49833754157, 20070.89964550177, 20100.396988090364, 22760.88619556904, 21941.561168776614, 21965.780342196573, 22070.33788986329, 22136.225232116878, 22331.888340558315, 973.956171972263, 981.5975450065474, 983.6360546597768, 983.7098056073439, 985.1576901748973, 928.9210417114554, 972.7227740094074, 978.838491648877, 979.7844474215697, 987.9555420006117, 1034.8085604163216, 1035.1201478743083, 1035.6841163445147, 1036.1710631494775, 1038.9584416623327, 1017.9643712470103, 1019.9541020654088, 1026.491886516172, 1026.630413051301, 1029.8815636201857, 752.947293689442, 755.0599503618031, 757.6666266842627, 759.3052357093253, 760.3764912771529, 20294.594108117904, 20686.965651717503, 20753.066112024993, 20873.269435569833, 20873.373798786062, 21876.781232187794, 22033.0, 22660.320190394315, 22674.0, 22681.2061577844, 17462.825371746247, 17629.55926101845, 17650.558736031573, 17652.205650745746, 17652.646947060988, 3569.5894972078286, 3646.7994260315672, 3709.888703338904, 3734.73856830022, 3736.4582135590185, 141259.29370353185, 141789.0, 145236.27381863235, 145421.0, 147248.0, 16860.91569542169, 16970.490885273462, 17155.970641761534, 17172.141392930305, 17505.824941750674, 31133.0, 32013.359732805213, 32033.0, 32083.0, 32150.678493214768, 8451.873221901553, 8582.055973842873, 8592.0, 8594.957025214959, 8602.225799678059, 4127.442795222667, 4156.314208155621, 4157.625813676784, 4167.229062623424, 4185.97907010463, 5043.445221025684, 5281.313429254173, 6114.510839132948, 6226.377362263828, 6322.178116844872, 1210.6731182580654, 1213.769383817072, 1244.0793812578627, 1249.2504497301547, 1251.455616806692, 682.0962225051826, 702.6170736948376, 709.8793205155137, 714.9821254468576, 723.6996646391793, 11841.763164736656, 11895.226810257478, 12376.0, 12704.618861434172, 13120.475180992653, 686.9587824730432, 689.2934741889503, 700.1283402164338, 700.7232143303366, 707.7947395255318, 5781.71091445426, 5786.537077033827, 5815.621984570989, 5861.853453663693, 5882.764689412461, 122343.0, 122532.0, 124010.0, 125985.37007315089, 126479.0, 109870.0, 109941.0, 111174.0, 115487.0, 116337.41831290789, 95684.0, 95708.0, 96740.0, 96746.51626741962, 99938.0, 10567.313124646873, 10660.0, 10735.785284294427, 10918.56325746993, 10951.83572246401, 44231.33652995272, 45358.880323328565, 45840.31239531343, 46702.766486167355, 47337.28994065161, 57545.0, 57614.423855760906, 58274.4172558269, 58406.0, 59762.40237597568, 15044.097354158786, 15350.462733804263, 15446.922765386551, 15462.690746185239, 15615.219239037775, 17403.303867845145, 17470.30118795234, 17644.294228230727, 17650.0, 17907.641847162722, 15580.143092130042, 15829.604259893595, 15880.682386352439, 15978.60053498672, 15993.760093598838, 15695.764563531784, 15875.603109922344, 15913.840861591236, 16034.278457469209, 16053.438129665406, 15515.922420387826, 15630.687386251984, 15768.60578485547, 15888.285027174035, 15927.0, 11341.432928353714, 11352.205345626056, 11456.140789440658, 11528.884711152781, 11531.654050378502, 11960.282383057045, 11964.46159922823, 11967.581134660246, 12068.456919438471, 12201.755964880831], "value": 9145.872646407966, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1431.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 106.0, 109.0, 110.0, 111.0, 109.0, 109.0, 109.0, 107.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 118.0, 115.0, 129.0, 120.0, 146.0, 124.0, 120.0, 117.0], "value": 122.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 165.0, 165.0, 167.0, 163.0, 166.0, 175.0, 165.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 78.0, 79.0, 78.0, 74.0, 76.0, 74.0, 75.0], "value": 75.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 79.0, 78.0, 79.0, 79.0, 79.0, 80.0, 81.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 110.0, 109.0, 114.0, 114.0, 114.0, 115.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 148.0, 149.0, 151.0, 148.0, 149.0, 147.0, 150.0, 148.0, 148.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 57.0, 53.0, 57.0, 54.0, 55.0, 55.0, 54.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 40.0, 38.0, 39.0, 38.0, 38.0, 39.0, 39.0, 39.0, 39.0], "value": 38.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 71.0, 74.0, 74.0, 76.0, 78.0, 74.0, 75.0, 72.0, 75.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 113.0, 114.0, 113.0, 119.0, 112.0, 119.0, 119.0], "value": 114.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 171.0, 175.0, 171.0, 166.0, 182.0, 176.0, 168.0, 171.0, 169.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 64.0, 66.0, 66.0, 70.0, 68.0, 72.0, 65.0, 66.0], "value": 66.9, "unit": "score"}]}]} 11:52:14 INFO - Return code: 0 11:52:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:52:14 INFO - # TBPL SUCCESS # 11:52:14 INFO - Running post-action listener: _package_coverage_data 11:52:14 INFO - Running post-action listener: _resource_record_post_action 11:52:14 INFO - [mozharness: 2017-09-26 18:52:14.763512Z] Finished run-tests step (success) 11:52:14 INFO - Running post-run listener: _resource_record_post_run 11:52:14 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 49152; Write bytes: 343822336; Read time: 40; Write time: 254436 11:52:14 INFO - TinderboxPrint: CPU usage
13.1% 11:52:14 INFO - TinderboxPrint: I/O read bytes / time
49,152 / 40 11:52:14 INFO - TinderboxPrint: I/O write bytes / time
343,822,336 / 254,436 11:52:14 INFO - TinderboxPrint: CPU idle
8,237.0 (86.9%) 11:52:14 INFO - TinderboxPrint: CPU user
1,192.9 (12.6%) 11:52:14 INFO - TinderboxPrint: Swap in / out
0 / 0 11:52:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10182656; Read time: 0; Write time: 1488 11:52:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:52:14 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 45056; Write bytes: 333639680; Read time: 28; Write time: 252948 11:52:15 INFO - Running post-run listener: _upload_blobber_files 11:52:15 INFO - Blob upload gear active. 11:52:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:52:15 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 11:52:15 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:52:15 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:52:15 INFO - (blobuploader) - INFO - Open directory for files ... 11:52:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:52:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:52:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:22 INFO - (blobuploader) - INFO - Done attempting. 11:52:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:52:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:52:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:23 INFO - (blobuploader) - INFO - Done attempting. 11:52:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:52:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:52:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:24 INFO - (blobuploader) - INFO - Done attempting. 11:52:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:52:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:52:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:25 INFO - (blobuploader) - INFO - Done attempting. 11:52:25 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:25 INFO - Return code: 0 11:52:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:52:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ab5061ff286bd52013f946da1cef8a2490949ad68009235d73fb2e98827d9af42c319b2fcba8f720f69bbd9891119809997c626b3198cc84a3b701caa717530", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7268c6c7ab245b85b72591fb32f9d33bd84a4f8878fb9583995a847b687f9be7121a015d911fdb8d336a706e1e56bf28508a87154b843782196af1353a0e1e9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df630bcab9b462f0b6a0db21709b653b727bf7d592a081c13e5325860bd4feff2e3aac53b35374b26c6369e9e20bd56c0e06bd2d4bacb8a486391c4c45c01e2a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28808c47d4028d27c882eacf4a051d2752a398d9b3601e38b43acb68b408c7d883977e47bd56fdc0881e1fda09b22fcee0873abaf048f936e656c231394c69fc"} 11:52:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:52:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:52:25 INFO - Contents: 11:52:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ab5061ff286bd52013f946da1cef8a2490949ad68009235d73fb2e98827d9af42c319b2fcba8f720f69bbd9891119809997c626b3198cc84a3b701caa717530", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7268c6c7ab245b85b72591fb32f9d33bd84a4f8878fb9583995a847b687f9be7121a015d911fdb8d336a706e1e56bf28508a87154b843782196af1353a0e1e9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df630bcab9b462f0b6a0db21709b653b727bf7d592a081c13e5325860bd4feff2e3aac53b35374b26c6369e9e20bd56c0e06bd2d4bacb8a486391c4c45c01e2a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28808c47d4028d27c882eacf4a051d2752a398d9b3601e38b43acb68b408c7d883977e47bd56fdc0881e1fda09b22fcee0873abaf048f936e656c231394c69fc"} 11:52:25 INFO - Running post-run listener: copy_logs_to_upload_dir 11:52:25 INFO - Copying logs to upload dir... 11:52:25 INFO - mkdir: /builds/slave/test/build/upload/logs 11:52:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.547557 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-26 11:52:25.894447) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 11:52:25.898201) ========= 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=03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ab5061ff286bd52013f946da1cef8a2490949ad68009235d73fb2e98827d9af42c319b2fcba8f720f69bbd9891119809997c626b3198cc84a3b701caa717530", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7268c6c7ab245b85b72591fb32f9d33bd84a4f8878fb9583995a847b687f9be7121a015d911fdb8d336a706e1e56bf28508a87154b843782196af1353a0e1e9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df630bcab9b462f0b6a0db21709b653b727bf7d592a081c13e5325860bd4feff2e3aac53b35374b26c6369e9e20bd56c0e06bd2d4bacb8a486391c4c45c01e2a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28808c47d4028d27c882eacf4a051d2752a398d9b3601e38b43acb68b408c7d883977e47bd56fdc0881e1fda09b22fcee0873abaf048f936e656c231394c69fc"} build_url:https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ab5061ff286bd52013f946da1cef8a2490949ad68009235d73fb2e98827d9af42c319b2fcba8f720f69bbd9891119809997c626b3198cc84a3b701caa717530", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7268c6c7ab245b85b72591fb32f9d33bd84a4f8878fb9583995a847b687f9be7121a015d911fdb8d336a706e1e56bf28508a87154b843782196af1353a0e1e9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df630bcab9b462f0b6a0db21709b653b727bf7d592a081c13e5325860bd4feff2e3aac53b35374b26c6369e9e20bd56c0e06bd2d4bacb8a486391c4c45c01e2a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28808c47d4028d27c882eacf4a051d2752a398d9b3601e38b43acb68b408c7d883977e47bd56fdc0881e1fda09b22fcee0873abaf048f936e656c231394c69fc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 11:52:25.933300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:52:25.939120) ========= 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=03627c79f6bb3d1578c4a402000001ba-1506450703.747634-2105627556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:52:26.014545) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 11:52:26.014875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 11:52:26.015232) ========= ========= Total master_lag: 0.21 =========