builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1504905862.66 results: success (0) revision: ea7b55d65d76214f97aaae502d65cb26fc6f5659 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:22.657481) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:22.658049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:22.658354) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:22.677059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:22.677360) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-08 14:24:22-- 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% 713K=0.02s 2017-09-08 14:24:22 (713 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094996 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:22.790495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:22.790814) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023605 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:22.841175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:22.841532) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ea7b55d65d76214f97aaae502d65cb26fc6f5659 --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 ea7b55d65d76214f97aaae502d65cb26fc6f5659 --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=e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-08 14:24:22,894 truncating revision to first 12 chars 2017-09-08 14:24:22,894 Setting DEBUG logging. 2017-09-08 14:24:22,894 attempt 1/10 2017-09-08 14:24:22,894 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ea7b55d65d76?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-08 14:24:23,158 unpacking tar archive at: mozilla-central-ea7b55d65d76/testing/mozharness/ program finished with exit code 0 elapsedTime=0.576470 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:23.434552) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:23.434871) ========= script_repo_revision: ea7b55d65d76214f97aaae502d65cb26fc6f5659 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:23.435334) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:23.435607) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 14:24:23.449142) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-08 14:24:23.449549) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:24:23 INFO - MultiFileLogger online at 20170908 14:24:23 in /builds/slave/test 14:24:23 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 14:24:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:24:23 INFO - {'append_to_log': False, 14:24:23 INFO - 'base_work_dir': '/builds/slave/test', 14:24:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:24:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:24:23 INFO - 'branch': 'Firefox-Non-PGO', 14:24:23 INFO - 'buildbot_json_path': 'buildprops.json', 14:24:23 INFO - 'code_coverage': False, 14:24:23 INFO - 'config_files': ('talos/linux_config.py',), 14:24:23 INFO - 'default_actions': ('clobber', 14:24:23 INFO - 'read-buildbot-config', 14:24:23 INFO - 'download-and-extract', 14:24:23 INFO - 'populate-webroot', 14:24:23 INFO - 'create-virtualenv', 14:24:23 INFO - 'install', 14:24:23 INFO - 'setup-mitmproxy', 14:24:23 INFO - 'run-tests'), 14:24:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:24:23 INFO - 'disable_ccov_upload': False, 14:24:23 INFO - 'disable_stylo': False, 14:24:23 INFO - 'download_minidump_stackwalk': True, 14:24:23 INFO - 'download_symbols': 'ondemand', 14:24:23 INFO - 'enable_stylo': False, 14:24:23 INFO - 'enable_webrender': False, 14:24:23 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 14:24:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:24:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:24:23 INFO - 'gecko_profile': False, 14:24:23 INFO - 'gecko_profile_interval': 0, 14:24:23 INFO - 'installer_path': 'installer.exe', 14:24:23 INFO - 'log_level': 'info', 14:24:23 INFO - 'log_name': 'talos', 14:24:23 INFO - 'log_to_console': True, 14:24:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:24:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:24:23 INFO - 'opt_config_files': (), 14:24:23 INFO - 'pip_index': False, 14:24:23 INFO - 'suite': 'dromaeojs-e10s', 14:24:23 INFO - 'system_bits': '32', 14:24:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:24:23 INFO - 'title': 'talos-linux64-ix-006', 14:24:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:24:23 INFO - 'use_talos_json': True, 14:24:23 INFO - 'verify': 'False', 14:24:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:24:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:24:23 INFO - 'work_dir': 'build'} 14:24:23 INFO - [mozharness: 2017-09-08 21:24:23.645778Z] Running clobber step. 14:24:23 INFO - Running pre-action listener: _resource_record_pre_action 14:24:23 INFO - Running main action method: clobber 14:24:23 INFO - rmtree: /builds/slave/test/build 14:24:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:24:24 INFO - Running post-action listener: _resource_record_post_action 14:24:24 INFO - [mozharness: 2017-09-08 21:24:24.672956Z] Finished clobber step (success) 14:24:24 INFO - [mozharness: 2017-09-08 21:24:24.673052Z] Running read-buildbot-config step. 14:24:24 INFO - Running pre-action listener: _resource_record_pre_action 14:24:24 INFO - Running main action method: read_buildbot_config 14:24:24 INFO - Using buildbot properties: 14:24:24 INFO - { 14:24:24 INFO - "project": "", 14:24:24 INFO - "product": "firefox", 14:24:24 INFO - "who": "kwierso@gmail.com", 14:24:24 INFO - "installer_path": "public/build/target.tar.bz2", 14:24:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:24:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:24:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:24:24 INFO - "stage_platform": "linux64", 14:24:24 INFO - "basedir": "/builds/slave/test", 14:24:24 INFO - "buildnumber": 1126, 14:24:24 INFO - "platform": "ubuntu64_hw", 14:24:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:24:24 INFO - "slavebuilddir": "test", 14:24:24 INFO - "taskId": "SWpqMbzdQQKdhh4K0N6b1A", 14:24:24 INFO - "branch": "mozilla-central", 14:24:24 INFO - "script_repo_revision": "production", 14:24:24 INFO - "revision": "ea7b55d65d76214f97aaae502d65cb26fc6f5659", 14:24:24 INFO - "slavename": "talos-linux64-ix-006", 14:24:24 INFO - "repo_path": "mozilla-central" 14:24:24 INFO - } 14:24:24 INFO - Finding installer, test and symbols from parent task. 14:24:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SWpqMbzdQQKdhh4K0N6b1A'}, attempt #1 14:24:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SWpqMbzdQQKdhh4K0N6b1A'}, attempt #1 14:24:25 INFO - Task dependencies: d3HW9PtGSQquoTirprYnMw 14:24:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw'}, attempt #1 14:24:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.tar.bz2 14:24:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.test_packages.json 14:24:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.crashreporter-symbols.zip 14:24:26 INFO - Running post-action listener: _resource_record_post_action 14:24:26 INFO - [mozharness: 2017-09-08 21:24:26.072652Z] Finished read-buildbot-config step (success) 14:24:26 INFO - [mozharness: 2017-09-08 21:24:26.072867Z] Running download-and-extract step. 14:24:26 INFO - Running pre-action listener: _resource_record_pre_action 14:24:26 INFO - Running main action method: download_and_extract 14:24:26 INFO - mkdir: /builds/slave/test/build/tests 14:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:26 INFO - trying https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.test_packages.json 14:24:26 INFO - Downloading https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:24:26 INFO - Downloaded 989 bytes. 14:24:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:24:26 INFO - Using the following test package requirements: 14:24:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:24:26 INFO - u'common': [u'target.common.tests.zip'], 14:24:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:24:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:24:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:24:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:24:26 INFO - u'mozbase': [u'target.common.tests.zip'], 14:24:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:24:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:24:26 INFO - u'web-platform': [u'target.common.tests.zip', 14:24:26 INFO - u'target.web-platform.tests.tar.gz'], 14:24:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:24:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 14:24:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.common.tests.zip 14:24:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:24:26 INFO - Fetch https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.common.tests.zip into memory 14:24:28 INFO - Content-Length response header: 55024852 14:24:28 INFO - Bytes received: 55024852 14:24:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.talos.tests.zip 14:24:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:24:39 INFO - Fetch https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.talos.tests.zip into memory 14:24:40 INFO - Content-Length response header: 14497945 14:24:40 INFO - Bytes received: 14497945 14:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:40 INFO - trying https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.tar.bz2 14:24:40 INFO - Downloading https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:24:42 INFO - Downloaded 62849623 bytes. 14:24:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.tar.bz2 14:24:43 INFO - mkdir: /builds/slave/test/properties 14:24:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:24:43 INFO - Writing to file /builds/slave/test/properties/build_url 14:24:43 INFO - Contents: 14:24:43 INFO - build_url:https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.tar.bz2 14:24:43 INFO - Running post-action listener: _resource_record_post_action 14:24:43 INFO - Running post-action listener: find_tests_for_verification 14:24:43 INFO - Running post-action listener: set_extra_try_arguments 14:24:43 INFO - [mozharness: 2017-09-08 21:24:43.048719Z] Finished download-and-extract step (success) 14:24:43 INFO - [mozharness: 2017-09-08 21:24:43.048952Z] Running populate-webroot step. 14:24:43 INFO - Running pre-action listener: _resource_record_pre_action 14:24:43 INFO - Running main action method: populate_webroot 14:24:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:24:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:24:43 INFO - 'tests': ['tresize', 14:24:43 INFO - 'tcanvasmark']}, 14:24:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:24:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:24:43 INFO - 'tests': ['dromaeo_css', 14:24:43 INFO - 'kraken']}, 14:24:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:24:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:24:43 INFO - 'talos_options': ['--disable-stylo'], 14:24:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:24:43 INFO - 'tests': ['damp', 'tps']}, 14:24:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:24:43 INFO - 'talos_options': ['--disable-stylo'], 14:24:43 INFO - 'tests': ['damp', 'tps']}, 14:24:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:24:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:24:43 INFO - 'tests': ['dromaeo_dom']}, 14:24:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:24:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:24:43 INFO - 'tests': ['basic_compositor_video', 14:24:43 INFO - 'glvideo']}, 14:24:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:24:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:24:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:24:43 INFO - 'talos_options': ['--disable-stylo'], 14:24:43 INFO - 'tests': ['ts_paint_webext', 14:24:43 INFO - 'tp5o_webext']}, 14:24:43 INFO - 'other-e10s': {'tests': ['a11yr', 14:24:43 INFO - 'ts_paint', 14:24:43 INFO - 'tpaint', 14:24:43 INFO - 'sessionrestore', 14:24:43 INFO - 'sessionrestore_many_windows', 14:24:43 INFO - 'sessionrestore_no_auto_restore', 14:24:43 INFO - 'tabpaint']}, 14:24:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:24:43 INFO - 'tests': ['a11yr', 14:24:43 INFO - 'ts_paint', 14:24:43 INFO - 'tpaint', 14:24:43 INFO - 'sessionrestore', 14:24:43 INFO - 'sessionrestore_many_windows', 14:24:43 INFO - 'sessionrestore_no_auto_restore', 14:24:43 INFO - 'tabpaint']}, 14:24:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:24:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 14:24:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:24:43 INFO - 'tests': ['bloom_basic_singleton']}, 14:24:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:24:43 INFO - 'tests': ['bloom_basic']}, 14:24:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:24:43 INFO - 'tsvgr_opacity', 14:24:43 INFO - 'tart', 14:24:43 INFO - 'tscrollx', 14:24:43 INFO - 'tsvg_static']}, 14:24:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:24:43 INFO - 'tests': ['tsvgx', 14:24:43 INFO - 'tsvgr_opacity', 14:24:43 INFO - 'tart', 14:24:43 INFO - 'tscrollx', 14:24:43 INFO - 'tsvg_static']}, 14:24:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:24:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:24:43 INFO - 'talos_options': ['--disable-stylo'], 14:24:43 INFO - 'tests': ['tp5o']}, 14:24:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:24:43 INFO - 'talos_options': ['--mitmproxy', 14:24:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:24:43 INFO - '--firstNonBlankPaint'], 14:24:43 INFO - 'tests': ['tp6_google', 14:24:43 INFO - 'tp6_youtube', 14:24:43 INFO - 'tp6_amazon', 14:24:43 INFO - 'tp6_facebook']}, 14:24:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:24:43 INFO - 'talos_options': ['--disable-stylo', 14:24:43 INFO - '--mitmproxy', 14:24:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:24:43 INFO - '--firstNonBlankPaint'], 14:24:43 INFO - 'tests': ['tp6_google', 14:24:43 INFO - 'tp6_youtube', 14:24:43 INFO - 'tp6_amazon', 14:24:43 INFO - 'tp6_facebook']}, 14:24:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:24:43 INFO - 'talos_options': ['--stylo-threads=1', 14:24:43 INFO - '--mitmproxy', 14:24:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:24:43 INFO - '--firstNonBlankPaint'], 14:24:43 INFO - 'tests': ['tp6_google', 14:24:43 INFO - 'tp6_youtube', 14:24:43 INFO - 'tp6_amazon', 14:24:43 INFO - 'tp6_facebook']}, 14:24:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:24:43 INFO - 'talos_options': ['--xperf_path', 14:24:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:43 INFO - 'tests': ['tp5n']}, 14:24:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:24:43 INFO - 'talos_options': ['--disable-stylo', 14:24:43 INFO - '--xperf_path', 14:24:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:43 INFO - 'tests': ['tp5n']}}} 14:24:43 INFO - Running post-action listener: _resource_record_post_action 14:24:43 INFO - [mozharness: 2017-09-08 21:24:43.069015Z] Finished populate-webroot step (success) 14:24:43 INFO - [mozharness: 2017-09-08 21:24:43.069129Z] Running create-virtualenv step. 14:24:43 INFO - Running pre-action listener: _resource_record_pre_action 14:24:43 INFO - Running main action method: create_virtualenv 14:24:43 INFO - Creating virtualenv /builds/slave/test/build/venv 14:24:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:24:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 14:24:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:24:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:24:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:24:43 INFO - Installing distribute.............................................................................................................................................................................................done. 14:24:43 INFO - Installing pip...............done. 14:24:44 INFO - Return code: 0 14:24:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:24:44 INFO - Reading from file tmpfile_stdout 14:24:44 INFO - Output received: 14:24:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 14:24:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2759a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2900090>, '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 0x2900d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28faf90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', '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 14:24:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:24:44 INFO - Using env: {'DISPLAY': ':0', 14:24:44 INFO - 'HOME': '/home/cltbld', 14:24:44 INFO - 'LANG': 'en_US.UTF-8', 14:24:44 INFO - 'LANGUAGE': 'en_US:en', 14:24:44 INFO - 'LOGNAME': 'cltbld', 14:24:44 INFO - 'MAIL': '/var/mail/cltbld', 14:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:44 INFO - 'MOZ_NO_REMOTE': '1', 14:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:44 INFO - 'NO_EM_RESTART': '1', 14:24:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:44 INFO - 'PWD': '/builds/slave/test', 14:24:44 INFO - 'SHELL': '/bin/bash', 14:24:44 INFO - 'SHLVL': '1', 14:24:44 INFO - 'TERM': 'linux', 14:24:44 INFO - 'TMOUT': '86400', 14:24:44 INFO - 'USER': 'cltbld', 14:24:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', 14:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:44 INFO - '_': '/tools/buildbot/bin/python'} 14:24:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 14:24:45 INFO - Downloading/unpacking pip>=1.5 14:24:45 INFO - Running setup.py egg_info for package pip 14:24:45 INFO - warning: no files found matching 'pip/cacert.pem' 14:24:45 INFO - warning: no files found matching '*.html' under directory 'docs' 14:24:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:24:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:24:45 INFO - Installing collected packages: pip 14:24:45 INFO - Found existing installation: pip 1.1 14:24:45 INFO - Uninstalling pip: 14:24:45 INFO - Successfully uninstalled pip 14:24:45 INFO - Running setup.py install for pip 14:24:45 INFO - warning: no files found matching 'pip/cacert.pem' 14:24:45 INFO - warning: no files found matching '*.html' under directory 'docs' 14:24:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:24:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:24:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 14:24:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 14:24:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 14:24:45 INFO - Successfully installed pip 14:24:45 INFO - Cleaning up... 14:24:45 INFO - Return code: 0 14:24:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:45 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 0x25901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2759a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2900090>, '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 0x2900d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28faf90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', '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 14:24:45 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 14:24:45 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 14:24:45 INFO - Using env: {'DISPLAY': ':0', 14:24:45 INFO - 'HOME': '/home/cltbld', 14:24:45 INFO - 'LANG': 'en_US.UTF-8', 14:24:45 INFO - 'LANGUAGE': 'en_US:en', 14:24:45 INFO - 'LOGNAME': 'cltbld', 14:24:45 INFO - 'MAIL': '/var/mail/cltbld', 14:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:45 INFO - 'MOZ_NO_REMOTE': '1', 14:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:45 INFO - 'NO_EM_RESTART': '1', 14:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:45 INFO - 'PWD': '/builds/slave/test', 14:24:45 INFO - 'SHELL': '/bin/bash', 14:24:45 INFO - 'SHLVL': '1', 14:24:45 INFO - 'TERM': 'linux', 14:24:45 INFO - 'TMOUT': '86400', 14:24:45 INFO - 'USER': 'cltbld', 14:24:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', 14:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:45 INFO - '_': '/tools/buildbot/bin/python'} 14:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:45 INFO - Downloading/unpacking psutil>=3.1.1 14:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:24:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:46 INFO - Installing collected packages: psutil 14:24:46 INFO - Running setup.py install for psutil 14:24:46 INFO - building 'psutil._psutil_linux' extension 14:24:46 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 14:24:46 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 14:24:47 INFO - building 'psutil._psutil_posix' extension 14:24:47 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 14:24:47 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 14:24:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:47 INFO - Successfully installed psutil 14:24:47 INFO - Cleaning up... 14:24:47 INFO - Return code: 0 14:24:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2759a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2900090>, '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 0x2900d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28faf90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', '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 14:24:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:24:47 INFO - Using env: {'DISPLAY': ':0', 14:24:47 INFO - 'HOME': '/home/cltbld', 14:24:47 INFO - 'LANG': 'en_US.UTF-8', 14:24:47 INFO - 'LANGUAGE': 'en_US:en', 14:24:47 INFO - 'LOGNAME': 'cltbld', 14:24:47 INFO - 'MAIL': '/var/mail/cltbld', 14:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:47 INFO - 'MOZ_NO_REMOTE': '1', 14:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:47 INFO - 'NO_EM_RESTART': '1', 14:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:47 INFO - 'PWD': '/builds/slave/test', 14:24:47 INFO - 'SHELL': '/bin/bash', 14:24:47 INFO - 'SHLVL': '1', 14:24:47 INFO - 'TERM': 'linux', 14:24:47 INFO - 'TMOUT': '86400', 14:24:47 INFO - 'USER': 'cltbld', 14:24:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', 14:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:47 INFO - '_': '/tools/buildbot/bin/python'} 14:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:24:47 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 14:24:47 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 14:24:47 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 14:24:47 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 14:24:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:24:48 INFO - Installing collected packages: mozsystemmonitor 14:24:48 INFO - Running setup.py install for mozsystemmonitor 14:24:49 INFO - Successfully installed mozsystemmonitor 14:24:49 INFO - Cleaning up... 14:24:50 INFO - Return code: 0 14:24:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2759a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2900090>, '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 0x2900d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28faf90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', '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 14:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:24:50 INFO - Using env: {'DISPLAY': ':0', 14:24:50 INFO - 'HOME': '/home/cltbld', 14:24:50 INFO - 'LANG': 'en_US.UTF-8', 14:24:50 INFO - 'LANGUAGE': 'en_US:en', 14:24:50 INFO - 'LOGNAME': 'cltbld', 14:24:50 INFO - 'MAIL': '/var/mail/cltbld', 14:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:50 INFO - 'MOZ_NO_REMOTE': '1', 14:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:50 INFO - 'NO_EM_RESTART': '1', 14:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:50 INFO - 'PWD': '/builds/slave/test', 14:24:50 INFO - 'SHELL': '/bin/bash', 14:24:50 INFO - 'SHLVL': '1', 14:24:50 INFO - 'TERM': 'linux', 14:24:50 INFO - 'TMOUT': '86400', 14:24:50 INFO - 'USER': 'cltbld', 14:24:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', 14:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:50 INFO - '_': '/tools/buildbot/bin/python'} 14:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:51 INFO - Downloading/unpacking jsonschema==2.5.1 14:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:24:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:24:52 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 14:24:52 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 14:24:52 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 14:24:52 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 14:24:52 INFO - Downloading functools32-3.2.3-2.tar.gz 14:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:24:52 INFO - warning: no files found matching '*.txt' 14:24:52 INFO - no previously-included directories found matching 'build' 14:24:52 INFO - no previously-included directories found matching 'dist' 14:24:52 INFO - no previously-included directories found matching '.git*' 14:24:52 INFO - Installing collected packages: jsonschema, functools32 14:24:52 INFO - Running setup.py install for functools32 14:24:52 INFO - warning: no files found matching '*.txt' 14:24:52 INFO - no previously-included directories found matching 'build' 14:24:52 INFO - no previously-included directories found matching 'dist' 14:24:52 INFO - no previously-included directories found matching '.git*' 14:24:52 INFO - Successfully installed jsonschema functools32 14:24:52 INFO - Cleaning up... 14:24:52 INFO - Return code: 0 14:24:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:52 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 0x25901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2759a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2900090>, '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 0x2900d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28faf90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', '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 14:24:52 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 14:24:52 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 14:24:52 INFO - Using env: {'DISPLAY': ':0', 14:24:52 INFO - 'HOME': '/home/cltbld', 14:24:52 INFO - 'LANG': 'en_US.UTF-8', 14:24:52 INFO - 'LANGUAGE': 'en_US:en', 14:24:52 INFO - 'LOGNAME': 'cltbld', 14:24:52 INFO - 'MAIL': '/var/mail/cltbld', 14:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:52 INFO - 'MOZ_NO_REMOTE': '1', 14:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:52 INFO - 'NO_EM_RESTART': '1', 14:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:52 INFO - 'PWD': '/builds/slave/test', 14:24:52 INFO - 'SHELL': '/bin/bash', 14:24:52 INFO - 'SHLVL': '1', 14:24:52 INFO - 'TERM': 'linux', 14:24:52 INFO - 'TMOUT': '86400', 14:24:52 INFO - 'USER': 'cltbld', 14:24:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', 14:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:52 INFO - '_': '/tools/buildbot/bin/python'} 14:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:24:52 INFO - Cleaning up... 14:24:52 INFO - Return code: 0 14:24:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:52 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 0x25901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2759a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2900090>, '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 0x2900d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28faf90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', '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 14:24:52 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 14:24:52 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 14:24:52 INFO - Using env: {'DISPLAY': ':0', 14:24:52 INFO - 'HOME': '/home/cltbld', 14:24:52 INFO - 'LANG': 'en_US.UTF-8', 14:24:52 INFO - 'LANGUAGE': 'en_US:en', 14:24:52 INFO - 'LOGNAME': 'cltbld', 14:24:52 INFO - 'MAIL': '/var/mail/cltbld', 14:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:52 INFO - 'MOZ_NO_REMOTE': '1', 14:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:52 INFO - 'NO_EM_RESTART': '1', 14:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:52 INFO - 'PWD': '/builds/slave/test', 14:24:52 INFO - 'SHELL': '/bin/bash', 14:24:52 INFO - 'SHLVL': '1', 14:24:52 INFO - 'TERM': 'linux', 14:24:52 INFO - 'TMOUT': '86400', 14:24:52 INFO - 'USER': 'cltbld', 14:24:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', 14:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:52 INFO - '_': '/tools/buildbot/bin/python'} 14:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:52 INFO - Downloading/unpacking blobuploader==1.2.4 14:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:54 INFO - Downloading blobuploader-1.2.4.tar.gz 14:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:24:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:24:54 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 14:24:54 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 14:24:54 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 14:24:54 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 14:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:24:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:24:54 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 14:24:54 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 14:24:54 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 14:24:54 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 14:24:54 INFO - Downloading docopt-0.6.1.tar.gz 14:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:24:54 INFO - Installing collected packages: blobuploader, requests, docopt 14:24:54 INFO - Running setup.py install for blobuploader 14:24:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:24:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:24:54 INFO - Running setup.py install for requests 14:24:55 INFO - Running setup.py install for docopt 14:24:55 INFO - Successfully installed blobuploader requests docopt 14:24:55 INFO - Cleaning up... 14:24:55 INFO - Return code: 0 14:24:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:55 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 0x25901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2759a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2900090>, '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 0x2900d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28faf90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', '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 14:24:55 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 14:24:55 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 14:24:55 INFO - Using env: {'DISPLAY': ':0', 14:24:55 INFO - 'HOME': '/home/cltbld', 14:24:55 INFO - 'LANG': 'en_US.UTF-8', 14:24:55 INFO - 'LANGUAGE': 'en_US:en', 14:24:55 INFO - 'LOGNAME': 'cltbld', 14:24:55 INFO - 'MAIL': '/var/mail/cltbld', 14:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:55 INFO - 'MOZ_NO_REMOTE': '1', 14:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:55 INFO - 'NO_EM_RESTART': '1', 14:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:55 INFO - 'PWD': '/builds/slave/test', 14:24:55 INFO - 'SHELL': '/bin/bash', 14:24:55 INFO - 'SHLVL': '1', 14:24:55 INFO - 'TERM': 'linux', 14:24:55 INFO - 'TMOUT': '86400', 14:24:55 INFO - 'USER': 'cltbld', 14:24:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', 14:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:55 INFO - '_': '/tools/buildbot/bin/python'} 14:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:55 INFO - Running setup.py (path:/tmp/pip-wVn_iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:55 INFO - Running setup.py (path:/tmp/pip-9QLUoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:55 INFO - Running setup.py (path:/tmp/pip-zAE3It-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:55 INFO - Running setup.py (path:/tmp/pip-E1tGt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:55 INFO - Running setup.py (path:/tmp/pip-ulah6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:55 INFO - Running setup.py (path:/tmp/pip-mmaAj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:55 INFO - Running setup.py (path:/tmp/pip-wPOEN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:55 INFO - Running setup.py (path:/tmp/pip-J28z6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:56 INFO - Running setup.py (path:/tmp/pip-G3xIQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:56 INFO - Running setup.py (path:/tmp/pip-gGd7xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:56 INFO - Running setup.py (path:/tmp/pip-D4p2is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:56 INFO - Running setup.py (path:/tmp/pip-XB5FPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:56 INFO - Running setup.py (path:/tmp/pip-DOoP9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:56 INFO - Running setup.py (path:/tmp/pip-kfkLn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:56 INFO - Running setup.py (path:/tmp/pip-7Myl4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:56 INFO - Running setup.py (path:/tmp/pip-XrSaFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:56 INFO - Running setup.py (path:/tmp/pip-Myaq2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:24:56 INFO - Running setup.py install for manifestparser 14:24:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for mozcrash 14:24:56 INFO - Running setup.py install for mozdebug 14:24:56 INFO - Running setup.py install for mozdevice 14:24:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for mozfile 14:24:57 INFO - Running setup.py install for mozhttpd 14:24:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for mozinfo 14:24:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for mozInstall 14:24:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for mozleak 14:24:57 INFO - Running setup.py install for mozlog 14:24:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for moznetwork 14:24:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for mozprocess 14:24:57 INFO - Running setup.py install for mozprofile 14:24:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for mozrunner 14:24:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:24:58 INFO - Running setup.py install for mozscreenshot 14:24:58 INFO - Running setup.py install for moztest 14:24:58 INFO - Running setup.py install for mozversion 14:24:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:24:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:24:58 INFO - Cleaning up... 14:24:58 INFO - Return code: 0 14:24:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:58 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')]} 14:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:58 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')]} 14:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:58 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 0x25901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2759a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2900090>, '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 0x2900d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28faf90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', '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 14:24:58 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 14:24:58 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 14:24:58 INFO - Using env: {'DISPLAY': ':0', 14:24:58 INFO - 'HOME': '/home/cltbld', 14:24:58 INFO - 'LANG': 'en_US.UTF-8', 14:24:58 INFO - 'LANGUAGE': 'en_US:en', 14:24:58 INFO - 'LOGNAME': 'cltbld', 14:24:58 INFO - 'MAIL': '/var/mail/cltbld', 14:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:58 INFO - 'MOZ_NO_REMOTE': '1', 14:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:58 INFO - 'NO_EM_RESTART': '1', 14:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:58 INFO - 'PWD': '/builds/slave/test', 14:24:58 INFO - 'SHELL': '/bin/bash', 14:24:58 INFO - 'SHLVL': '1', 14:24:58 INFO - 'TERM': 'linux', 14:24:58 INFO - 'TMOUT': '86400', 14:24:58 INFO - 'USER': 'cltbld', 14:24:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', 14:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:58 INFO - '_': '/tools/buildbot/bin/python'} 14:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:58 INFO - Running setup.py (path:/tmp/pip-UggyEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:58 INFO - Running setup.py (path:/tmp/pip-bk2oTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:58 INFO - Running setup.py (path:/tmp/pip-fr_iot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:58 INFO - Running setup.py (path:/tmp/pip-lv0jlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:58 INFO - Running setup.py (path:/tmp/pip-mRfWuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:59 INFO - Running setup.py (path:/tmp/pip-z4RJo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:59 INFO - Running setup.py (path:/tmp/pip-YFIyso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:59 INFO - Running setup.py (path:/tmp/pip-y2ArLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:59 INFO - Running setup.py (path:/tmp/pip-sEza6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:59 INFO - Running setup.py (path:/tmp/pip-A_y8BU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:59 INFO - Running setup.py (path:/tmp/pip-GjSWwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:59 INFO - Running setup.py (path:/tmp/pip-hXwGfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:59 INFO - Running setup.py (path:/tmp/pip-qxtQDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:59 INFO - Running setup.py (path:/tmp/pip-gL8Emz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:59 INFO - Running setup.py (path:/tmp/pip-KRcNAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:59 INFO - Running setup.py (path:/tmp/pip-bRDMuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:59 INFO - Running setup.py (path:/tmp/pip-mZ6WYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:59 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)) 14:24:59 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)) 14:24:59 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)) 14:24:59 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)) 14:24:59 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)) 14:24:59 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)) 14:24:59 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)) 14:24:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:24:59 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 14:24:59 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 14:24:59 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 14:24:59 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 14:25:00 INFO - Downloading blessings-1.6.tar.gz 14:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:25:01 INFO - Installing collected packages: blessings 14:25:01 INFO - Running setup.py install for blessings 14:25:01 INFO - Successfully installed blessings 14:25:01 INFO - Cleaning up... 14:25:01 INFO - Return code: 0 14:25:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:25:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:25:01 INFO - Reading from file tmpfile_stdout 14:25:01 INFO - Current package versions: 14:25:01 INFO - argparse == 1.2.1 14:25:01 INFO - blessings == 1.6 14:25:01 INFO - blobuploader == 1.2.4 14:25:01 INFO - docopt == 0.6.1 14:25:01 INFO - functools32 == 3.2.3-2 14:25:01 INFO - jsonschema == 2.5.1 14:25:01 INFO - manifestparser == 1.1 14:25:01 INFO - mozInstall == 1.13 14:25:01 INFO - mozcrash == 1.0 14:25:01 INFO - mozdebug == 0.1 14:25:01 INFO - mozdevice == 0.51 14:25:01 INFO - mozfile == 1.2 14:25:01 INFO - mozhttpd == 0.7 14:25:01 INFO - mozinfo == 0.10 14:25:01 INFO - mozleak == 0.1 14:25:01 INFO - mozlog == 3.5 14:25:01 INFO - moznetwork == 0.27 14:25:01 INFO - mozprocess == 0.25 14:25:01 INFO - mozprofile == 0.28 14:25:01 INFO - mozrunner == 6.13 14:25:01 INFO - mozscreenshot == 0.1 14:25:01 INFO - mozsystemmonitor == 0.3 14:25:01 INFO - moztest == 0.8 14:25:01 INFO - mozversion == 1.4 14:25:01 INFO - psutil == 3.1.1 14:25:01 INFO - requests == 1.2.3 14:25:01 INFO - wsgiref == 0.1.2 14:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:25:01 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')]} 14:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:01 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')]} 14:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:01 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 0x25901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2759a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2900090>, '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 0x2900d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28faf90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', '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 14:25:01 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 14:25:01 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 14:25:01 INFO - Using env: {'DISPLAY': ':0', 14:25:01 INFO - 'HOME': '/home/cltbld', 14:25:01 INFO - 'LANG': 'en_US.UTF-8', 14:25:01 INFO - 'LANGUAGE': 'en_US:en', 14:25:01 INFO - 'LOGNAME': 'cltbld', 14:25:01 INFO - 'MAIL': '/var/mail/cltbld', 14:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:01 INFO - 'MOZ_NO_REMOTE': '1', 14:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:01 INFO - 'NO_EM_RESTART': '1', 14:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:01 INFO - 'PWD': '/builds/slave/test', 14:25:01 INFO - 'SHELL': '/bin/bash', 14:25:01 INFO - 'SHLVL': '1', 14:25:01 INFO - 'TERM': 'linux', 14:25:01 INFO - 'TMOUT': '86400', 14:25:01 INFO - 'USER': 'cltbld', 14:25:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', 14:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:01 INFO - '_': '/tools/buildbot/bin/python'} 14:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:25:01 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 14:25:01 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 14:25:01 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 14:25:01 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 14:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:25:02 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)) 14:25:02 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)) 14:25:02 INFO - Installing collected packages: simplejson 14:25:02 INFO - Running setup.py install for simplejson 14:25:02 INFO - building 'simplejson._speedups' extension 14:25:02 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 14:25:03 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 14:25:03 INFO - Successfully installed simplejson 14:25:03 INFO - Cleaning up... 14:25:03 INFO - Return code: 0 14:25:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:25: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')]} 14:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25: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')]} 14:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:03 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 0x25901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2759a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2900090>, '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 0x2900d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28faf90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', '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 14:25:03 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 14:25:03 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 14:25:03 INFO - Using env: {'DISPLAY': ':0', 14:25:03 INFO - 'HOME': '/home/cltbld', 14:25:03 INFO - 'LANG': 'en_US.UTF-8', 14:25:03 INFO - 'LANGUAGE': 'en_US:en', 14:25:03 INFO - 'LOGNAME': 'cltbld', 14:25:03 INFO - 'MAIL': '/var/mail/cltbld', 14:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:03 INFO - 'MOZ_NO_REMOTE': '1', 14:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:03 INFO - 'NO_EM_RESTART': '1', 14:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:03 INFO - 'PWD': '/builds/slave/test', 14:25:03 INFO - 'SHELL': '/bin/bash', 14:25:03 INFO - 'SHLVL': '1', 14:25:03 INFO - 'TERM': 'linux', 14:25:03 INFO - 'TMOUT': '86400', 14:25:03 INFO - 'USER': 'cltbld', 14:25:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', 14:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:03 INFO - '_': '/tools/buildbot/bin/python'} 14:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:25:04 INFO - Cleaning up... 14:25:04 INFO - Return code: 0 14:25:04 INFO - Running post-action listener: _resource_record_post_action 14:25:04 INFO - Running post-action listener: _start_resource_monitoring 14:25:04 INFO - Starting resource monitoring. 14:25:04 INFO - [mozharness: 2017-09-08 21:25:04.108988Z] Finished create-virtualenv step (success) 14:25:04 INFO - [mozharness: 2017-09-08 21:25:04.109562Z] Running install step. 14:25:04 INFO - Running pre-action listener: _resource_record_pre_action 14:25:04 INFO - Running main action method: install 14:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:25:04 INFO - Reading from file tmpfile_stdout 14:25:04 INFO - Detecting whether we're running mozinstall >=1.0... 14:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:25:04 INFO - Reading from file tmpfile_stdout 14:25:04 INFO - Output received: 14:25:04 INFO - Usage: mozinstall [options] installer 14:25:04 INFO - Options: 14:25:04 INFO - -h, --help show this help message and exit 14:25:04 INFO - -d DEST, --destination=DEST 14:25:04 INFO - Directory to install application into. [default: 14:25:04 INFO - "/builds/slave/test"] 14:25:04 INFO - --app=APP Application being installed. [default: firefox] 14:25:04 INFO - mkdir: /builds/slave/test/build/application 14:25:04 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'] 14:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:25:21 INFO - Reading from file tmpfile_stdout 14:25:21 INFO - Output received: 14:25:21 INFO - /builds/slave/test/build/application/firefox/firefox 14:25:21 INFO - Running post-action listener: _resource_record_post_action 14:25:21 INFO - [mozharness: 2017-09-08 21:25:21.158899Z] Finished install step (success) 14:25:21 INFO - [mozharness: 2017-09-08 21:25:21.159147Z] Running setup-mitmproxy step. 14:25:21 INFO - Running pre-action listener: _resource_record_pre_action 14:25:21 INFO - Running main action method: setup_mitmproxy 14:25:21 INFO - Skipping: mitmproxy is not required 14:25:21 INFO - Running post-action listener: _resource_record_post_action 14:25:21 INFO - [mozharness: 2017-09-08 21:25:21.160264Z] Finished setup-mitmproxy step (success) 14:25:21 INFO - [mozharness: 2017-09-08 21:25:21.160483Z] Running run-tests step. 14:25:21 INFO - Running pre-action listener: _resource_record_pre_action 14:25:21 INFO - Running pre-action listener: _set_gcov_prefix 14:25:21 INFO - Running main action method: run_tests 14:25:21 WARNING - Try message not found. 14:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:25:21 INFO - Python 2.7.3 14:25:21 INFO - Return code: 0 14:25:21 INFO - grabbing minidump binary from tooltool 14:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:21 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 0x2900090>, '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 0x2900d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28faf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:25:21 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 14:25:21 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 14:25:21 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 14:25:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:25:21 INFO - Return code: 0 14:25:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:25:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:25:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:25:21 INFO - ENV: RUST_BACKTRACE is now full 14:25:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:25:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:25:21 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/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 14:25:21 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/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 14:25:21 INFO - Using env: {'DISPLAY': ':0', 14:25:21 INFO - 'HOME': '/home/cltbld', 14:25:21 INFO - 'LANG': 'en_US.UTF-8', 14:25:21 INFO - 'LANGUAGE': 'en_US:en', 14:25:21 INFO - 'LOGNAME': 'cltbld', 14:25:21 INFO - 'MAIL': '/var/mail/cltbld', 14:25:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:25:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:21 INFO - 'MOZ_NO_REMOTE': '1', 14:25:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:21 INFO - 'NO_EM_RESTART': '1', 14:25:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:21 INFO - 'PWD': '/builds/slave/test', 14:25:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:25:21 INFO - 'RUST_BACKTRACE': 'full', 14:25:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:25:21 INFO - 'SHELL': '/bin/bash', 14:25:21 INFO - 'SHLVL': '1', 14:25:21 INFO - 'TERM': 'linux', 14:25:21 INFO - 'TMOUT': '86400', 14:25:21 INFO - 'USER': 'cltbld', 14:25:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', 14:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:21 INFO - '_': '/tools/buildbot/bin/python'} 14:25:21 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/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 14:25:21 INFO - mozversion application_buildid: 20170908203646 14:25:21 INFO - mozversion application_changeset: ea7b55d65d76214f97aaae502d65cb26fc6f5659 14:25:21 INFO - mozversion application_display_name: Nightly 14:25:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:25:21 INFO - mozversion application_name: Firefox 14:25:21 INFO - mozversion application_remotingname: firefox 14:25:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:25:21 INFO - mozversion application_vendor: Mozilla 14:25:21 INFO - mozversion application_version: 57.0a1 14:25:21 INFO - mozversion platform_buildid: 20170908203646 14:25:21 INFO - mozversion platform_changeset: ea7b55d65d76214f97aaae502d65cb26fc6f5659 14:25:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:25:21 INFO - mozversion platform_version: 57.0a1 14:25:21 INFO - using testdate: 1504905921 14:25:21 INFO - actual date: 1504905921 14:25:21 INFO - starting webserver on 'localhost:40850' 14:25:21 INFO - SUITE-START | Running 2 tests 14:25:21 INFO - TEST-START | dromaeo_css 14:25:21 INFO - Initialising browser for dromaeo_css test... 14:25:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40850/getInfo.html -profile /tmp/tmpf7uu_M/profile 14:25:21 INFO - TEST-INFO | started process 25225 (/builds/slave/test/build/application/firefox/firefox http://localhost:40850/getInfo.html) 14:25:26 INFO - TEST-INFO | 25225: exit 0 14:25:27 INFO - Browser initialized. 14:25:27 INFO - Running cycle 1/1 for dromaeo_css test... 14:25:27 INFO - Using env: {'DISPLAY': ':0', 14:25:27 INFO - 'HOME': '/home/cltbld', 14:25:27 INFO - 'JSGC_DISABLE_POISONING': '1', 14:25:27 INFO - 'LANG': 'en_US.UTF-8', 14:25:27 INFO - 'LANGUAGE': 'en_US:en', 14:25:27 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:25:27 INFO - 'LOGNAME': 'cltbld', 14:25:27 INFO - 'MAIL': '/var/mail/cltbld', 14:25:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:25:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:25:27 INFO - 'MOZ_CRASHREPORTER': '1', 14:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:27 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:25:27 INFO - 'MOZ_NO_REMOTE': '1', 14:25:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:27 INFO - 'NO_EM_RESTART': '1', 14:25:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:27 INFO - 'PWD': '/builds/slave/test', 14:25:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:25:27 INFO - 'RUST_BACKTRACE': 'full', 14:25:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:25:27 INFO - 'SHELL': '/bin/bash', 14:25:27 INFO - 'SHLVL': '1', 14:25:27 INFO - 'TERM': 'linux', 14:25:27 INFO - 'TMOUT': '86400', 14:25:27 INFO - 'USER': 'cltbld', 14:25:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', 14:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:27 INFO - '_': '/tools/buildbot/bin/python'} 14:25:27 INFO - TEST-INFO | started process 25421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf7uu_M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:28 INFO - PID 25421 | 14:25:28 INFO - PID 25421 | (/builds/slave/test/build/application/firefox/firefox:25472): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:25:28 INFO - PID 25421 | 14:25:38 INFO - PID 25421 | RSS: Main: 173375488 14:25:38 INFO - PID 25421 | 14:28:35 INFO - PID 25421 | Cycle 1(1): loaded http://localhost:40850/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40850/tests/dromaeo/cssquery-ext.html) 14:28:36 INFO - PID 25421 | RSS: Main: 173871104 14:28:36 INFO - PID 25421 | 14:31:37 INFO - PID 25421 | Cycle 1(1): loaded http://localhost:40850/tests/dromaeo/cssquery-ext.html (next: http://localhost:40850/tests/dromaeo/cssquery-jquery.html) 14:31:38 INFO - PID 25421 | RSS: Main: 169353216 14:31:38 INFO - PID 25421 | 14:34:40 INFO - PID 25421 | Cycle 1(1): loaded http://localhost:40850/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40850/tests/dromaeo/cssquery-mootools.html) 14:34:40 INFO - PID 25421 | RSS: Main: 171778048 14:34:40 INFO - PID 25421 | 14:37:42 INFO - PID 25421 | Cycle 1(1): loaded http://localhost:40850/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40850/tests/dromaeo/cssquery-prototype.html) 14:37:42 INFO - PID 25421 | RSS: Main: 171655168 14:37:42 INFO - PID 25421 | 14:40:46 INFO - PID 25421 | Cycle 1(1): loaded http://localhost:40850/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40850/tests/dromaeo/cssquery-yui.html) 14:40:46 INFO - PID 25421 | RSS: Main: 172171264 14:40:46 INFO - PID 25421 | 14:43:48 INFO - PID 25421 | Cycle 1(1): loaded http://localhost:40850/tests/dromaeo/cssquery-yui.html (next: http://localhost:40850/tests/dromaeo/cssquery-dojo.html) 14:43:48 INFO - PID 25421 | RSS: Main: 175259648 14:43:48 INFO - PID 25421 | 14:43:48 INFO - PID 25421 | __start_tp_report 14:43:48 INFO - PID 25421 | _x_x_mozilla_page_load 14:43:48 INFO - PID 25421 | _x_x_mozilla_page_load_details 14:43:48 INFO - PID 25421 | |i|pagename|runs| 14:43:48 INFO - PID 25421 | |0;dojo.html;3066.8926587569435;3119.2669722615183;3131.7181453669173;3145;3152.2749767553446;6116.724747386367;6230.5638605297645;6261.843453913654;6324.462420694241;6380.553361264713;6192.256929168506;6269.6238225706375;6339.11252424661;6393.392627700373;6432.42108210261;5774.335951365584;5830.387809280028;5833.708314584275;5873.148393482942;5900.321463031742;60.88063090152337;5644.04051311276;5702.743376548045;5736.110902810071;5784.68184249866;5718.399568045378;5725.083986562151;5784.652920824743;5793.33376661683;5793.5365170786445;5712.428757124296;5739.225204597367;5783.392743761887;5798.710064496759;5805.970970145122;5703;5722.713864306768;5780.132980052984;5786.508146807527;5798.942010579883;6050.48570871472;6237.812865614039;6289.0252010938375;6308.526860485482;6340.746370145189;6638;6666.400023997863;6689.030090636879;6732.360425759545;6742.865142697118;6793.320667933217;6814.557053791487;6831.419329357011;6836.794896153124;6843.726250949956;6066.150738896558;6145.508359331243;6230.408111229426;6234.968825155891;6288.245410550763;6876.071730316393;6899.862002759916;6926.722931082701;6935.271796461399;6942.965285173542;6515.02274658805;6532.281449040602;6536.673166341664;6604.735810567619;6654.23476300222;6612.371824676648;6717.126773519509;6727.66361681914;6785.491088168407;6794.4904132189295;6691.063251144844;6725.899111513331;6736.865262694719;6761.425278851254;6772.762953296611;6693.631850248283;6734.629595372302;6785.11793466856;6793.59238445685;6806.659667016629;5259.132243179909;5260.158374660036;5268.894622107537;5330.067238233293;5333.493318134771;4559.840405585788;4586.793594288199;4623.583877450978;4644.837430689977;4660.254359302496;5767.048437007847;5794.536437085023;5865.824025279248;5873.177755114288;5885.176075349455;6651.068850360954;6795.422389096883;6824.078749368871;6826.658667066627;6826.897596536056;5792.88414231713;5801.622894511843;5857.941420585825;5887.322957859816;5897.380775018647;5643.040683083886;5737.713114344349;5755.568332375088;5791.9131213031;5820.447057529528;6503.9349606504275;6504.089427480157;6510.381513756186;6526.412622863965;6569.57297775643;6572.375624315682;6671.266160722414;6735.966320168368;6770;6770.72917083321;6403.6798160090875;6432.421082102634;6452.838679033061;6523.934760652332;6547.148870646785;6609.140811694641;6614.6361950093205;6624.33756624353;6635.170603674541;6659.267480577229;6563.573367731082;6702.765403210864;6769.526133170828;6805.727770889109;6823.795286141423;6312.936870631419;6394;6506.837329066811;6534.705938232696;6560.573562718408;6483.967580162069;6565.901511477236;6570.5729127606555;6574.671266436755;6585.769498067544;6276.874462510816;6393.552451328548;6401.071844582602;6483.222013358427;6492.383223593751;6430.5177111715875;6505.934940650533;6510.5117116217425;6562.343765623399;6573.868522629617;6331.841703957438;6359.17330747;6360.586561873649;6413.038044293393;6417.454516366161 14:43:48 INFO - PID 25421 | |1;ext.html;771.1401787007486;794.2018271637007;796.3867821777231;797.0554892452441;798.269583331252;39559.80220098899;43124.568754312444;43233;43248.13503729924;43259.3511097333;38642.613573864255;38992;39010.21979560407;39034.8048259759;39107.21785564287;6987.301269872997;7156.964215178917;7161.104861892263;7905.130435652074;8157.592120393986;7959.880601790977;8066.193380661945;8076.232757887991;8076.596170191497;8080.39397045221;8046.798830029267;8117.715879944203;8118.147594502551;8120.553369564672;8123.187681231859;8046.275835174833;8079.313258373046;8081.4747041442415;8093.554854483001;8094.919050809475;7841.294283514454;7968.322692571139;7970.641321140504;7974.242446967529;7977;39222.41166382506;39423.21153576912;39426.408603870965;39492.21015579701;39492.407613885814;3577.105723569108;3608.9458658120147;3620.7646502977223;3622.5834029086727;3622.9275414491563;32895.83552082248;33085.6691433085;33189.50215746766;33240.501392479135;33265.33469330624;5239.449857764918;5251.9212211816475;5278.841634750964;5298.735063246861;5302.072137375943;187255;187810;187843;188177;188474;42706.78646606747;42988.78505607452;48780.26829597488;48839.75580122077;48957.51042489529;53076.46923530792;53363.733181333846;53505.7324713374;53577.732111339195;53627.19559206615;16136.273867675984;16240.187990600423;16243.269052892649;16287.267072981744;16363.181840907908;13303.73392532144;13310.66723331905;13333.866661333457;13341.66645833862;13351.73296534064;14373.78439323411;14443.638909027359;14553.345099470549;14565.490207842675;14586.562403127924;5936.7031648417405;6056.66688332146;6097.847553811191;6118.715069835295;6121.357257487989;1002.7392877851811;1007.3049595778889;1008.5108722269694;1011.8886922438526;1031.4120951057826;22711.659325110137;22771.886140569524;22821;23004.19485318006;23109.653355199687;1097.1058587251364;1121.9270747401392;1124.1905827803969;1125.3641692443744;1126.0316128129803;12000.87999120015;12021.819672704916;12104.455299511543;12263.632091037283;12283.877161228453;217179;217848;218024;218283;218780;53034.67413314698;53380;53562;53570.73214633902;53871.46128538743;1451.608065822201;1467.5744034230167;1472.779083137538;1486.7695507196402;1490.2623201515319;22240.66639000384;22578;22636.773632263466;22741.658875117217;22790.544189116456;37851.432228516045;37864.242715146094;37871;37995.24009519739;38056.80971595124;134767;135138;135202.32398837942;135338;135486;34707.305853883285;36557.634423656484;36880.44679329866;37147.25705485821;37220.62779372172;46855;47011.764941175075;47117.29324060073;47258.527414726785;47312;33435.16412089717;33767.66232337744;33943.4908476378;34072.31855362929;34668.47997280093;33855.661443386234;33995.3200935975;34001.97994060182;34183.487247690806;34705.82647086748;38031.619683802805;38035;38085.23829523449;38171;38323.233535329695;32233.194170144994;32334;32854.67145328516;32889.17777055593;33357.66642333545;24013.399665007815;24354.02583896624;24369.39076523101;24424.511509770062;25095.24714258575 14:43:48 INFO - PID 25421 | |2;jquery.html;557.2727590494403;564.4919572384856;572.5019233267059;578.4418036594686;588.0796553393939;22194.667079993793;22999;23000;23007.769922300773;23094.30717078486;23051.884740576315;23946.76053239467;24120.276391708234;24247;24280.39299017521;6412.743490260395;6528.7714929977465;6565.967170164143;6578.8684226315445;6584.2098948126295;6423.421892029716;6479.93520064798;6582.341765823403;6588.802335929906;6665.633390163539;6618.669066546678;6619.073329733841;6619.404253617174;6621.867562648744;6621.900671489908;6620.966895165518;6631.502637302197;6632.801015969529;6667.93332066678;6669.933300666979;5900.616459930091;6123.755049798003;6128.63228206309;6128.662923539204;6130.8773824523705;27826.443471130464;28246.576301355497;28254.85872570624;28267.71732282692;28286.85856570704;1970.7142464342733;1993.1429485321305;1994.4116485636628;1999.4601457606511;2003.24878170686;19023.61952760951;19144.61710765777;19429.417117486497;19448.611027779367;19683.11425985834;2321.0483701682397;2346.1436575649764;2367.9763202367926;2376.2752360530203;2411.7467665895006;121576.39211803973;127132;128316;132207;133807;14694.55916322512;14712.485063022958;14785.11289322644;14850.960432769818;14941.982832317499;22233.666495002588;22274.331770046923;22298.777012229995;22304.10783568639;22340.106395744315;10158.746031349276;10277.691669249934;10297.639582614573;10365.170786337076;10462.163026957825;9597.424154550748;9599.280053995979;9606.855897161548;9681.37071090377;9699.272554558294;8952.820943581091;9129.224015958585;9148.908510914805;9199.264058875275;9230.169284764403;2700.405910699643;2711.180372412708;2718.6058021587155;2768.43247134337;2804.1026871401364;939.2251392600995;940.6660635474445;959.318883592657;959.7600599850037;974.848898420746;18427.72358414625;18731.157097930627;18776.624467510574;18884.15021324044;18989.33537326187;969.413504829582;983.1446641422009;998.8662867645274;1004.4023805835516;1009.5810238750836;10278.434686092336;10329.74175645615;10334.638287659896;10361.222908281909;10519.84220236697;427592;439579;451068;472139;473118;109266;111150;111381.44309278401;112250.43874780573;112426;1010.9443980580992;1067.791780602775;1127.1377396291844;1139.680889350983;1184.3841202574786;19089;19528.707069393688;19606.000939521233;19923.501912452306;19991.700124498435;54308.45691543192;55030;55609.88780224292;56632.43367566436;58562;68380.31619683938;68494.65752671404;68537;68549.65725171342;69400.3059969414;12990;13186;13218.140820846615;13250.072494925264;13312.866871331551;21579.2447264345;21688.783112168676;21746.238881639067;21837.78162218421;21921.342359729235;17268.827311727226;17304.221310040826;17424.47726568205;17595.736063958793;17606.295748170443;15616.843831561993;16086.919565402566;16119.435819746253;16211.35154593803;16524.421645242357;17465.738013929546;17898.463046108638;17936;18001.819981800538;18024.63950720952;13074.411651475897;13156.079074464695;13171.407286672315;13174.40715167839;13195.274259915413;17196;17604.38384656531;17609.823901760818;17663.735043974608;17665.823341766933 14:43:48 INFO - PID 25421 | |3;mootools.html;1269.5112381733031;1343.4491858338083;1389.8957578181632;1398.6293632187467;1398.748225319442;15620.843791562082;15969.121698306588;15994.120323382209;16097.517074487769;16147.919260403696;15568.14375209363;15674.373025079012;15696.84303156971;15728.606784830385;15749.921250393732;2713.8236014659083;2753.752162305392;2784.763295119917;2786.512360336943;2789.2329609357384;2745.4509098180442;2830.80184387093;2842.559403292493;2843.274964883962;2847.9715202848015;2634.2492389668946;2731.549294366427;2732.617433559303;2804.901828436005;2808.5927540506614;2799.1882354117283;2809.2976755811046;2836.049923275705;2839.0489186122672;2840.758535524483;2699.824511406752;2741.3420779013095;2758.544840101381;2763.668359796817;2765.14280573023;14683.412663493447;15025.398984040625;15031.924840375837;15068.246587670572;15094.924525377302;7514.774556763306;7769.067711874554;7775.961120194363;7776.144624091346;7784.910112584243;5316.734163291859;5382.327209098863;5463.399026107125;5584.134459158837;5592.748326325284;1926.402815127315;1929.4983304340833;1951.9121639526256;1981.7126516655005;2050.76416212136;26459.867700661373;26578;26722.19833405001;26730;26798.062067827534;6688.498362622823;6838.760643377458;6870.828229294208;6960.79117626472;7012.088428504262;17146.742798858028;17159.742603860952;17178.141092945552;17198.31206751741;17198.656026879642;7616.504927179826;7733.883991740128;7749.612519374009;7756.108047574488;7761.72833950809;7100.289971002859;7156.534825236343;7258.165310989199;7410.184879663233;7515.94776731258;4942.184539550934;5084.796608135707;5126.92309615356;5129.615278854101;5137.332146820964;1279.5841351560593;1552.4178433087593;1553.7980062591791;1560.7112684153467;1583.081812548719;736.5543845973216;873.057098333798;891.6611687558686;894.9686760963465;899.1458114790975;7851.9214807851195;7906.7627971160955;7916.445848790529;7940.364770818321;7958.721444749406;970.5729479029204;980.7695191629962;981.0924894472727;983.7737320416344;1000.2398177385239;4182.309918863414;4190.622843943998;4266.573342665771;4320.200762858881;4322.654187664979;20569.69145462819;21437.571248574943;21448.249311274343;21632.134714611555;21645.67531487029;17432.738508922375;18803.81196188048;20937.476563086046;21023.15907363719;21123.366299011053;10579.894201058045;10795.40625265618;10922.672319830417;10946.671599852018;10988.395638239814;8428.199321064489;8710.82578348442;8863.64545418176;9012.143846334588;9115.407498512575;18060;18200.089995500435;18375.26498940081;18415.90792046031;18635.161417735962;18698.252069917595;18891.055447227307;19028.429147125607;19164.904175479034;19510.90244548825;12182.208156470155;12274.81587776202;12404.62786116418;12432.191907526343;12444.31556264378;13735;13911.721765564835;14003.299835008413;14043;14069.718605627626;11471.369074700639;11476.770464590829;11551.364674942959;11751.529938802352;11900.226485278428;11246.493907774005;11289.548418063185;11500.712482188012;11671.416429178676;11857.229280096766;8834.911650883667;8990.415622984485;8995.370324077252;8998.100189980949;9003;6826.351496607815;6875.724971001104;6926.58440493572;6938.826529336807;6939.201991771011;7106.786796396116;7129.287071292829;7137.429005679429;7168.2831716827895;7193.676284567103 14:43:48 INFO - PID 25421 | |4;prototype.html;493.32531798967534;528.3501293409109;528.888933324002;532.4302995794499;532.7256462921594;6382.297947225801;6395.48836093112;6405.583637063599;6449.645269510175;6459;6238.937610623892;6294.150289710888;6347.36526347365;6354.968225158879;6366.331535188808;4903.16131450706;5031.647784655075;5083.466236045218;5234.214867769827;5265;5041.7143628374715;5060.342155519777;5063.84808455745;5102;5120.948790512103;4925.950740492603;4975.527324904128;4988.42633097193;5015.448300686921;5031.993601279741;4967.875803104916;5013.6490445668815;5035.269885866565;5048.242763585455;5056.595472362221;4505.684602077856;4523.525029871849;4532.229520981408;4542.341360502742;4576.649888282965;6012.96993515034;6122.234720659918;6176.795524872651;6212;6286.559940804145;5599.776008959637;5668.858278543028;5672.149177623348;5682.659040457585;5713.942860571424;6508.186476690414;6547.869042619121;6550.213974323064;6559;6627.707597018583;4841.7337046462435;4843.75781210938;4860.270959356089;4866.635002374836;4905.607551395916;6592.077109204715;6614.305497922697;6784.219814721321;6787.72849086036;6953.860922781516;4989.800407983713;5006.3491746073505;5035.899282014412;5035.974820125876;5092.159793634009;5060.367454068241;5085.491450854959;5101.7194054327365;5108.412532558729;5145.125328694131;5623.216507828651;5671.149327600893;5686.346070201897;5757;5806.2451881255165;6625.238097618739;6729.6971636276485;6742.258351581322;6773.8645227095185;6792.626405547742;1774.4676597020841;1779.128227168678;1779.4038996935913;1794.6410717856481;1801.7837859456688;1160.802663547199;1213.0598785940967;1219.615821016377;1231.3720002798636;1232.3468561662332;5793.623414478046;5797.768089276466;5803.187553742479;5851.034579294369;5869.060950248026;6741.696623651947;6774.729010839511;6783.321667833177;6887.483438742114;6909.965450172817;5762.884742305214;5792.536597072309;5796.565257605696;5800.535957123504;5843.474087332075;3562.5724913010604;3563.3585954528435;3574.6425357464564;3589.9820500897326;3608.440691692792;6300.889202117342;6371.55399122057;6459.61242325462;6531.575447595891;6578.769743059066;6321.241451025906;6744.258131605519;6767.221769496472;6790.287019862843;6874.621895795679;6340.556161068773;6436;6485.221773387224;6518.28298887122;6552.410283074546;6609.900851487328;6661.500387470862;6680.899786503109;6703.4972377070935;6708.932910670831;6608.645227728401;6648.634325112165;6703.899441508479;6726.905623413089;6751.257361690308;6446.161998940108;6446.323136070832;6465.450436712932;6476.255230648536;6523.129822877919;4927.211646136601;4937.654364194472;5012.223105418666;5042.294078828893;5049.57078648319;6597.175353080865;6617.933820661924;6666.566673166229;6793;6801.149856267966;6559.196221039252;6578.210614726264;6602.141721576164;6604.273529911609;6607.240167380813;6570.5729127606555;6586.209654841449;6588.637624930675;6593.736250549924;6595.670216489252;6489.884855269403;6490.383413575702;6496.447801936888;6509.665518568777;6561.210316468909;6642.634655094016;6657.833554161185;6670.866582668416;6676.397664560568;6734.191896972395;6421.068945003042;6422;6449.871002579828;6458.870822583616;6478.222613286436 14:43:48 INFO - PID 25421 | |5;yui.html;886.1315910407804;899.4783025845009;914.9752277449257;918.0406475233384;937.9249660027197;17102.144892755357;17722.556936076588;17842.464726058206;17851.928884266938;17853.285868565243;17764.200610972504;17896;17911.28354865807;18016.18927148278;18661.813381866177;963.32085879455;974.0308393148827;974.907383798538;975.8438649816031;978.5009645080988;955.0544960489135;957.0333962697656;958.2334132693852;958.5782255807458;961.620160036785;1034.57065317893;1038.169464428458;1039.8960103989616;1044.4621020174616;1044.5612842606085;1022.7443139215196;1024.329064462778;1027.7790275090817;1029.4955471818791;1031.2162756305263;764.8814433762776;764.942629302799;767.3055884424605;767.4781148818801;769.869122249219;20296.391108266776;20325.491862703402;20591.58816823655;20643.380698579065;20644;21246.787532124636;21272.46818829526;21810.672839907413;21833.126674932984;21883.67174492384;16600.584985375343;16682.916585417115;16795.0762708051;16805.57986050346;16842.41051563202;3784.564775050877;3788.6021967693546;3801.2777572261184;3805.1438426354125;3815.8664446744233;140473.24651496712;143519;144516;144749.99999999895;145596;16374.83625163757;16501.33994640201;16543.420980265633;16612.916935415487;16703.999999999756;30492.390152196833;31209.8439507801;31312.53031204534;31419.214519636735;31475.84262078675;7915.722949696733;8024.358051355877;8056.83886322282;8076.192380761877;8117.675292988214;4089.488813898263;4137.420761093449;4144.48193975753;4145.97927010363;4147.730397524151;5362.8659283517445;5376.301080859464;5485.835424937259;5501.064818980783;5515.310586176728;1002.1131298800468;1009.4094954451581;1021.9846702299471;1022.4938655365642;1025.195221750922;655.8360409897525;668.582136164897;681.1757773094611;686.9519133660596;687.3916583823352;11584.942075289739;11761.88238117625;11938.52245910154;12413.565525206574;12432.875671243353;670.7518218259275;683.6923384477005;688.4905170174135;690.0925283252507;695.9512834101564;5611.9337325907945;5660.433956604389;5663.716814159276;5675.5459563234845;5741.827745167651;117363;117731.41134294274;120414.39792801155;122030;123586;100537;102917;103982;105483.47258263659;108210.45894770476;92359.53820230855;94925.5253723727;95377;97183;97926.0207397917;10474.633387831389;10480.109190718875;10577.418241996456;10613.893861061291;10639;43285.35071973986;43306.78346608247;43750.78124609357;44793.552064478936;44975.550244498445;54890;56446.43553564576;56577.434225658864;57866.4213357861;58740.412595873495;14482.565523034325;14674.046186997812;14772.55682329532;14807.111573305636;14816.777748334;15492.457763978207;15695.921520392325;15755.369785208923;15890.284937177623;15906.681866362376;13568.389422475815;13734.519291824738;13794.86205137976;13932.164070155823;13984.37070331817;13050.216986980811;13096.410661520064;13210.669733256746;13279.66800829987;13295;13631.454741810614;13677;13700.45198192061;13758.587242382744;13808.654783630087;9614.519274036411;9620.278479113955;9755.122039016522;9756.85364719544;9954.601815927283;9547.961959913026;9604.327697061419;9718.076782705632;9741.805163896825;9888.208943284664 14:43:48 INFO - PID 25421 | __end_tp_report 14:43:48 INFO - PID 25421 | __start_cc_report 14:43:48 INFO - PID 25421 | _x_x_mozilla_cycle_collect,366 14:43:48 INFO - PID 25421 | __end_cc_report 14:43:48 INFO - PID 25421 | __startTimestamp1504907028703__endTimestamp 14:43:48 INFO - PID 25421 | 14:43:48 INFO - PID 25421 | ------- Summary: start ------- 14:43:48 INFO - PID 25421 | Number of tests: 6 14:43:48 INFO - PID 25421 | 14:43:48 INFO - PID 25421 | [#0] dojo.html Cycles:165 Average:6139.47 Median:6403.68 stddev:881.32 (13.8%) stddev-sans-first:850.42 14:43:48 INFO - PID 25421 | Values: 3066.9 3119.3 3131.7 3145.0 3152.3 6116.7 6230.6 6261.8 6324.5 6380.6 6192.3 6269.6 6339.1 6393.4 6432.4 5774.3 5830.4 5833.7 5873.1 5900.3 60.9 5644.0 5702.7 5736.1 5784.7 5718.4 5725.1 5784.7 5793.3 5793.5 5712.4 5739.2 5783.4 5798.7 5806.0 5703.0 5722.7 5780.1 5786.5 5798.9 6050.5 6237.8 6289.0 6308.5 6340.7 6638.0 6666.4 6689.0 6732.4 6742.9 6793.3 6814.6 6831.4 6836.8 6843.7 6066.2 6145.5 6230.4 6235.0 6288.2 6876.1 6899.9 6926.7 6935.3 6943.0 6515.0 6532.3 6536.7 6604.7 6654.2 6612.4 6717.1 6727.7 6785.5 6794.5 6691.1 6725.9 6736.9 6761.4 6772.8 6693.6 6734.6 6785.1 6793.6 6806.7 5259.1 5260.2 5268.9 5330.1 5333.5 4559.8 4586.8 4623.6 4644.8 4660.3 5767.0 5794.5 5865.8 5873.2 5885.2 6651.1 6795.4 6824.1 6826.7 6826.9 5792.9 5801.6 5857.9 5887.3 5897.4 5643.0 5737.7 5755.6 5791.9 5820.4 6503.9 6504.1 6510.4 6526.4 6569.6 6572.4 6671.3 6736.0 6770.0 6770.7 6403.7 6432.4 6452.8 6523.9 6547.1 6609.1 6614.6 6624.3 6635.2 6659.3 6563.6 6702.8 6769.5 6805.7 6823.8 6312.9 6394.0 6506.8 6534.7 6560.6 6484.0 6565.9 6570.6 6574.7 6585.8 6276.9 6393.6 6401.1 6483.2 6492.4 6430.5 6505.9 6510.5 6562.3 6573.9 6331.8 6359.2 6360.6 6413.0 6417.5 14:43:48 INFO - PID 25421 | 14:43:48 INFO - PID 25421 | [#1] ext.html Cycles:180 Average:35949.07 Median:20090.28 stddev:47602.28 (236.9%) stddev-sans-first:47662.52 14:43:48 INFO - PID 25421 | Values: 771.1 794.2 796.4 797.1 798.3 39559.8 43124.6 43233.0 43248.1 43259.4 38642.6 38992.0 39010.2 39034.8 39107.2 6987.3 7157.0 7161.1 7905.1 8157.6 7959.9 8066.2 8076.2 8076.6 8080.4 8046.8 8117.7 8118.1 8120.6 8123.2 8046.3 8079.3 8081.5 8093.6 8094.9 7841.3 7968.3 7970.6 7974.2 7977.0 39222.4 39423.2 39426.4 39492.2 39492.4 3577.1 3608.9 3620.8 3622.6 3622.9 32895.8 33085.7 33189.5 33240.5 33265.3 5239.4 5251.9 5278.8 5298.7 5302.1 187255.0 187810.0 187843.0 188177.0 188474.0 42706.8 42988.8 48780.3 48839.8 48957.5 53076.5 53363.7 53505.7 53577.7 53627.2 16136.3 16240.2 16243.3 16287.3 16363.2 13303.7 13310.7 13333.9 13341.7 13351.7 14373.8 14443.6 14553.3 14565.5 14586.6 5936.7 6056.7 6097.8 6118.7 6121.4 1002.7 1007.3 1008.5 1011.9 1031.4 22711.7 22771.9 22821.0 23004.2 23109.7 1097.1 1121.9 1124.2 1125.4 1126.0 12000.9 12021.8 12104.5 12263.6 12283.9 217179.0 217848.0 218024.0 218283.0 218780.0 53034.7 53380.0 53562.0 53570.7 53871.5 1451.6 1467.6 1472.8 1486.8 1490.3 22240.7 22578.0 22636.8 22741.7 22790.5 37851.4 37864.2 37871.0 37995.2 38056.8 134767.0 135138.0 135202.3 135338.0 135486.0 34707.3 36557.6 36880.4 37147.3 37220.6 46855.0 47011.8 47117.3 47258.5 47312.0 33435.2 33767.7 33943.5 34072.3 34668.5 33855.7 33995.3 34002.0 34183.5 34705.8 38031.6 38035.0 38085.2 38171.0 38323.2 32233.2 32334.0 32854.7 32889.2 33357.7 24013.4 24354.0 24369.4 24424.5 25095.2 14:43:48 INFO - PID 25421 | 14:43:48 INFO - PID 25421 | [#2] jquery.html Cycles:180 Average:32965.40 Median:22301.44 stddev:76459.30 (342.8%) stddev-sans-first:76635.07 14:43:48 INFO - PID 25421 | Values: 557.3 564.5 572.5 578.4 588.1 22194.7 22999.0 23000.0 23007.8 23094.3 23051.9 23946.8 24120.3 24247.0 24280.4 6412.7 6528.8 6566.0 6578.9 6584.2 6423.4 6479.9 6582.3 6588.8 6665.6 6618.7 6619.1 6619.4 6621.9 6621.9 6621.0 6631.5 6632.8 6667.9 6669.9 5900.6 6123.8 6128.6 6128.7 6130.9 27826.4 28246.6 28254.9 28267.7 28286.9 1970.7 1993.1 1994.4 1999.5 2003.2 19023.6 19144.6 19429.4 19448.6 19683.1 2321.0 2346.1 2368.0 2376.3 2411.7 121576.4 127132.0 128316.0 132207.0 133807.0 14694.6 14712.5 14785.1 14851.0 14942.0 22233.7 22274.3 22298.8 22304.1 22340.1 10158.7 10277.7 10297.6 10365.2 10462.2 9597.4 9599.3 9606.9 9681.4 9699.3 8952.8 9129.2 9148.9 9199.3 9230.2 2700.4 2711.2 2718.6 2768.4 2804.1 939.2 940.7 959.3 959.8 974.8 18427.7 18731.2 18776.6 18884.2 18989.3 969.4 983.1 998.9 1004.4 1009.6 10278.4 10329.7 10334.6 10361.2 10519.8 427592.0 439579.0 451068.0 472139.0 473118.0 109266.0 111150.0 111381.4 112250.4 112426.0 1010.9 1067.8 1127.1 1139.7 1184.4 19089.0 19528.7 19606.0 19923.5 19991.7 54308.5 55030.0 55609.9 56632.4 58562.0 68380.3 68494.7 68537.0 68549.7 69400.3 12990.0 13186.0 13218.1 13250.1 13312.9 21579.2 21688.8 21746.2 21837.8 21921.3 17268.8 17304.2 17424.5 17595.7 17606.3 15616.8 16086.9 16119.4 16211.4 16524.4 17465.7 17898.5 17936.0 18001.8 18024.6 13074.4 13156.1 13171.4 13174.4 13195.3 17196.0 17604.4 17609.8 17663.7 17665.8 14:43:48 INFO - PID 25421 | 14:43:48 INFO - PID 25421 | [#3] mootools.html Cycles:180 Average:9280.84 Median:2736.98 stddev:6636.77 (242.5%) stddev-sans-first:6628.09 14:43:48 INFO - PID 25421 | Values: 1269.5 1343.4 1389.9 1398.6 1398.7 15620.8 15969.1 15994.1 16097.5 16147.9 15568.1 15674.4 15696.8 15728.6 15749.9 2713.8 2753.8 2784.8 2786.5 2789.2 2745.5 2830.8 2842.6 2843.3 2848.0 2634.2 2731.5 2732.6 2804.9 2808.6 2799.2 2809.3 2836.0 2839.0 2840.8 2699.8 2741.3 2758.5 2763.7 2765.1 14683.4 15025.4 15031.9 15068.2 15094.9 7514.8 7769.1 7776.0 7776.1 7784.9 5316.7 5382.3 5463.4 5584.1 5592.7 1926.4 1929.5 1951.9 1981.7 2050.8 26459.9 26578.0 26722.2 26730.0 26798.1 6688.5 6838.8 6870.8 6960.8 7012.1 17146.7 17159.7 17178.1 17198.3 17198.7 7616.5 7733.9 7749.6 7756.1 7761.7 7100.3 7156.5 7258.2 7410.2 7515.9 4942.2 5084.8 5126.9 5129.6 5137.3 1279.6 1552.4 1553.8 1560.7 1583.1 736.6 873.1 891.7 895.0 899.1 7851.9 7906.8 7916.4 7940.4 7958.7 970.6 980.8 981.1 983.8 1000.2 4182.3 4190.6 4266.6 4320.2 4322.7 20569.7 21437.6 21448.2 21632.1 21645.7 17432.7 18803.8 20937.5 21023.2 21123.4 10579.9 10795.4 10922.7 10946.7 10988.4 8428.2 8710.8 8863.6 9012.1 9115.4 18060.0 18200.1 18375.3 18415.9 18635.2 18698.3 18891.1 19028.4 19164.9 19510.9 12182.2 12274.8 12404.6 12432.2 12444.3 13735.0 13911.7 14003.3 14043.0 14069.7 11471.4 11476.8 11551.4 11751.5 11900.2 11246.5 11289.5 11500.7 11671.4 11857.2 8834.9 8990.4 8995.4 8998.1 9003.0 6826.4 6875.7 6926.6 6938.8 6939.2 7106.8 7129.3 7137.4 7168.3 7193.7 14:43:48 INFO - PID 25421 | 14:43:48 INFO - PID 25421 | [#4] prototype.html Cycles:180 Average:5542.41 Median:6290.36 stddev:1547.82 (24.6%) stddev-sans-first:1505.06 14:43:48 INFO - PID 25421 | Values: 493.3 528.4 528.9 532.4 532.7 6382.3 6395.5 6405.6 6449.6 6459.0 6238.9 6294.2 6347.4 6355.0 6366.3 4903.2 5031.6 5083.5 5234.2 5265.0 5041.7 5060.3 5063.8 5102.0 5120.9 4926.0 4975.5 4988.4 5015.4 5032.0 4967.9 5013.6 5035.3 5048.2 5056.6 4505.7 4523.5 4532.2 4542.3 4576.6 6013.0 6122.2 6176.8 6212.0 6286.6 5599.8 5668.9 5672.1 5682.7 5713.9 6508.2 6547.9 6550.2 6559.0 6627.7 4841.7 4843.8 4860.3 4866.6 4905.6 6592.1 6614.3 6784.2 6787.7 6953.9 4989.8 5006.3 5035.9 5036.0 5092.2 5060.4 5085.5 5101.7 5108.4 5145.1 5623.2 5671.1 5686.3 5757.0 5806.2 6625.2 6729.7 6742.3 6773.9 6792.6 1774.5 1779.1 1779.4 1794.6 1801.8 1160.8 1213.1 1219.6 1231.4 1232.3 5793.6 5797.8 5803.2 5851.0 5869.1 6741.7 6774.7 6783.3 6887.5 6910.0 5762.9 5792.5 5796.6 5800.5 5843.5 3562.6 3563.4 3574.6 3590.0 3608.4 6300.9 6371.6 6459.6 6531.6 6578.8 6321.2 6744.3 6767.2 6790.3 6874.6 6340.6 6436.0 6485.2 6518.3 6552.4 6609.9 6661.5 6680.9 6703.5 6708.9 6608.6 6648.6 6703.9 6726.9 6751.3 6446.2 6446.3 6465.5 6476.3 6523.1 4927.2 4937.7 5012.2 5042.3 5049.6 6597.2 6617.9 6666.6 6793.0 6801.1 6559.2 6578.2 6602.1 6604.3 6607.2 6570.6 6586.2 6588.6 6593.7 6595.7 6489.9 6490.4 6496.4 6509.7 6561.2 6642.6 6657.8 6670.9 6676.4 6734.2 6421.1 6422.0 6449.9 6458.9 6478.2 14:43:48 INFO - PID 25421 | 14:43:48 INFO - PID 25421 | [#5] yui.html Cycles:180 Average:23759.51 Median:21259.63 stddev:35324.83 (166.2%) stddev-sans-first:35382.17 14:43:48 INFO - PID 25421 | Values: 886.1 899.5 915.0 918.0 937.9 17102.1 17722.6 17842.5 17851.9 17853.3 17764.2 17896.0 17911.3 18016.2 18661.8 963.3 974.0 974.9 975.8 978.5 955.1 957.0 958.2 958.6 961.6 1034.6 1038.2 1039.9 1044.5 1044.6 1022.7 1024.3 1027.8 1029.5 1031.2 764.9 764.9 767.3 767.5 769.9 20296.4 20325.5 20591.6 20643.4 20644.0 21246.8 21272.5 21810.7 21833.1 21883.7 16600.6 16682.9 16795.1 16805.6 16842.4 3784.6 3788.6 3801.3 3805.1 3815.9 140473.2 143519.0 144516.0 144750.0 145596.0 16374.8 16501.3 16543.4 16612.9 16704.0 30492.4 31209.8 31312.5 31419.2 31475.8 7915.7 8024.4 8056.8 8076.2 8117.7 4089.5 4137.4 4144.5 4146.0 4147.7 5362.9 5376.3 5485.8 5501.1 5515.3 1002.1 1009.4 1022.0 1022.5 1025.2 655.8 668.6 681.2 687.0 687.4 11584.9 11761.9 11938.5 12413.6 12432.9 670.8 683.7 688.5 690.1 696.0 5611.9 5660.4 5663.7 5675.5 5741.8 117363.0 117731.4 120414.4 122030.0 123586.0 100537.0 102917.0 103982.0 105483.5 108210.5 92359.5 94925.5 95377.0 97183.0 97926.0 10474.6 10480.1 10577.4 10613.9 10639.0 43285.4 43306.8 43750.8 44793.6 44975.6 54890.0 56446.4 56577.4 57866.4 58740.4 14482.6 14674.0 14772.6 14807.1 14816.8 15492.5 15695.9 15755.4 15890.3 15906.7 13568.4 13734.5 13794.9 13932.2 13984.4 13050.2 13096.4 13210.7 13279.7 13295.0 13631.5 13677.0 13700.5 13758.6 13808.7 9614.5 9620.3 9755.1 9756.9 9954.6 9548.0 9604.3 9718.1 9741.8 9888.2 14:43:48 INFO - PID 25421 | -------- Summary: end -------- 14:43:48 INFO - PID 25421 | 14:43:49 INFO - TEST-INFO | 25421: exit 0 14:43:49 INFO - TEST-OK | dromaeo_css | took 1107908ms 14:43:49 INFO - TEST-START | kraken 14:43:49 INFO - Initialising browser for kraken test... 14:43:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40850/getInfo.html -profile /tmp/tmpHhtJAY/profile 14:43:49 INFO - TEST-INFO | started process 25794 (/builds/slave/test/build/application/firefox/firefox http://localhost:40850/getInfo.html) 14:43:54 INFO - TEST-INFO | 25794: exit 0 14:43:54 INFO - Browser initialized. 14:43:54 INFO - Running cycle 1/1 for kraken test... 14:43:54 INFO - Using env: {'DISPLAY': ':0', 14:43:54 INFO - 'HOME': '/home/cltbld', 14:43:54 INFO - 'JSGC_DISABLE_POISONING': '1', 14:43:54 INFO - 'LANG': 'en_US.UTF-8', 14:43:54 INFO - 'LANGUAGE': 'en_US:en', 14:43:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:43:54 INFO - 'LOGNAME': 'cltbld', 14:43:54 INFO - 'MAIL': '/var/mail/cltbld', 14:43:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:43:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:43:54 INFO - 'MOZ_CRASHREPORTER': '1', 14:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:43:54 INFO - 'MOZ_NO_REMOTE': '1', 14:43:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:54 INFO - 'NO_EM_RESTART': '1', 14:43:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:54 INFO - 'PWD': '/builds/slave/test', 14:43:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:43:54 INFO - 'RUST_BACKTRACE': 'full', 14:43:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:43:54 INFO - 'SHELL': '/bin/bash', 14:43:54 INFO - 'SHLVL': '1', 14:43:54 INFO - 'TERM': 'linux', 14:43:54 INFO - 'TMOUT': '86400', 14:43:54 INFO - 'USER': 'cltbld', 14:43:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636', 14:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:54 INFO - '_': '/tools/buildbot/bin/python'} 14:43:54 INFO - TEST-INFO | started process 25990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHhtJAY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:43:55 INFO - PID 25990 | 14:43:55 INFO - PID 25990 | (/builds/slave/test/build/application/firefox/firefox:26041): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:43:55 INFO - PID 25990 | 14:44:05 INFO - PID 25990 | RSS: Main: 172924928 14:44:05 INFO - PID 25990 | 14:44:08 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40850/tests/kraken/driver.html?testName=audio-beat-detection) 14:44:09 INFO - PID 25990 | RSS: Main: 178044928 14:44:09 INFO - PID 25990 | 14:44:12 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40850/tests/kraken/driver.html?testName=audio-dft) 14:44:12 INFO - PID 25990 | RSS: Main: 179232768 14:44:12 INFO - PID 25990 | 14:44:15 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40850/tests/kraken/driver.html?testName=audio-fft) 14:44:16 INFO - PID 25990 | RSS: Main: 172834816 14:44:16 INFO - PID 25990 | 14:44:18 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40850/tests/kraken/driver.html?testName=audio-oscillator) 14:44:19 INFO - PID 25990 | RSS: Main: 174182400 14:44:19 INFO - PID 25990 | 14:44:21 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40850/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:44:21 INFO - PID 25990 | RSS: Main: 173912064 14:44:21 INFO - PID 25990 | 14:44:24 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40850/tests/kraken/driver.html?testName=imaging-darkroom) 14:44:25 INFO - PID 25990 | RSS: Main: 176721920 14:44:25 INFO - PID 25990 | 14:44:29 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40850/tests/kraken/driver.html?testName=imaging-desaturate) 14:44:29 INFO - PID 25990 | RSS: Main: 176300032 14:44:29 INFO - PID 25990 | 14:44:32 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40850/tests/kraken/driver.html?testName=json-parse-financial) 14:44:33 INFO - PID 25990 | RSS: Main: 176979968 14:44:33 INFO - PID 25990 | 14:44:35 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40850/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:44:35 INFO - PID 25990 | RSS: Main: 176967680 14:44:35 INFO - PID 25990 | 14:44:37 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40850/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:44:37 INFO - PID 25990 | RSS: Main: 177037312 14:44:37 INFO - PID 25990 | 14:44:40 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40850/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:40 INFO - PID 25990 | RSS: Main: 173719552 14:44:40 INFO - PID 25990 | 14:44:43 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:44 INFO - PID 25990 | RSS: Main: 174317568 14:44:44 INFO - PID 25990 | 14:44:47 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:44:47 INFO - PID 25990 | RSS: Main: 174354432 14:44:47 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | Cycle 1(1): loaded http://localhost:40850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40850/tests/kraken/driver.html?testName=ai-astar) 14:44:49 INFO - PID 25990 | RSS: Main: 176226304 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | __start_tp_report 14:44:49 INFO - PID 25990 | _x_x_mozilla_page_load 14:44:49 INFO - PID 25990 | _x_x_mozilla_page_load_details 14:44:49 INFO - PID 25990 | |i|pagename|runs| 14:44:49 INFO - PID 25990 | |0;ai-astar;107;107;106;107;107;107;107;108;108;109 14:44:49 INFO - PID 25990 | |1;audio-beat-detection;116;122;123;115;118;116;117;149;117;119 14:44:49 INFO - PID 25990 | |2;audio-dft;165;161;162;162;162;162;166;166;166;166 14:44:49 INFO - PID 25990 | |3;audio-fft;74;75;76;73;73;74;74;80;89;73 14:44:49 INFO - PID 25990 | |4;audio-oscillator;80;80;79;78;80;80;80;79;80;79 14:44:49 INFO - PID 25990 | |5;imaging-gaussian-blur;113;113;113;114;113;114;114;110;114;110 14:44:49 INFO - PID 25990 | |6;imaging-darkroom;159;147;148;148;150;151;149;151;148;147 14:44:49 INFO - PID 25990 | |7;imaging-desaturate;99;98;94;95;94;95;94;95;94;94 14:44:49 INFO - PID 25990 | |8;json-parse-financial;54;53;53;55;54;54;53;54;53;53 14:44:49 INFO - PID 25990 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;39;37 14:44:49 INFO - PID 25990 | |10;stanford-crypto-aes;78;75;78;77;81;74;78;76;77;81 14:44:49 INFO - PID 25990 | |11;stanford-crypto-ccm;118;117;119;120;116;129;129;125;118;122 14:44:49 INFO - PID 25990 | |12;stanford-crypto-pbkdf2;169;170;164;172;173;184;173;183;169;168 14:44:49 INFO - PID 25990 | |13;stanford-crypto-sha256-iterative;66;63;67;65;63;63;67;66;63;64 14:44:49 INFO - PID 25990 | __end_tp_report 14:44:49 INFO - PID 25990 | __start_cc_report 14:44:49 INFO - PID 25990 | _x_x_mozilla_cycle_collect,952 14:44:49 INFO - PID 25990 | __end_cc_report 14:44:49 INFO - PID 25990 | __startTimestamp1504907089653__endTimestamp 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | ------- Summary: start ------- 14:44:49 INFO - PID 25990 | Number of tests: 14 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#0] ai-astar Cycles:10 Average:107.30 Median:107.00 stddev:0.82 (0.8%) stddev-sans-first:0.87 14:44:49 INFO - PID 25990 | Values: 107.0 107.0 106.0 107.0 107.0 107.0 107.0 108.0 108.0 109.0 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:118.50 stddev:10.11 (8.5%) stddev-sans-first:10.54 14:44:49 INFO - PID 25990 | Values: 116.0 122.0 123.0 115.0 118.0 116.0 117.0 149.0 117.0 119.0 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#2] audio-dft Cycles:10 Average:163.80 Median:165.50 stddev:2.15 (1.3%) stddev-sans-first:2.24 14:44:49 INFO - PID 25990 | Values: 165.0 161.0 162.0 162.0 162.0 162.0 166.0 166.0 166.0 166.0 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#3] audio-fft Cycles:10 Average:76.10 Median:74.50 stddev:5.00 (6.7%) stddev-sans-first:5.24 14:44:49 INFO - PID 25990 | Values: 74.0 75.0 76.0 73.0 73.0 74.0 74.0 80.0 89.0 73.0 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:80.00 stddev:0.71 (0.9%) stddev-sans-first:0.73 14:44:49 INFO - PID 25990 | Values: 80.0 80.0 79.0 78.0 80.0 80.0 80.0 79.0 80.0 79.0 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.50 stddev:1.55 (1.4%) stddev-sans-first:1.64 14:44:49 INFO - PID 25990 | Values: 113.0 113.0 113.0 114.0 113.0 114.0 114.0 110.0 114.0 110.0 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:149.50 stddev:3.55 (2.4%) stddev-sans-first:1.56 14:44:49 INFO - PID 25990 | Values: 159.0 147.0 148.0 148.0 150.0 151.0 149.0 151.0 148.0 147.0 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.81 (1.9%) stddev-sans-first:1.30 14:44:49 INFO - PID 25990 | Values: 99.0 98.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 14:44:49 INFO - PID 25990 | Values: 54.0 53.0 53.0 55.0 54.0 54.0 53.0 54.0 53.0 53.0 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.47 (1.2%) stddev-sans-first:0.50 14:44:49 INFO - PID 25990 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 39.0 37.0 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:78.00 stddev:2.27 (2.9%) stddev-sans-first:2.40 14:44:49 INFO - PID 25990 | Values: 78.0 75.0 78.0 77.0 81.0 74.0 78.0 76.0 77.0 81.0 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:121.00 stddev:4.81 (4.0%) stddev-sans-first:4.95 14:44:49 INFO - PID 25990 | Values: 118.0 117.0 119.0 120.0 116.0 129.0 129.0 125.0 118.0 122.0 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:172.50 stddev:6.38 (3.7%) stddev-sans-first:6.64 14:44:49 INFO - PID 25990 | Values: 169.0 170.0 164.0 172.0 173.0 184.0 173.0 183.0 169.0 168.0 14:44:49 INFO - PID 25990 | 14:44:49 INFO - PID 25990 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.50 stddev:1.70 (2.6%) stddev-sans-first:1.74 14:44:49 INFO - PID 25990 | Values: 66.0 63.0 67.0 65.0 63.0 63.0 67.0 66.0 63.0 64.0 14:44:49 INFO - PID 25990 | -------- Summary: end -------- 14:44:49 INFO - PID 25990 | 14:44:50 INFO - PID 25990 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:44:50 INFO - TEST-INFO | 25990: exit 0 14:44:50 INFO - TEST-OK | kraken | took 60932ms 14:44:50 INFO - SUITE-END | took 1168s 14:44:50 INFO - Completed test suite (00:19:29) 14:44:50 INFO - javascript benchmark 14:44:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8418.955431396644, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3066.8926587569435, 3119.2669722615183, 3131.7181453669173, 3145.0, 3152.2749767553446, 6116.724747386367, 6230.5638605297645, 6261.843453913654, 6324.462420694241, 6380.553361264713, 6192.256929168506, 6269.6238225706375, 6339.11252424661, 6393.392627700373, 6432.42108210261, 5774.335951365584, 5830.387809280028, 5833.708314584275, 5873.148393482942, 5900.321463031742, 60.88063090152337, 5644.04051311276, 5702.743376548045, 5736.110902810071, 5784.68184249866, 5718.399568045378, 5725.083986562151, 5784.652920824743, 5793.33376661683, 5793.5365170786445, 5712.428757124296, 5739.225204597367, 5783.392743761887, 5798.710064496759, 5805.970970145122, 5703.0, 5722.713864306768, 5780.132980052984, 5786.508146807527, 5798.942010579883, 6050.48570871472, 6237.812865614039, 6289.0252010938375, 6308.526860485482, 6340.746370145189, 6638.0, 6666.400023997863, 6689.030090636879, 6732.360425759545, 6742.865142697118, 6793.320667933217, 6814.557053791487, 6831.419329357011, 6836.794896153124, 6843.726250949956, 6066.150738896558, 6145.508359331243, 6230.408111229426, 6234.968825155891, 6288.245410550763, 6876.071730316393, 6899.862002759916, 6926.722931082701, 6935.271796461399, 6942.965285173542, 6515.02274658805, 6532.281449040602, 6536.673166341664, 6604.735810567619, 6654.23476300222, 6612.371824676648, 6717.126773519509, 6727.66361681914, 6785.491088168407, 6794.4904132189295, 6691.063251144844, 6725.899111513331, 6736.865262694719, 6761.425278851254, 6772.762953296611, 6693.631850248283, 6734.629595372302, 6785.11793466856, 6793.59238445685, 6806.659667016629, 5259.132243179909, 5260.158374660036, 5268.894622107537, 5330.067238233293, 5333.493318134771, 4559.840405585788, 4586.793594288199, 4623.583877450978, 4644.837430689977, 4660.254359302496, 5767.048437007847, 5794.536437085023, 5865.824025279248, 5873.177755114288, 5885.176075349455, 6651.068850360954, 6795.422389096883, 6824.078749368871, 6826.658667066627, 6826.897596536056, 5792.88414231713, 5801.622894511843, 5857.941420585825, 5887.322957859816, 5897.380775018647, 5643.040683083886, 5737.713114344349, 5755.568332375088, 5791.9131213031, 5820.447057529528, 6503.9349606504275, 6504.089427480157, 6510.381513756186, 6526.412622863965, 6569.57297775643, 6572.375624315682, 6671.266160722414, 6735.966320168368, 6770.0, 6770.72917083321, 6403.6798160090875, 6432.421082102634, 6452.838679033061, 6523.934760652332, 6547.148870646785, 6609.140811694641, 6614.6361950093205, 6624.33756624353, 6635.170603674541, 6659.267480577229, 6563.573367731082, 6702.765403210864, 6769.526133170828, 6805.727770889109, 6823.795286141423, 6312.936870631419, 6394.0, 6506.837329066811, 6534.705938232696, 6560.573562718408, 6483.967580162069, 6565.901511477236, 6570.5729127606555, 6574.671266436755, 6585.769498067544, 6276.874462510816, 6393.552451328548, 6401.071844582602, 6483.222013358427, 6492.383223593751, 6430.5177111715875, 6505.934940650533, 6510.5117116217425, 6562.343765623399, 6573.868522629617, 6331.841703957438, 6359.17330747, 6360.586561873649, 6413.038044293393, 6417.454516366161], "value": 6075.9568197322915, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.1401787007486, 794.2018271637007, 796.3867821777231, 797.0554892452441, 798.269583331252, 39559.80220098899, 43124.568754312444, 43233.0, 43248.13503729924, 43259.3511097333, 38642.613573864255, 38992.0, 39010.21979560407, 39034.8048259759, 39107.21785564287, 6987.301269872997, 7156.964215178917, 7161.104861892263, 7905.130435652074, 8157.592120393986, 7959.880601790977, 8066.193380661945, 8076.232757887991, 8076.596170191497, 8080.39397045221, 8046.798830029267, 8117.715879944203, 8118.147594502551, 8120.553369564672, 8123.187681231859, 8046.275835174833, 8079.313258373046, 8081.4747041442415, 8093.554854483001, 8094.919050809475, 7841.294283514454, 7968.322692571139, 7970.641321140504, 7974.242446967529, 7977.0, 39222.41166382506, 39423.21153576912, 39426.408603870965, 39492.21015579701, 39492.407613885814, 3577.105723569108, 3608.9458658120147, 3620.7646502977223, 3622.5834029086727, 3622.9275414491563, 32895.83552082248, 33085.6691433085, 33189.50215746766, 33240.501392479135, 33265.33469330624, 5239.449857764918, 5251.9212211816475, 5278.841634750964, 5298.735063246861, 5302.072137375943, 187255.0, 187810.0, 187843.0, 188177.0, 188474.0, 42706.78646606747, 42988.78505607452, 48780.26829597488, 48839.75580122077, 48957.51042489529, 53076.46923530792, 53363.733181333846, 53505.7324713374, 53577.732111339195, 53627.19559206615, 16136.273867675984, 16240.187990600423, 16243.269052892649, 16287.267072981744, 16363.181840907908, 13303.73392532144, 13310.66723331905, 13333.866661333457, 13341.66645833862, 13351.73296534064, 14373.78439323411, 14443.638909027359, 14553.345099470549, 14565.490207842675, 14586.562403127924, 5936.7031648417405, 6056.66688332146, 6097.847553811191, 6118.715069835295, 6121.357257487989, 1002.7392877851811, 1007.3049595778889, 1008.5108722269694, 1011.8886922438526, 1031.4120951057826, 22711.659325110137, 22771.886140569524, 22821.0, 23004.19485318006, 23109.653355199687, 1097.1058587251364, 1121.9270747401392, 1124.1905827803969, 1125.3641692443744, 1126.0316128129803, 12000.87999120015, 12021.819672704916, 12104.455299511543, 12263.632091037283, 12283.877161228453, 217179.0, 217848.0, 218024.0, 218283.0, 218780.0, 53034.67413314698, 53380.0, 53562.0, 53570.73214633902, 53871.46128538743, 1451.608065822201, 1467.5744034230167, 1472.779083137538, 1486.7695507196402, 1490.2623201515319, 22240.66639000384, 22578.0, 22636.773632263466, 22741.658875117217, 22790.544189116456, 37851.432228516045, 37864.242715146094, 37871.0, 37995.24009519739, 38056.80971595124, 134767.0, 135138.0, 135202.32398837942, 135338.0, 135486.0, 34707.305853883285, 36557.634423656484, 36880.44679329866, 37147.25705485821, 37220.62779372172, 46855.0, 47011.764941175075, 47117.29324060073, 47258.527414726785, 47312.0, 33435.16412089717, 33767.66232337744, 33943.4908476378, 34072.31855362929, 34668.47997280093, 33855.661443386234, 33995.3200935975, 34001.97994060182, 34183.487247690806, 34705.82647086748, 38031.619683802805, 38035.0, 38085.23829523449, 38171.0, 38323.233535329695, 32233.194170144994, 32334.0, 32854.67145328516, 32889.17777055593, 33357.66642333545, 24013.399665007815, 24354.02583896624, 24369.39076523101, 24424.511509770062, 25095.24714258575], "value": 17267.808413261984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.2727590494403, 564.4919572384856, 572.5019233267059, 578.4418036594686, 588.0796553393939, 22194.667079993793, 22999.0, 23000.0, 23007.769922300773, 23094.30717078486, 23051.884740576315, 23946.76053239467, 24120.276391708234, 24247.0, 24280.39299017521, 6412.743490260395, 6528.7714929977465, 6565.967170164143, 6578.8684226315445, 6584.2098948126295, 6423.421892029716, 6479.93520064798, 6582.341765823403, 6588.802335929906, 6665.633390163539, 6618.669066546678, 6619.073329733841, 6619.404253617174, 6621.867562648744, 6621.900671489908, 6620.966895165518, 6631.502637302197, 6632.801015969529, 6667.93332066678, 6669.933300666979, 5900.616459930091, 6123.755049798003, 6128.63228206309, 6128.662923539204, 6130.8773824523705, 27826.443471130464, 28246.576301355497, 28254.85872570624, 28267.71732282692, 28286.85856570704, 1970.7142464342733, 1993.1429485321305, 1994.4116485636628, 1999.4601457606511, 2003.24878170686, 19023.61952760951, 19144.61710765777, 19429.417117486497, 19448.611027779367, 19683.11425985834, 2321.0483701682397, 2346.1436575649764, 2367.9763202367926, 2376.2752360530203, 2411.7467665895006, 121576.39211803973, 127132.0, 128316.0, 132207.0, 133807.0, 14694.55916322512, 14712.485063022958, 14785.11289322644, 14850.960432769818, 14941.982832317499, 22233.666495002588, 22274.331770046923, 22298.777012229995, 22304.10783568639, 22340.106395744315, 10158.746031349276, 10277.691669249934, 10297.639582614573, 10365.170786337076, 10462.163026957825, 9597.424154550748, 9599.280053995979, 9606.855897161548, 9681.37071090377, 9699.272554558294, 8952.820943581091, 9129.224015958585, 9148.908510914805, 9199.264058875275, 9230.169284764403, 2700.405910699643, 2711.180372412708, 2718.6058021587155, 2768.43247134337, 2804.1026871401364, 939.2251392600995, 940.6660635474445, 959.318883592657, 959.7600599850037, 974.848898420746, 18427.72358414625, 18731.157097930627, 18776.624467510574, 18884.15021324044, 18989.33537326187, 969.413504829582, 983.1446641422009, 998.8662867645274, 1004.4023805835516, 1009.5810238750836, 10278.434686092336, 10329.74175645615, 10334.638287659896, 10361.222908281909, 10519.84220236697, 427592.0, 439579.0, 451068.0, 472139.0, 473118.0, 109266.0, 111150.0, 111381.44309278401, 112250.43874780573, 112426.0, 1010.9443980580992, 1067.791780602775, 1127.1377396291844, 1139.680889350983, 1184.3841202574786, 19089.0, 19528.707069393688, 19606.000939521233, 19923.501912452306, 19991.700124498435, 54308.45691543192, 55030.0, 55609.88780224292, 56632.43367566436, 58562.0, 68380.31619683938, 68494.65752671404, 68537.0, 68549.65725171342, 69400.3059969414, 12990.0, 13186.0, 13218.140820846615, 13250.072494925264, 13312.866871331551, 21579.2447264345, 21688.783112168676, 21746.238881639067, 21837.78162218421, 21921.342359729235, 17268.827311727226, 17304.221310040826, 17424.47726568205, 17595.736063958793, 17606.295748170443, 15616.843831561993, 16086.919565402566, 16119.435819746253, 16211.35154593803, 16524.421645242357, 17465.738013929546, 17898.463046108638, 17936.0, 18001.819981800538, 18024.63950720952, 13074.411651475897, 13156.079074464695, 13171.407286672315, 13174.40715167839, 13195.274259915413, 17196.0, 17604.38384656531, 17609.823901760818, 17663.735043974608, 17665.823341766933], "value": 11659.778887392953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.5112381733031, 1343.4491858338083, 1389.8957578181632, 1398.6293632187467, 1398.748225319442, 15620.843791562082, 15969.121698306588, 15994.120323382209, 16097.517074487769, 16147.919260403696, 15568.14375209363, 15674.373025079012, 15696.84303156971, 15728.606784830385, 15749.921250393732, 2713.8236014659083, 2753.752162305392, 2784.763295119917, 2786.512360336943, 2789.2329609357384, 2745.4509098180442, 2830.80184387093, 2842.559403292493, 2843.274964883962, 2847.9715202848015, 2634.2492389668946, 2731.549294366427, 2732.617433559303, 2804.901828436005, 2808.5927540506614, 2799.1882354117283, 2809.2976755811046, 2836.049923275705, 2839.0489186122672, 2840.758535524483, 2699.824511406752, 2741.3420779013095, 2758.544840101381, 2763.668359796817, 2765.14280573023, 14683.412663493447, 15025.398984040625, 15031.924840375837, 15068.246587670572, 15094.924525377302, 7514.774556763306, 7769.067711874554, 7775.961120194363, 7776.144624091346, 7784.910112584243, 5316.734163291859, 5382.327209098863, 5463.399026107125, 5584.134459158837, 5592.748326325284, 1926.402815127315, 1929.4983304340833, 1951.9121639526256, 1981.7126516655005, 2050.76416212136, 26459.867700661373, 26578.0, 26722.19833405001, 26730.0, 26798.062067827534, 6688.498362622823, 6838.760643377458, 6870.828229294208, 6960.79117626472, 7012.088428504262, 17146.742798858028, 17159.742603860952, 17178.141092945552, 17198.31206751741, 17198.656026879642, 7616.504927179826, 7733.883991740128, 7749.612519374009, 7756.108047574488, 7761.72833950809, 7100.289971002859, 7156.534825236343, 7258.165310989199, 7410.184879663233, 7515.94776731258, 4942.184539550934, 5084.796608135707, 5126.92309615356, 5129.615278854101, 5137.332146820964, 1279.5841351560593, 1552.4178433087593, 1553.7980062591791, 1560.7112684153467, 1583.081812548719, 736.5543845973216, 873.057098333798, 891.6611687558686, 894.9686760963465, 899.1458114790975, 7851.9214807851195, 7906.7627971160955, 7916.445848790529, 7940.364770818321, 7958.721444749406, 970.5729479029204, 980.7695191629962, 981.0924894472727, 983.7737320416344, 1000.2398177385239, 4182.309918863414, 4190.622843943998, 4266.573342665771, 4320.200762858881, 4322.654187664979, 20569.69145462819, 21437.571248574943, 21448.249311274343, 21632.134714611555, 21645.67531487029, 17432.738508922375, 18803.81196188048, 20937.476563086046, 21023.15907363719, 21123.366299011053, 10579.894201058045, 10795.40625265618, 10922.672319830417, 10946.671599852018, 10988.395638239814, 8428.199321064489, 8710.82578348442, 8863.64545418176, 9012.143846334588, 9115.407498512575, 18060.0, 18200.089995500435, 18375.26498940081, 18415.90792046031, 18635.161417735962, 18698.252069917595, 18891.055447227307, 19028.429147125607, 19164.904175479034, 19510.90244548825, 12182.208156470155, 12274.81587776202, 12404.62786116418, 12432.191907526343, 12444.31556264378, 13735.0, 13911.721765564835, 14003.299835008413, 14043.0, 14069.718605627626, 11471.369074700639, 11476.770464590829, 11551.364674942959, 11751.529938802352, 11900.226485278428, 11246.493907774005, 11289.548418063185, 11500.712482188012, 11671.416429178676, 11857.229280096766, 8834.911650883667, 8990.415622984485, 8995.370324077252, 8998.100189980949, 9003.0, 6826.351496607815, 6875.724971001104, 6926.58440493572, 6938.826529336807, 6939.201991771011, 7106.786796396116, 7129.287071292829, 7137.429005679429, 7168.2831716827895, 7193.676284567103], "value": 6639.158218935873, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.32531798967534, 528.3501293409109, 528.888933324002, 532.4302995794499, 532.7256462921594, 6382.297947225801, 6395.48836093112, 6405.583637063599, 6449.645269510175, 6459.0, 6238.937610623892, 6294.150289710888, 6347.36526347365, 6354.968225158879, 6366.331535188808, 4903.16131450706, 5031.647784655075, 5083.466236045218, 5234.214867769827, 5265.0, 5041.7143628374715, 5060.342155519777, 5063.84808455745, 5102.0, 5120.948790512103, 4925.950740492603, 4975.527324904128, 4988.42633097193, 5015.448300686921, 5031.993601279741, 4967.875803104916, 5013.6490445668815, 5035.269885866565, 5048.242763585455, 5056.595472362221, 4505.684602077856, 4523.525029871849, 4532.229520981408, 4542.341360502742, 4576.649888282965, 6012.96993515034, 6122.234720659918, 6176.795524872651, 6212.0, 6286.559940804145, 5599.776008959637, 5668.858278543028, 5672.149177623348, 5682.659040457585, 5713.942860571424, 6508.186476690414, 6547.869042619121, 6550.213974323064, 6559.0, 6627.707597018583, 4841.7337046462435, 4843.75781210938, 4860.270959356089, 4866.635002374836, 4905.607551395916, 6592.077109204715, 6614.305497922697, 6784.219814721321, 6787.72849086036, 6953.860922781516, 4989.800407983713, 5006.3491746073505, 5035.899282014412, 5035.974820125876, 5092.159793634009, 5060.367454068241, 5085.491450854959, 5101.7194054327365, 5108.412532558729, 5145.125328694131, 5623.216507828651, 5671.149327600893, 5686.346070201897, 5757.0, 5806.2451881255165, 6625.238097618739, 6729.6971636276485, 6742.258351581322, 6773.8645227095185, 6792.626405547742, 1774.4676597020841, 1779.128227168678, 1779.4038996935913, 1794.6410717856481, 1801.7837859456688, 1160.802663547199, 1213.0598785940967, 1219.615821016377, 1231.3720002798636, 1232.3468561662332, 5793.623414478046, 5797.768089276466, 5803.187553742479, 5851.034579294369, 5869.060950248026, 6741.696623651947, 6774.729010839511, 6783.321667833177, 6887.483438742114, 6909.965450172817, 5762.884742305214, 5792.536597072309, 5796.565257605696, 5800.535957123504, 5843.474087332075, 3562.5724913010604, 3563.3585954528435, 3574.6425357464564, 3589.9820500897326, 3608.440691692792, 6300.889202117342, 6371.55399122057, 6459.61242325462, 6531.575447595891, 6578.769743059066, 6321.241451025906, 6744.258131605519, 6767.221769496472, 6790.287019862843, 6874.621895795679, 6340.556161068773, 6436.0, 6485.221773387224, 6518.28298887122, 6552.410283074546, 6609.900851487328, 6661.500387470862, 6680.899786503109, 6703.4972377070935, 6708.932910670831, 6608.645227728401, 6648.634325112165, 6703.899441508479, 6726.905623413089, 6751.257361690308, 6446.161998940108, 6446.323136070832, 6465.450436712932, 6476.255230648536, 6523.129822877919, 4927.211646136601, 4937.654364194472, 5012.223105418666, 5042.294078828893, 5049.57078648319, 6597.175353080865, 6617.933820661924, 6666.566673166229, 6793.0, 6801.149856267966, 6559.196221039252, 6578.210614726264, 6602.141721576164, 6604.273529911609, 6607.240167380813, 6570.5729127606555, 6586.209654841449, 6588.637624930675, 6593.736250549924, 6595.670216489252, 6489.884855269403, 6490.383413575702, 6496.447801936888, 6509.665518568777, 6561.210316468909, 6642.634655094016, 6657.833554161185, 6670.866582668416, 6676.397664560568, 6734.191896972395, 6421.068945003042, 6422.0, 6449.871002579828, 6458.870822583616, 6478.222613286436], "value": 5087.460007947642, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.1315910407804, 899.4783025845009, 914.9752277449257, 918.0406475233384, 937.9249660027197, 17102.144892755357, 17722.556936076588, 17842.464726058206, 17851.928884266938, 17853.285868565243, 17764.200610972504, 17896.0, 17911.28354865807, 18016.18927148278, 18661.813381866177, 963.32085879455, 974.0308393148827, 974.907383798538, 975.8438649816031, 978.5009645080988, 955.0544960489135, 957.0333962697656, 958.2334132693852, 958.5782255807458, 961.620160036785, 1034.57065317893, 1038.169464428458, 1039.8960103989616, 1044.4621020174616, 1044.5612842606085, 1022.7443139215196, 1024.329064462778, 1027.7790275090817, 1029.4955471818791, 1031.2162756305263, 764.8814433762776, 764.942629302799, 767.3055884424605, 767.4781148818801, 769.869122249219, 20296.391108266776, 20325.491862703402, 20591.58816823655, 20643.380698579065, 20644.0, 21246.787532124636, 21272.46818829526, 21810.672839907413, 21833.126674932984, 21883.67174492384, 16600.584985375343, 16682.916585417115, 16795.0762708051, 16805.57986050346, 16842.41051563202, 3784.564775050877, 3788.6021967693546, 3801.2777572261184, 3805.1438426354125, 3815.8664446744233, 140473.24651496712, 143519.0, 144516.0, 144749.99999999895, 145596.0, 16374.83625163757, 16501.33994640201, 16543.420980265633, 16612.916935415487, 16703.999999999756, 30492.390152196833, 31209.8439507801, 31312.53031204534, 31419.214519636735, 31475.84262078675, 7915.722949696733, 8024.358051355877, 8056.83886322282, 8076.192380761877, 8117.675292988214, 4089.488813898263, 4137.420761093449, 4144.48193975753, 4145.97927010363, 4147.730397524151, 5362.8659283517445, 5376.301080859464, 5485.835424937259, 5501.064818980783, 5515.310586176728, 1002.1131298800468, 1009.4094954451581, 1021.9846702299471, 1022.4938655365642, 1025.195221750922, 655.8360409897525, 668.582136164897, 681.1757773094611, 686.9519133660596, 687.3916583823352, 11584.942075289739, 11761.88238117625, 11938.52245910154, 12413.565525206574, 12432.875671243353, 670.7518218259275, 683.6923384477005, 688.4905170174135, 690.0925283252507, 695.9512834101564, 5611.9337325907945, 5660.433956604389, 5663.716814159276, 5675.5459563234845, 5741.827745167651, 117363.0, 117731.41134294274, 120414.39792801155, 122030.0, 123586.0, 100537.0, 102917.0, 103982.0, 105483.47258263659, 108210.45894770476, 92359.53820230855, 94925.5253723727, 95377.0, 97183.0, 97926.0207397917, 10474.633387831389, 10480.109190718875, 10577.418241996456, 10613.893861061291, 10639.0, 43285.35071973986, 43306.78346608247, 43750.78124609357, 44793.552064478936, 44975.550244498445, 54890.0, 56446.43553564576, 56577.434225658864, 57866.4213357861, 58740.412595873495, 14482.565523034325, 14674.046186997812, 14772.55682329532, 14807.111573305636, 14816.777748334, 15492.457763978207, 15695.921520392325, 15755.369785208923, 15890.284937177623, 15906.681866362376, 13568.389422475815, 13734.519291824738, 13794.86205137976, 13932.164070155823, 13984.37070331817, 13050.216986980811, 13096.410661520064, 13210.669733256746, 13279.66800829987, 13295.0, 13631.454741810614, 13677.0, 13700.45198192061, 13758.587242382744, 13808.654783630087, 9614.519274036411, 9620.278479113955, 9755.122039016522, 9756.85364719544, 9954.601815927283, 9547.961959913026, 9604.327697061419, 9718.076782705632, 9741.805163896825, 9888.208943284664], "value": 8617.226044018222, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1433.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 106.0, 107.0, 107.0, 107.0, 107.0, 108.0, 108.0, 109.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 122.0, 123.0, 115.0, 118.0, 116.0, 117.0, 149.0, 117.0, 119.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 162.0, 162.0, 162.0, 162.0, 166.0, 166.0, 166.0, 166.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 73.0, 73.0, 74.0, 74.0, 80.0, 89.0, 73.0], "value": 76.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 78.0, 80.0, 80.0, 80.0, 79.0, 80.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 110.0, 114.0, 110.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 147.0, 148.0, 148.0, 150.0, 151.0, 149.0, 151.0, 148.0, 147.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 98.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 55.0, 54.0, 54.0, 53.0, 54.0, 53.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 37.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 78.0, 77.0, 81.0, 74.0, 78.0, 76.0, 77.0, 81.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 120.0, 116.0, 129.0, 129.0, 125.0, 118.0, 122.0], "value": 121.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 164.0, 172.0, 173.0, 184.0, 173.0, 183.0, 169.0, 168.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 67.0, 65.0, 63.0, 63.0, 67.0, 66.0, 63.0, 64.0], "value": 64.7, "unit": "score"}]}]} 14:44:50 INFO - Return code: 0 14:44:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:44:50 INFO - # TBPL SUCCESS # 14:44:50 INFO - Running post-action listener: _package_coverage_data 14:44:50 INFO - Running post-action listener: _resource_record_post_action 14:44:50 INFO - [mozharness: 2017-09-08 21:44:50.939181Z] Finished run-tests step (success) 14:44:50 INFO - Running post-run listener: _resource_record_post_run 14:44:51 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 300658688; Read time: 8; Write time: 160468 14:44:51 INFO - TinderboxPrint: CPU usage
13.1% 14:44:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 14:44:51 INFO - TinderboxPrint: I/O write bytes / time
300,658,688 / 160,468 14:44:51 INFO - TinderboxPrint: CPU idle
8,215.2 (86.9%) 14:44:51 INFO - TinderboxPrint: CPU user
1,189.8 (12.6%) 14:44:51 INFO - TinderboxPrint: Swap in / out
0 / 0 14:44:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12468224; Read time: 0; Write time: 1788 14:44:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:44:51 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 287129600; Read time: 0; Write time: 158648 14:44:51 INFO - Running post-run listener: _upload_blobber_files 14:44:51 INFO - Blob upload gear active. 14:44:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:44:51 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 14:44:51 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'] 14:44:51 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 14:44:51 INFO - (blobuploader) - INFO - Open directory for files ... 14:44:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:44:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:44:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:53 INFO - (blobuploader) - INFO - Done attempting. 14:44:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:44:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:44:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:58 INFO - (blobuploader) - INFO - Done attempting. 14:44:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:44:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:44:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:59 INFO - (blobuploader) - INFO - Done attempting. 14:44:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:44:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:44:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:59 INFO - (blobuploader) - INFO - Done attempting. 14:44:59 INFO - (blobuploader) - INFO - Iteration through files over. 14:44:59 INFO - Return code: 0 14:44:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:44:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:44:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5b4f87905bab039b6374c03a3636bc3171457688b33fda530d7d0197c4c02b5be4cbe5df27aac005e5808a0a3114805d6e8978c014eccbd8160f46d13fe24ae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44de4d3a98e3d911f89737f856cb727d3666e9e8a19726c86c9cd96b77e3503f24c21f556729c37900d462160fedac48894292d46dafc26c25d0221d1d0821d9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d1061dbe4d307b9a197a4c1274b6199fca6f1cf8c80d3e75c58b415d0d33197eed3937f4c7448a1227076b73862b074079d314845833d42f6c21c69fb487804", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f5b5a75a4e1722590a5d43134ab5e40c278fb50a7480d0a66da955223cdbb0edd261bd8fce9175caa5ef9b952728e0239b68a0a54cb024815ecb7ecd59a0fdf"} 14:44:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:44:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:44:59 INFO - Contents: 14:44:59 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5b4f87905bab039b6374c03a3636bc3171457688b33fda530d7d0197c4c02b5be4cbe5df27aac005e5808a0a3114805d6e8978c014eccbd8160f46d13fe24ae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44de4d3a98e3d911f89737f856cb727d3666e9e8a19726c86c9cd96b77e3503f24c21f556729c37900d462160fedac48894292d46dafc26c25d0221d1d0821d9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d1061dbe4d307b9a197a4c1274b6199fca6f1cf8c80d3e75c58b415d0d33197eed3937f4c7448a1227076b73862b074079d314845833d42f6c21c69fb487804", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f5b5a75a4e1722590a5d43134ab5e40c278fb50a7480d0a66da955223cdbb0edd261bd8fce9175caa5ef9b952728e0239b68a0a54cb024815ecb7ecd59a0fdf"} 14:44:59 INFO - Running post-run listener: copy_logs_to_upload_dir 14:44:59 INFO - Copying logs to upload dir... 14:44:59 INFO - mkdir: /builds/slave/test/build/upload/logs 14:44:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.512875 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-08 14:44:59.998629) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 14:45:00.004906) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5b4f87905bab039b6374c03a3636bc3171457688b33fda530d7d0197c4c02b5be4cbe5df27aac005e5808a0a3114805d6e8978c014eccbd8160f46d13fe24ae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44de4d3a98e3d911f89737f856cb727d3666e9e8a19726c86c9cd96b77e3503f24c21f556729c37900d462160fedac48894292d46dafc26c25d0221d1d0821d9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d1061dbe4d307b9a197a4c1274b6199fca6f1cf8c80d3e75c58b415d0d33197eed3937f4c7448a1227076b73862b074079d314845833d42f6c21c69fb487804", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f5b5a75a4e1722590a5d43134ab5e40c278fb50a7480d0a66da955223cdbb0edd261bd8fce9175caa5ef9b952728e0239b68a0a54cb024815ecb7ecd59a0fdf"} build_url:https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/d3HW9PtGSQquoTirprYnMw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5b4f87905bab039b6374c03a3636bc3171457688b33fda530d7d0197c4c02b5be4cbe5df27aac005e5808a0a3114805d6e8978c014eccbd8160f46d13fe24ae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44de4d3a98e3d911f89737f856cb727d3666e9e8a19726c86c9cd96b77e3503f24c21f556729c37900d462160fedac48894292d46dafc26c25d0221d1d0821d9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d1061dbe4d307b9a197a4c1274b6199fca6f1cf8c80d3e75c58b415d0d33197eed3937f4c7448a1227076b73862b074079d314845833d42f6c21c69fb487804", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f5b5a75a4e1722590a5d43134ab5e40c278fb50a7480d0a66da955223cdbb0edd261bd8fce9175caa5ef9b952728e0239b68a0a54cb024815ecb7ecd59a0fdf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 14:45:00.038043) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:45:00.038366) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1504895077.185159-824404636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:45:00.122308) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 14:45:00.122835) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 14:45:00.123267) ========= ========= Total master_lag: 0.20 =========