builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1506008535.82 results: success (0) revision: 835a92b19e3d7666890153a84bc635bc43a44cb2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:15.822108) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:15.822804) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:15.823083) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:15.878043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:15.878326) ========= 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=a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 08:42:15-- 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% 227M=0s 2017-09-21 08:42:15 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092745 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:15.999773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:16.002986) ========= 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=a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019375 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:16.082264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-21 08:42:16.088777) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 835a92b19e3d7666890153a84bc635bc43a44cb2 --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 835a92b19e3d7666890153a84bc635bc43a44cb2 --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=a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 08:42:15,979 truncating revision to first 12 chars 2017-09-21 08:42:15,979 Setting DEBUG logging. 2017-09-21 08:42:15,979 attempt 1/10 2017-09-21 08:42:15,979 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/835a92b19e3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 08:42:16,908 unpacking tar archive at: mozilla-central-835a92b19e3d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.218723 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-21 08:42:17.341829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:17.342149) ========= script_repo_revision: 835a92b19e3d7666890153a84bc635bc43a44cb2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:17.342538) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:17.342800) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:17.356285) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-21 08:42:17.356653) ========= /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=a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:42:17 INFO - MultiFileLogger online at 20170921 08:42:17 in /builds/slave/test 08:42:17 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 08:42:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:17 INFO - {'append_to_log': False, 08:42:17 INFO - 'base_work_dir': '/builds/slave/test', 08:42:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:42:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:17 INFO - 'branch': 'Firefox-Non-PGO', 08:42:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:17 INFO - 'code_coverage': False, 08:42:17 INFO - 'config_files': ('talos/linux_config.py',), 08:42:17 INFO - 'default_actions': ('clobber', 08:42:17 INFO - 'read-buildbot-config', 08:42:17 INFO - 'download-and-extract', 08:42:17 INFO - 'populate-webroot', 08:42:17 INFO - 'create-virtualenv', 08:42:17 INFO - 'install', 08:42:17 INFO - 'setup-mitmproxy', 08:42:17 INFO - 'run-tests'), 08:42:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:17 INFO - 'disable_ccov_upload': False, 08:42:17 INFO - 'disable_stylo': False, 08:42:17 INFO - 'download_minidump_stackwalk': True, 08:42:17 INFO - 'download_symbols': 'ondemand', 08:42:17 INFO - 'enable_stylo': False, 08:42:17 INFO - 'enable_webrender': False, 08:42:17 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:42:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:17 INFO - 'gecko_profile': False, 08:42:17 INFO - 'gecko_profile_interval': 0, 08:42:17 INFO - 'installer_path': 'installer.exe', 08:42:17 INFO - 'log_level': 'info', 08:42:17 INFO - 'log_name': 'talos', 08:42:17 INFO - 'log_to_console': True, 08:42:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:42:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:42:17 INFO - 'opt_config_files': (), 08:42:17 INFO - 'pip_index': False, 08:42:17 INFO - 'suite': 'dromaeojs-e10s', 08:42:17 INFO - 'system_bits': '32', 08:42:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:17 INFO - 'title': 'talos-linux64-ix-002', 08:42:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:17 INFO - 'use_talos_json': True, 08:42:17 INFO - 'verify': 'False', 08:42:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:17 INFO - 'work_dir': 'build'} 08:42:17 INFO - [mozharness: 2017-09-21 15:42:17.376349Z] Running clobber step. 08:42:17 INFO - Running pre-action listener: _resource_record_pre_action 08:42:17 INFO - Running main action method: clobber 08:42:17 INFO - rmtree: /builds/slave/test/build 08:42:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:18 INFO - Running post-action listener: _resource_record_post_action 08:42:18 INFO - [mozharness: 2017-09-21 15:42:18.365674Z] Finished clobber step (success) 08:42:18 INFO - [mozharness: 2017-09-21 15:42:18.365771Z] Running read-buildbot-config step. 08:42:18 INFO - Running pre-action listener: _resource_record_pre_action 08:42:18 INFO - Running main action method: read_buildbot_config 08:42:18 INFO - Using buildbot properties: 08:42:18 INFO - { 08:42:18 INFO - "project": "", 08:42:18 INFO - "product": "firefox", 08:42:18 INFO - "who": "jlorenzo@mozilla.com", 08:42:18 INFO - "installer_path": "public/build/target.tar.bz2", 08:42:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:42:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 08:42:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:42:18 INFO - "stage_platform": "linux64", 08:42:18 INFO - "basedir": "/builds/slave/test", 08:42:18 INFO - "buildnumber": 851, 08:42:18 INFO - "platform": "ubuntu64_hw", 08:42:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:42:18 INFO - "slavebuilddir": "test", 08:42:18 INFO - "taskId": "FdaUzIgWSJWvfPCSwqV8Sg", 08:42:18 INFO - "branch": "mozilla-central", 08:42:18 INFO - "script_repo_revision": "production", 08:42:18 INFO - "revision": "835a92b19e3d7666890153a84bc635bc43a44cb2", 08:42:18 INFO - "slavename": "talos-linux64-ix-002", 08:42:18 INFO - "repo_path": "mozilla-central" 08:42:18 INFO - } 08:42:18 INFO - Finding installer, test and symbols from parent task. 08:42:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FdaUzIgWSJWvfPCSwqV8Sg'}, attempt #1 08:42:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FdaUzIgWSJWvfPCSwqV8Sg'}, attempt #1 08:42:19 INFO - Task dependencies: NkyEVKxfQa-s6GWN1Ap4sg 08:42:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg'}, attempt #1 08:42:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2 08:42:22 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.test_packages.json 08:42:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.crashreporter-symbols.zip 08:42:22 INFO - Running post-action listener: _resource_record_post_action 08:42:22 INFO - [mozharness: 2017-09-21 15:42:22.715612Z] Finished read-buildbot-config step (success) 08:42:22 INFO - [mozharness: 2017-09-21 15:42:22.715831Z] Running download-and-extract step. 08:42:22 INFO - Running pre-action listener: _resource_record_pre_action 08:42:22 INFO - Running main action method: download_and_extract 08:42:22 INFO - mkdir: /builds/slave/test/build/tests 08:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:22 INFO - trying https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.test_packages.json 08:42:22 INFO - Downloading https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:42:23 INFO - Downloaded 989 bytes. 08:42:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:42:23 INFO - Using the following test package requirements: 08:42:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:42:23 INFO - u'common': [u'target.common.tests.zip'], 08:42:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:42:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:42:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:42:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:42:23 INFO - u'mozbase': [u'target.common.tests.zip'], 08:42:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:42:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:42:23 INFO - u'web-platform': [u'target.common.tests.zip', 08:42:23 INFO - u'target.web-platform.tests.tar.gz'], 08:42:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:42:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 08:42:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.common.tests.zip 08:42:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:42:23 INFO - Fetch https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.common.tests.zip into memory 08:42:24 INFO - Content-Length response header: 54741106 08:42:24 INFO - Bytes received: 54741106 08:42:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.talos.tests.zip 08:42:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:42:34 INFO - Fetch https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.talos.tests.zip into memory 08:42:36 INFO - Content-Length response header: 14509184 08:42:36 INFO - Bytes received: 14509184 08:42:36 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')]} 08:42:36 INFO - trying https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2 08:42:36 INFO - Downloading https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:42:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:42:37 INFO - Downloaded 61627500 bytes. 08:42:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2 08:42:37 INFO - mkdir: /builds/slave/test/properties 08:42:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:37 INFO - Contents: 08:42:37 INFO - build_url:https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2 08:42:37 INFO - Running post-action listener: _resource_record_post_action 08:42:37 INFO - Running post-action listener: find_tests_for_verification 08:42:37 INFO - Running post-action listener: set_extra_try_arguments 08:42:37 INFO - [mozharness: 2017-09-21 15:42:37.628225Z] Finished download-and-extract step (success) 08:42:37 INFO - [mozharness: 2017-09-21 15:42:37.628322Z] Running populate-webroot step. 08:42:37 INFO - Running pre-action listener: _resource_record_pre_action 08:42:37 INFO - Running main action method: populate_webroot 08:42:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:37 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:37 INFO - 'tests': ['tresize', 08:42:37 INFO - 'tcanvasmark']}, 08:42:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:37 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:37 INFO - 'tests': ['dromaeo_css', 08:42:37 INFO - 'kraken']}, 08:42:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:42:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:37 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:42:37 INFO - 'talos_options': ['--disable-stylo'], 08:42:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:42:37 INFO - 'tests': ['damp', 'tps']}, 08:42:37 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:42:37 INFO - 'talos_options': ['--disable-stylo'], 08:42:37 INFO - 'tests': ['damp', 'tps']}, 08:42:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:37 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:37 INFO - 'tests': ['dromaeo_dom']}, 08:42:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:42:37 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:37 INFO - 'tests': ['basic_compositor_video', 08:42:37 INFO - 'glvideo']}, 08:42:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:42:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:42:37 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:42:37 INFO - 'talos_options': ['--disable-stylo'], 08:42:37 INFO - 'tests': ['ts_paint_webext', 08:42:37 INFO - 'tp5o_webext']}, 08:42:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:37 INFO - 'ts_paint', 08:42:37 INFO - 'tpaint', 08:42:37 INFO - 'sessionrestore', 08:42:37 INFO - 'sessionrestore_many_windows', 08:42:37 INFO - 'sessionrestore_no_auto_restore', 08:42:37 INFO - 'tabpaint']}, 08:42:37 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:37 INFO - 'tests': ['a11yr', 08:42:37 INFO - 'ts_paint', 08:42:37 INFO - 'tpaint', 08:42:37 INFO - 'sessionrestore', 08:42:37 INFO - 'sessionrestore_many_windows', 08:42:37 INFO - 'sessionrestore_no_auto_restore', 08:42:37 INFO - 'tabpaint']}, 08:42:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:42:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 08:42:37 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:37 INFO - 'tests': ['perf_reftest_singletons']}, 08:42:37 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:37 INFO - 'tests': ['bloom_basic']}, 08:42:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:37 INFO - 'tsvgr_opacity', 08:42:37 INFO - 'tart', 08:42:37 INFO - 'tscrollx', 08:42:37 INFO - 'tsvg_static']}, 08:42:37 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:37 INFO - 'tests': ['tsvgx', 08:42:37 INFO - 'tsvgr_opacity', 08:42:37 INFO - 'tart', 08:42:37 INFO - 'tscrollx', 08:42:37 INFO - 'tsvg_static']}, 08:42:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:42:37 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:42:37 INFO - 'talos_options': ['--disable-stylo'], 08:42:37 INFO - 'tests': ['tp5o']}, 08:42:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:42:37 INFO - 'talos_options': ['--mitmproxy', 08:42:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:42:37 INFO - '--firstNonBlankPaint'], 08:42:37 INFO - 'tests': ['tp6_google', 08:42:37 INFO - 'tp6_youtube', 08:42:37 INFO - 'tp6_amazon', 08:42:37 INFO - 'tp6_facebook']}, 08:42:37 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:42:37 INFO - 'talos_options': ['--disable-stylo', 08:42:37 INFO - '--mitmproxy', 08:42:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:42:37 INFO - '--firstNonBlankPaint'], 08:42:37 INFO - 'tests': ['tp6_google', 08:42:37 INFO - 'tp6_youtube', 08:42:37 INFO - 'tp6_amazon', 08:42:37 INFO - 'tp6_facebook']}, 08:42:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:42:37 INFO - 'talos_options': ['--stylo-threads=1', 08:42:37 INFO - '--mitmproxy', 08:42:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:42:37 INFO - '--firstNonBlankPaint'], 08:42:37 INFO - 'tests': ['tp6_google', 08:42:37 INFO - 'tp6_youtube', 08:42:37 INFO - 'tp6_amazon', 08:42:37 INFO - 'tp6_facebook']}, 08:42:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:42:37 INFO - 'talos_options': ['--xperf_path', 08:42:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:37 INFO - 'tests': ['tp5n']}, 08:42:37 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:42:37 INFO - 'talos_options': ['--disable-stylo', 08:42:37 INFO - '--xperf_path', 08:42:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:37 INFO - 'tests': ['tp5n']}}} 08:42:37 INFO - Running post-action listener: _resource_record_post_action 08:42:37 INFO - [mozharness: 2017-09-21 15:42:37.643136Z] Finished populate-webroot step (success) 08:42:37 INFO - [mozharness: 2017-09-21 15:42:37.643225Z] Running create-virtualenv step. 08:42:37 INFO - Running pre-action listener: _resource_record_pre_action 08:42:37 INFO - Running main action method: create_virtualenv 08:42:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:37 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:42:37 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:42:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:42:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:38 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:38 INFO - Installing pip...............done. 08:42:38 INFO - Return code: 0 08:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:42:38 INFO - Reading from file tmpfile_stdout 08:42:38 INFO - Output received: 08:42:38 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 08:42:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:38 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 0x12581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1421a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8090>, '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 0x15c8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c2f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', '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 08:42:38 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 08:42:38 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 08:42:38 INFO - Using env: {'DISPLAY': ':0', 08:42:38 INFO - 'HOME': '/home/cltbld', 08:42:38 INFO - 'LANG': 'en_US.UTF-8', 08:42:38 INFO - 'LANGUAGE': 'en_US:en', 08:42:38 INFO - 'LOGNAME': 'cltbld', 08:42:38 INFO - 'MAIL': '/var/mail/cltbld', 08:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:38 INFO - 'MOZ_NO_REMOTE': '1', 08:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:38 INFO - 'NO_EM_RESTART': '1', 08:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:38 INFO - 'PWD': '/builds/slave/test', 08:42:38 INFO - 'SHELL': '/bin/bash', 08:42:38 INFO - 'SHLVL': '1', 08:42:38 INFO - 'TERM': 'linux', 08:42:38 INFO - 'TMOUT': '86400', 08:42:38 INFO - 'USER': 'cltbld', 08:42:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', 08:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:38 INFO - '_': '/tools/buildbot/bin/python'} 08:42:39 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:42:39 INFO - Downloading/unpacking pip>=1.5 08:42:39 INFO - Running setup.py egg_info for package pip 08:42:39 INFO - warning: no files found matching 'pip/cacert.pem' 08:42:39 INFO - warning: no files found matching '*.html' under directory 'docs' 08:42:39 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:42:39 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:42:39 INFO - Installing collected packages: pip 08:42:39 INFO - Found existing installation: pip 1.1 08:42:39 INFO - Uninstalling pip: 08:42:39 INFO - Successfully uninstalled pip 08:42:39 INFO - Running setup.py install for pip 08:42:39 INFO - warning: no files found matching 'pip/cacert.pem' 08:42:39 INFO - warning: no files found matching '*.html' under directory 'docs' 08:42:39 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:42:39 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:42:39 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:42:39 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:42:39 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:42:39 INFO - Successfully installed pip 08:42:39 INFO - Cleaning up... 08:42:39 INFO - Return code: 0 08:42:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:42:39 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')]} 08:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:39 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')]} 08:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:39 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 0x12581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1421a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8090>, '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 0x15c8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c2f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', '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 08:42:39 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 08:42:39 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 08:42:39 INFO - Using env: {'DISPLAY': ':0', 08:42:39 INFO - 'HOME': '/home/cltbld', 08:42:39 INFO - 'LANG': 'en_US.UTF-8', 08:42:39 INFO - 'LANGUAGE': 'en_US:en', 08:42:39 INFO - 'LOGNAME': 'cltbld', 08:42:39 INFO - 'MAIL': '/var/mail/cltbld', 08:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:39 INFO - 'MOZ_NO_REMOTE': '1', 08:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:39 INFO - 'NO_EM_RESTART': '1', 08:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:39 INFO - 'PWD': '/builds/slave/test', 08:42:39 INFO - 'SHELL': '/bin/bash', 08:42:39 INFO - 'SHLVL': '1', 08:42:39 INFO - 'TERM': 'linux', 08:42:39 INFO - 'TMOUT': '86400', 08:42:39 INFO - 'USER': 'cltbld', 08:42:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', 08:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:39 INFO - '_': '/tools/buildbot/bin/python'} 08:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:40 INFO - Downloading/unpacking psutil>=3.1.1 08:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:41 INFO - Installing collected packages: psutil 08:42:41 INFO - Running setup.py install for psutil 08:42:41 INFO - building 'psutil._psutil_linux' extension 08:42:41 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 08:42:41 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 08:42:41 INFO - building 'psutil._psutil_posix' extension 08:42:41 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 08:42:41 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 08:42:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:41 INFO - Successfully installed psutil 08:42:41 INFO - Cleaning up... 08:42:41 INFO - Return code: 0 08:42:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:41 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 0x12581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1421a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8090>, '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 0x15c8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c2f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', '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 08:42:41 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 08:42:41 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 08:42:41 INFO - Using env: {'DISPLAY': ':0', 08:42:41 INFO - 'HOME': '/home/cltbld', 08:42:41 INFO - 'LANG': 'en_US.UTF-8', 08:42:41 INFO - 'LANGUAGE': 'en_US:en', 08:42:41 INFO - 'LOGNAME': 'cltbld', 08:42:41 INFO - 'MAIL': '/var/mail/cltbld', 08:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:41 INFO - 'MOZ_NO_REMOTE': '1', 08:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:41 INFO - 'NO_EM_RESTART': '1', 08:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:41 INFO - 'PWD': '/builds/slave/test', 08:42:41 INFO - 'SHELL': '/bin/bash', 08:42:41 INFO - 'SHLVL': '1', 08:42:41 INFO - 'TERM': 'linux', 08:42:41 INFO - 'TMOUT': '86400', 08:42:41 INFO - 'USER': 'cltbld', 08:42:41 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', 08:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:41 INFO - '_': '/tools/buildbot/bin/python'} 08:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:42:42 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 08:42:42 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 08:42:42 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 08:42:42 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 08:42:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:42:43 INFO - Installing collected packages: mozsystemmonitor 08:42:43 INFO - Running setup.py install for mozsystemmonitor 08:42:43 INFO - Successfully installed mozsystemmonitor 08:42:43 INFO - Cleaning up... 08:42:44 INFO - Return code: 0 08:42:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42: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')]} 08:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1421a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8090>, '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 0x15c8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c2f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', '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 08:42:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:42:44 INFO - Using env: {'DISPLAY': ':0', 08:42:44 INFO - 'HOME': '/home/cltbld', 08:42:44 INFO - 'LANG': 'en_US.UTF-8', 08:42:44 INFO - 'LANGUAGE': 'en_US:en', 08:42:44 INFO - 'LOGNAME': 'cltbld', 08:42:44 INFO - 'MAIL': '/var/mail/cltbld', 08:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:44 INFO - 'MOZ_NO_REMOTE': '1', 08:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:44 INFO - 'NO_EM_RESTART': '1', 08:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:44 INFO - 'PWD': '/builds/slave/test', 08:42:44 INFO - 'SHELL': '/bin/bash', 08:42:44 INFO - 'SHLVL': '1', 08:42:44 INFO - 'TERM': 'linux', 08:42:44 INFO - 'TMOUT': '86400', 08:42:44 INFO - 'USER': 'cltbld', 08:42:44 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', 08:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:44 INFO - '_': '/tools/buildbot/bin/python'} 08:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:44 INFO - Downloading/unpacking jsonschema==2.5.1 08:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:42:46 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 08:42:46 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 08:42:46 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 08:42:46 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 08:42:46 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:46 INFO - warning: no files found matching '*.txt' 08:42:46 INFO - no previously-included directories found matching 'build' 08:42:46 INFO - no previously-included directories found matching 'dist' 08:42:46 INFO - no previously-included directories found matching '.git*' 08:42:46 INFO - Installing collected packages: jsonschema, functools32 08:42:46 INFO - Running setup.py install for functools32 08:42:47 INFO - warning: no files found matching '*.txt' 08:42:47 INFO - no previously-included directories found matching 'build' 08:42:47 INFO - no previously-included directories found matching 'dist' 08:42:47 INFO - no previously-included directories found matching '.git*' 08:42:47 INFO - Successfully installed jsonschema functools32 08:42:47 INFO - Cleaning up... 08:42:47 INFO - Return code: 0 08:42:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42: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')]} 08:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42: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', '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 0x12581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1421a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8090>, '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 0x15c8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c2f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', '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 08:42: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:42: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 functools32==3.2.3-2 08:42:47 INFO - Using env: {'DISPLAY': ':0', 08:42:47 INFO - 'HOME': '/home/cltbld', 08:42:47 INFO - 'LANG': 'en_US.UTF-8', 08:42:47 INFO - 'LANGUAGE': 'en_US:en', 08:42:47 INFO - 'LOGNAME': 'cltbld', 08:42:47 INFO - 'MAIL': '/var/mail/cltbld', 08:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:47 INFO - 'MOZ_NO_REMOTE': '1', 08:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:47 INFO - 'NO_EM_RESTART': '1', 08:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:47 INFO - 'PWD': '/builds/slave/test', 08:42:47 INFO - 'SHELL': '/bin/bash', 08:42:47 INFO - 'SHLVL': '1', 08:42:47 INFO - 'TERM': 'linux', 08:42:47 INFO - 'TMOUT': '86400', 08:42:47 INFO - 'USER': 'cltbld', 08:42:47 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', 08:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:47 INFO - '_': '/tools/buildbot/bin/python'} 08:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:42:47 INFO - Cleaning up... 08:42:47 INFO - Return code: 0 08:42:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42: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')]} 08:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42: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', '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 0x12581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1421a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8090>, '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 0x15c8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c2f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', '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 08:42: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:42: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 blobuploader==1.2.4 08:42:47 INFO - Using env: {'DISPLAY': ':0', 08:42:47 INFO - 'HOME': '/home/cltbld', 08:42:47 INFO - 'LANG': 'en_US.UTF-8', 08:42:47 INFO - 'LANGUAGE': 'en_US:en', 08:42:47 INFO - 'LOGNAME': 'cltbld', 08:42:47 INFO - 'MAIL': '/var/mail/cltbld', 08:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:47 INFO - 'MOZ_NO_REMOTE': '1', 08:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:47 INFO - 'NO_EM_RESTART': '1', 08:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:47 INFO - 'PWD': '/builds/slave/test', 08:42:47 INFO - 'SHELL': '/bin/bash', 08:42:47 INFO - 'SHLVL': '1', 08:42:47 INFO - 'TERM': 'linux', 08:42:47 INFO - 'TMOUT': '86400', 08:42:47 INFO - 'USER': 'cltbld', 08:42:47 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', 08:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:47 INFO - '_': '/tools/buildbot/bin/python'} 08:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:42: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 08:42: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 08:42: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 08:42: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 08:42:48 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42:48 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 08:42:48 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 08:42:48 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 08:42:48 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 08:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42:49 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 08:42:49 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 08:42:49 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 08:42:49 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 08:42:49 INFO - Downloading docopt-0.6.1.tar.gz 08:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:49 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:49 INFO - Running setup.py install for blobuploader 08:42:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:49 INFO - Running setup.py install for requests 08:42:49 INFO - Running setup.py install for docopt 08:42:49 INFO - Successfully installed blobuploader requests docopt 08:42:49 INFO - Cleaning up... 08:42:49 INFO - Return code: 0 08:42:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:49 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 0x12581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1421a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8090>, '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 0x15c8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c2f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', '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 08:42:49 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 08:42:49 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 08:42:49 INFO - Using env: {'DISPLAY': ':0', 08:42:49 INFO - 'HOME': '/home/cltbld', 08:42:49 INFO - 'LANG': 'en_US.UTF-8', 08:42:49 INFO - 'LANGUAGE': 'en_US:en', 08:42:49 INFO - 'LOGNAME': 'cltbld', 08:42:49 INFO - 'MAIL': '/var/mail/cltbld', 08:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:49 INFO - 'MOZ_NO_REMOTE': '1', 08:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:49 INFO - 'NO_EM_RESTART': '1', 08:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:49 INFO - 'PWD': '/builds/slave/test', 08:42:49 INFO - 'SHELL': '/bin/bash', 08:42:49 INFO - 'SHLVL': '1', 08:42:49 INFO - 'TERM': 'linux', 08:42:49 INFO - 'TMOUT': '86400', 08:42:49 INFO - 'USER': 'cltbld', 08:42:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', 08:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:49 INFO - '_': '/tools/buildbot/bin/python'} 08:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:50 INFO - Running setup.py (path:/tmp/pip-191Vdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:50 INFO - Running setup.py (path:/tmp/pip-yY2j_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:50 INFO - Running setup.py (path:/tmp/pip-gkc5Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:50 INFO - Running setup.py (path:/tmp/pip-PQZncr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:50 INFO - Running setup.py (path:/tmp/pip-3zESQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:50 INFO - Running setup.py (path:/tmp/pip-ksUaSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:50 INFO - Running setup.py (path:/tmp/pip-6LtECh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:50 INFO - Running setup.py (path:/tmp/pip-klAa3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:50 INFO - Running setup.py (path:/tmp/pip-NaIArP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:50 INFO - Running setup.py (path:/tmp/pip-Umhx6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:50 INFO - Running setup.py (path:/tmp/pip-Hh_RWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:50 INFO - Running setup.py (path:/tmp/pip-C29e1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:50 INFO - Running setup.py (path:/tmp/pip-P6wfYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:51 INFO - Running setup.py (path:/tmp/pip-Ev8UQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:51 INFO - Running setup.py (path:/tmp/pip-lasB_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:51 INFO - Running setup.py (path:/tmp/pip-dGumSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:51 INFO - Running setup.py (path:/tmp/pip-A7xPbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:51 INFO - Running setup.py install for manifestparser 08:42:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozcrash 08:42:51 INFO - Running setup.py install for mozdebug 08:42:51 INFO - Running setup.py install for mozdevice 08:42:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozfile 08:42:51 INFO - Running setup.py install for mozhttpd 08:42:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozinfo 08:42:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozInstall 08:42:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:52 INFO - Running setup.py install for mozleak 08:42:52 INFO - Running setup.py install for mozlog 08:42:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:52 INFO - Running setup.py install for moznetwork 08:42:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:52 INFO - Running setup.py install for mozprocess 08:42:52 INFO - Running setup.py install for mozprofile 08:42:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:52 INFO - Running setup.py install for mozrunner 08:42:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:52 INFO - Running setup.py install for mozscreenshot 08:42:52 INFO - Running setup.py install for moztest 08:42:52 INFO - Running setup.py install for mozversion 08:42:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:53 INFO - Cleaning up... 08:42:53 INFO - Return code: 0 08:42:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:53 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 0x12581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1421a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8090>, '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 0x15c8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c2f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', '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 08:42:53 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 08:42:53 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 08:42:53 INFO - Using env: {'DISPLAY': ':0', 08:42:53 INFO - 'HOME': '/home/cltbld', 08:42:53 INFO - 'LANG': 'en_US.UTF-8', 08:42:53 INFO - 'LANGUAGE': 'en_US:en', 08:42:53 INFO - 'LOGNAME': 'cltbld', 08:42:53 INFO - 'MAIL': '/var/mail/cltbld', 08:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:53 INFO - 'MOZ_NO_REMOTE': '1', 08:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:53 INFO - 'NO_EM_RESTART': '1', 08:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:53 INFO - 'PWD': '/builds/slave/test', 08:42:53 INFO - 'SHELL': '/bin/bash', 08:42:53 INFO - 'SHLVL': '1', 08:42:53 INFO - 'TERM': 'linux', 08:42:53 INFO - 'TMOUT': '86400', 08:42:53 INFO - 'USER': 'cltbld', 08:42:53 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', 08:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:53 INFO - '_': '/tools/buildbot/bin/python'} 08:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:53 INFO - Running setup.py (path:/tmp/pip-WDCBmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:53 INFO - Running setup.py (path:/tmp/pip-1Fhkc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:53 INFO - Running setup.py (path:/tmp/pip-xYu0lT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:53 INFO - Running setup.py (path:/tmp/pip-_C6cmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:53 INFO - Running setup.py (path:/tmp/pip-vJycBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:53 INFO - Running setup.py (path:/tmp/pip-YuVgAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:53 INFO - Running setup.py (path:/tmp/pip-9fZKdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:53 INFO - Running setup.py (path:/tmp/pip-KWo1h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:53 INFO - Running setup.py (path:/tmp/pip-ggadZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:53 INFO - Running setup.py (path:/tmp/pip-0wtTzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:54 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)) 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:54 INFO - Running setup.py (path:/tmp/pip-WPc1qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:54 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)) 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:54 INFO - Running setup.py (path:/tmp/pip-MUz2aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:54 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)) 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:54 INFO - Running setup.py (path:/tmp/pip-hRKk5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:54 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)) 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:54 INFO - Running setup.py (path:/tmp/pip-fnnGec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:54 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)) 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:54 INFO - Running setup.py (path:/tmp/pip-OQ90IS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:54 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)) 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:54 INFO - Running setup.py (path:/tmp/pip-6E3Git-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:54 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)) 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:54 INFO - Running setup.py (path:/tmp/pip-R7Ul7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:54 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)) 08:42:54 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)) 08:42:54 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)) 08:42:54 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)) 08:42:54 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)) 08:42:54 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)) 08:42:54 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)) 08:42:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42: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 08:42: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 08:42: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 08:42: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 08:42:55 INFO - Downloading blessings-1.6.tar.gz 08:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:55 INFO - Installing collected packages: blessings 08:42:55 INFO - Running setup.py install for blessings 08:42:55 INFO - Successfully installed blessings 08:42:55 INFO - Cleaning up... 08:42:55 INFO - Return code: 0 08:42:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:56 INFO - Reading from file tmpfile_stdout 08:42:56 INFO - Current package versions: 08:42:56 INFO - argparse == 1.2.1 08:42:56 INFO - blessings == 1.6 08:42:56 INFO - blobuploader == 1.2.4 08:42:56 INFO - docopt == 0.6.1 08:42:56 INFO - functools32 == 3.2.3-2 08:42:56 INFO - jsonschema == 2.5.1 08:42:56 INFO - manifestparser == 1.1 08:42:56 INFO - mozInstall == 1.13 08:42:56 INFO - mozcrash == 1.0 08:42:56 INFO - mozdebug == 0.1 08:42:56 INFO - mozdevice == 0.51 08:42:56 INFO - mozfile == 1.2 08:42:56 INFO - mozhttpd == 0.7 08:42:56 INFO - mozinfo == 0.10 08:42:56 INFO - mozleak == 0.1 08:42:56 INFO - mozlog == 3.5 08:42:56 INFO - moznetwork == 0.27 08:42:56 INFO - mozprocess == 0.25 08:42:56 INFO - mozprofile == 0.28 08:42:56 INFO - mozrunner == 6.13 08:42:56 INFO - mozscreenshot == 0.1 08:42:56 INFO - mozsystemmonitor == 0.3 08:42:56 INFO - moztest == 0.8 08:42:56 INFO - mozversion == 1.4 08:42:56 INFO - psutil == 3.1.1 08:42:56 INFO - requests == 1.2.3 08:42:56 INFO - wsgiref == 0.1.2 08:42:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:56 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 0x12581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1421a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8090>, '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 0x15c8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c2f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', '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 08:42:56 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 08:42:56 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 08:42:56 INFO - Using env: {'DISPLAY': ':0', 08:42:56 INFO - 'HOME': '/home/cltbld', 08:42:56 INFO - 'LANG': 'en_US.UTF-8', 08:42:56 INFO - 'LANGUAGE': 'en_US:en', 08:42:56 INFO - 'LOGNAME': 'cltbld', 08:42:56 INFO - 'MAIL': '/var/mail/cltbld', 08:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:56 INFO - 'MOZ_NO_REMOTE': '1', 08:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:56 INFO - 'NO_EM_RESTART': '1', 08:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:56 INFO - 'PWD': '/builds/slave/test', 08:42:56 INFO - 'SHELL': '/bin/bash', 08:42:56 INFO - 'SHLVL': '1', 08:42:56 INFO - 'TERM': 'linux', 08:42:56 INFO - 'TMOUT': '86400', 08:42:56 INFO - 'USER': 'cltbld', 08:42:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', 08:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:56 INFO - '_': '/tools/buildbot/bin/python'} 08:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:56 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)) 08:42:56 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)) 08:42:56 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)) 08:42:56 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)) 08:42:56 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)) 08:42:56 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)) 08:42:56 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)) 08:42:56 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)) 08:42:56 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)) 08:42:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:42:57 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)) 08:42:57 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)) 08:42:57 INFO - Installing collected packages: simplejson 08:42:57 INFO - Running setup.py install for simplejson 08:42:57 INFO - building 'simplejson._speedups' extension 08:42:57 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 08:42:58 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 08:42:58 INFO - Successfully installed simplejson 08:42:58 INFO - Cleaning up... 08:42:58 INFO - Return code: 0 08:42:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42: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')]} 08:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:58 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 0x12581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1421a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8090>, '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 0x15c8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c2f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', '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 08:42:58 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 08:42:58 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 08:42:58 INFO - Using env: {'DISPLAY': ':0', 08:42:58 INFO - 'HOME': '/home/cltbld', 08:42:58 INFO - 'LANG': 'en_US.UTF-8', 08:42:58 INFO - 'LANGUAGE': 'en_US:en', 08:42:58 INFO - 'LOGNAME': 'cltbld', 08:42:58 INFO - 'MAIL': '/var/mail/cltbld', 08:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:58 INFO - 'MOZ_NO_REMOTE': '1', 08:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:58 INFO - 'NO_EM_RESTART': '1', 08:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:58 INFO - 'PWD': '/builds/slave/test', 08:42:58 INFO - 'SHELL': '/bin/bash', 08:42:58 INFO - 'SHLVL': '1', 08:42:58 INFO - 'TERM': 'linux', 08:42:58 INFO - 'TMOUT': '86400', 08:42:58 INFO - 'USER': 'cltbld', 08:42:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', 08:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:58 INFO - '_': '/tools/buildbot/bin/python'} 08:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:42:58 INFO - Cleaning up... 08:42:58 INFO - Return code: 0 08:42:58 INFO - Running post-action listener: _resource_record_post_action 08:42:58 INFO - Running post-action listener: _start_resource_monitoring 08:42:58 INFO - Starting resource monitoring. 08:42:58 INFO - [mozharness: 2017-09-21 15:42:58.777798Z] Finished create-virtualenv step (success) 08:42:58 INFO - [mozharness: 2017-09-21 15:42:58.778309Z] Running install step. 08:42:58 INFO - Running pre-action listener: _resource_record_pre_action 08:42:58 INFO - Running main action method: install 08:42:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:58 INFO - Reading from file tmpfile_stdout 08:42:58 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:59 INFO - Reading from file tmpfile_stdout 08:42:59 INFO - Output received: 08:42:59 INFO - Usage: mozinstall [options] installer 08:42:59 INFO - Options: 08:42:59 INFO - -h, --help show this help message and exit 08:42:59 INFO - -d DEST, --destination=DEST 08:42:59 INFO - Directory to install application into. [default: 08:42:59 INFO - "/builds/slave/test"] 08:42:59 INFO - --app=APP Application being installed. [default: firefox] 08:42:59 INFO - mkdir: /builds/slave/test/build/application 08:42:59 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'] 08:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:43:16 INFO - Reading from file tmpfile_stdout 08:43:16 INFO - Output received: 08:43:16 INFO - /builds/slave/test/build/application/firefox/firefox 08:43:16 INFO - Running post-action listener: _resource_record_post_action 08:43:16 INFO - [mozharness: 2017-09-21 15:43:16.933900Z] Finished install step (success) 08:43:16 INFO - [mozharness: 2017-09-21 15:43:16.934149Z] Running setup-mitmproxy step. 08:43:16 INFO - Running pre-action listener: _resource_record_pre_action 08:43:16 INFO - Running main action method: setup_mitmproxy 08:43:16 INFO - Skipping: mitmproxy is not required 08:43:16 INFO - Running post-action listener: _resource_record_post_action 08:43:16 INFO - [mozharness: 2017-09-21 15:43:16.935344Z] Finished setup-mitmproxy step (success) 08:43:16 INFO - [mozharness: 2017-09-21 15:43:16.935564Z] Running run-tests step. 08:43:16 INFO - Running pre-action listener: _resource_record_pre_action 08:43:16 INFO - Running pre-action listener: _set_gcov_prefix 08:43:16 INFO - Running main action method: run_tests 08:43:16 WARNING - Try message not found. 08:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:16 INFO - Python 2.7.3 08:43:16 INFO - Return code: 0 08:43:16 INFO - grabbing minidump binary from tooltool 08:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:16 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 0x15c8090>, '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 0x15c8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c2f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:16 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 08:43:16 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 08:43:16 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 08:43:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:17 INFO - Return code: 0 08:43:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:43:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:17 INFO - ENV: RUST_BACKTRACE is now full 08:43:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:43:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:17 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/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 08:43:17 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/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 08:43:17 INFO - Using env: {'DISPLAY': ':0', 08:43:17 INFO - 'HOME': '/home/cltbld', 08:43:17 INFO - 'LANG': 'en_US.UTF-8', 08:43:17 INFO - 'LANGUAGE': 'en_US:en', 08:43:17 INFO - 'LOGNAME': 'cltbld', 08:43:17 INFO - 'MAIL': '/var/mail/cltbld', 08:43:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:17 INFO - 'MOZ_NO_REMOTE': '1', 08:43:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:17 INFO - 'NO_EM_RESTART': '1', 08:43:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:17 INFO - 'PWD': '/builds/slave/test', 08:43:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:17 INFO - 'RUST_BACKTRACE': 'full', 08:43:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:43:17 INFO - 'SHELL': '/bin/bash', 08:43:17 INFO - 'SHLVL': '1', 08:43:17 INFO - 'TERM': 'linux', 08:43:17 INFO - 'TMOUT': '86400', 08:43:17 INFO - 'USER': 'cltbld', 08:43:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', 08:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:17 INFO - '_': '/tools/buildbot/bin/python'} 08:43:17 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/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 08:43:17 INFO - mozversion application_buildid: 20170921144305 08:43:17 INFO - mozversion application_changeset: 835a92b19e3d7666890153a84bc635bc43a44cb2 08:43:17 INFO - mozversion application_display_name: Nightly 08:43:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:17 INFO - mozversion application_name: Firefox 08:43:17 INFO - mozversion application_remotingname: firefox 08:43:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:43:17 INFO - mozversion application_vendor: Mozilla 08:43:17 INFO - mozversion application_version: 58.0a1 08:43:17 INFO - mozversion platform_buildid: 20170921144305 08:43:17 INFO - mozversion platform_changeset: 835a92b19e3d7666890153a84bc635bc43a44cb2 08:43:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:43:17 INFO - mozversion platform_version: 58.0a1 08:43:17 INFO - using testdate: 1506008597 08:43:17 INFO - actual date: 1506008597 08:43:17 INFO - starting webserver on 'localhost:43968' 08:43:17 INFO - SUITE-START | Running 2 tests 08:43:17 INFO - TEST-START | dromaeo_css 08:43:17 INFO - Initialising browser for dromaeo_css test... 08:43:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43968/getInfo.html -profile /tmp/tmpPU1aEm/profile 08:43:17 INFO - TEST-INFO | started process 13439 (/builds/slave/test/build/application/firefox/firefox http://localhost:43968/getInfo.html) 08:43:22 INFO - TEST-INFO | 13439: exit 0 08:43:23 INFO - Browser initialized. 08:43:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:23 INFO - Using env: {'DISPLAY': ':0', 08:43:23 INFO - 'HOME': '/home/cltbld', 08:43:23 INFO - 'JSGC_DISABLE_POISONING': '1', 08:43:23 INFO - 'LANG': 'en_US.UTF-8', 08:43:23 INFO - 'LANGUAGE': 'en_US:en', 08:43:23 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:43:23 INFO - 'LOGNAME': 'cltbld', 08:43:23 INFO - 'MAIL': '/var/mail/cltbld', 08:43:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:23 INFO - 'MOZ_CRASHREPORTER': '1', 08:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:23 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:43:23 INFO - 'MOZ_NO_REMOTE': '1', 08:43:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:23 INFO - 'NO_EM_RESTART': '1', 08:43:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:23 INFO - 'PWD': '/builds/slave/test', 08:43:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:23 INFO - 'RUST_BACKTRACE': 'full', 08:43:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:43:23 INFO - 'SHELL': '/bin/bash', 08:43:23 INFO - 'SHLVL': '1', 08:43:23 INFO - 'TERM': 'linux', 08:43:23 INFO - 'TMOUT': '86400', 08:43:23 INFO - 'USER': 'cltbld', 08:43:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', 08:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:23 INFO - '_': '/tools/buildbot/bin/python'} 08:43:23 INFO - TEST-INFO | started process 13675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPU1aEm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:23 INFO - PID 13675 | 08:43:23 INFO - PID 13675 | (/builds/slave/test/build/application/firefox/firefox:13725): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:43:23 INFO - PID 13675 | 08:43:34 INFO - PID 13675 | RSS: Main: 154247168 08:43:34 INFO - PID 13675 | 08:46:31 INFO - PID 13675 | Cycle 1(1): loaded http://localhost:43968/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43968/tests/dromaeo/cssquery-ext.html) 08:46:33 INFO - PID 13675 | RSS: Main: 154505216 08:46:33 INFO - PID 13675 | 08:49:35 INFO - PID 13675 | Cycle 1(1): loaded http://localhost:43968/tests/dromaeo/cssquery-ext.html (next: http://localhost:43968/tests/dromaeo/cssquery-jquery.html) 08:49:35 INFO - PID 13675 | RSS: Main: 153120768 08:49:35 INFO - PID 13675 | 08:52:37 INFO - PID 13675 | Cycle 1(1): loaded http://localhost:43968/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43968/tests/dromaeo/cssquery-mootools.html) 08:52:37 INFO - PID 13675 | RSS: Main: 156569600 08:52:37 INFO - PID 13675 | 08:55:39 INFO - PID 13675 | Cycle 1(1): loaded http://localhost:43968/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43968/tests/dromaeo/cssquery-prototype.html) 08:55:40 INFO - PID 13675 | RSS: Main: 155070464 08:55:40 INFO - PID 13675 | 08:58:43 INFO - PID 13675 | Cycle 1(1): loaded http://localhost:43968/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43968/tests/dromaeo/cssquery-yui.html) 08:58:43 INFO - PID 13675 | RSS: Main: 156614656 08:58:43 INFO - PID 13675 | 09:01:45 INFO - PID 13675 | Cycle 1(1): loaded http://localhost:43968/tests/dromaeo/cssquery-yui.html (next: http://localhost:43968/tests/dromaeo/cssquery-dojo.html) 09:01:45 INFO - PID 13675 | RSS: Main: 158646272 09:01:45 INFO - PID 13675 | 09:01:45 INFO - PID 13675 | __start_tp_report 09:01:45 INFO - PID 13675 | _x_x_mozilla_page_load 09:01:45 INFO - PID 13675 | _x_x_mozilla_page_load_details 09:01:45 INFO - PID 13675 | |i|pagename|runs| 09:01:45 INFO - PID 13675 | |0;dojo.html;3147.197464646515;3182.013575791505;3182.283986103126;3199.0402879136254;3203.887863924763;6174.289956654986;6303.495720342373;6314;6364.872702545947;6429.067785171153;6259.123722678817;6274.4353008229255;6292;6310.1165836782775;6333.8099857004245;5804.187413762077;5822.679752613626;5835.124731290319;5846.649201047951;5951.732172052247;5895;5940.910886336708;5962.552808539355;5969.940300596982;5990.760369585233;5844.035734103868;5866.120081987693;5906.586538942232;5972.283326000886;6017.669028203447;5649;5755.366909639936;5841.7371218295275;5855.8536036599;5904.704764761745;5764.587676019402;5794.536437085023;5847.415258474119;5853.473187413153;5897;6367.4906007519285;6380.042993550958;6392.137061496732;6427.2929977702415;6458.160439142881;6793.490488213404;6860.828479288008;6870.31296870309;6873.347032031949;6889;6821.420179284767;6859.451243900476;6916.55042422241;6937.098177236978;6941.895871561931;6146.416090471398;6308.747650093991;6340.334264902165;6412.102305677209;6447.032945058232;6883.070785444002;6956.756513522002;7005.50961432705;7033.331833475811;7062;6670.666466676646;6675.065490831287;6718.899216511756;6737.023131645884;6760.898586521206;6726.192856857208;6729.528932974743;6770.83072923171;6834.384905358542;6853.383195512428;6571.901421478682;6683.298253683391;6716.093327400836;6816.318368163144;6818.386345228953;6815.659217039228;6842.794716158523;6892.207396149407;6894.586324820527;6896.827579310457;5324.6805191687845;5324.946750532445;5330.760115794798;5381.623286369917;5399.649022813504;4572.0855828834365;4629.421322334708;4632.72203667781;4658.930116048262;4674.5325467452985;5716.685582292931;5719.056355701263;5722.341930677942;5724.0841465366175;5736.741846616912;6695.799126026227;6707.798766037026;6713.295104014106;6720.462363010947;6727.66361681914;5642.689652069093;5718.628289161275;5730.455606717355;5741.19623252745;5747.310322761212;5816.418358164235;5838;5845.327787304429;5850.23946886902;5875.353711091777;6516.380943810425;6532.608043517404;6538.803835884931;6594.439472644879;6605.966970165215;6620.602763834186;6750.32496750321;6760.526763126731;6850.725970961205;6856.897146542906;6484.902726459012;6505;6534.901976470452;6591.472682185317;6605.471562275103;6713.362230588086;6724.831879203059;6748.223954245324;6752.527323087336;6767.526273160832;6810.897836532555;6825.488088393291;6836.93163068363;6897.896531552131;6931.653417329214;6382.0745991831855;6458.289588145394;6494.383033611799;6582.539222254396;6643.900341494785;6537.7058032389605;6539.6403197824575;6560.901586476302;6563.113979612691;6625.304343044104;6519.119918810899;6573.1783527059115;6590.439812615981;6632.369924857131;6647.069410282467;6627.502937279627;6662.533622646368;6699.162604674416;6749.966250168718;6787.626680532618;6264.5301602379095;6408.775692850728;6431.5819471734185;6445.1943507061615;6548.443382312556 09:01:45 INFO - PID 13675 | |1;ext.html;863.343858667413;864.2912811494575;867.5878957495195;911.2300106410081;913.2009491694768;39571;40271.59728402715;40299.79850100753;40338.79830600843;40373.19253614926;36195.819020904855;36411.27177456449;36483;36580.451293230624;36716;7100.254473280309;7231.385332246739;7233.855322893539;7250.963745181267;7257.129144502641;7150.392216661564;7226.241244669312;7240.312170343809;7242.818929526751;7248.1302243730825;7791.844163116734;7969.800754981114;7983.680652773911;7991.041075071;7995.880061799048;7863.13505514393;7944.682212711485;7945.483543569679;7946.443748937577;7948.085970113453;7712.57580833054;7866.842663146762;7902.20977902211;7910.723124690666;7915.366770658334;36011.819940900124;36016.819915900516;36066.8196659015;36310.8184459076;36319;3494.825258737053;3558.074900525856;3560.0565850049757;3566.6433356664384;3586.4261718124976;31343.529847052312;31401.52897706536;31409.214769630715;31417.21456963594;31424.685753142403;5166.5866730661455;5176.7929282828645;5184.948150518522;5219.921701174448;5282.947170528284;187025;187650;188004;188466;188817;47080.29379559309;47219.29171062437;47241.291380629315;47260.76369618199;47327.29009064867;48953.75523122433;48991;49056.509434905194;49062.509374906505;49082.75458622755;14292.071015383966;14671.119732815852;14684.559463216121;14696.55910322692;14703.852961470462;11935;11968.281903085843;11968.760624787456;11969.102317326235;11973.102017348734;13935.58193254204;14000.859991399955;14166.929165354108;14172.433102675777;14267;5646.265985421869;5705.229793977843;5741.770329186786;5838.065909454467;5882.852758743028;999.5551979369111;1001.7395477175987;1020.3316827478013;1024.3802499487851;1027.121810851726;22668.206612768474;22731.659025114637;22852.885735571548;22934.7706522936;23130.884345578164;1091.0834898685143;1091.6997825598023;1099.912007039435;1111.6220485034964;1111.8888111188817;12115.636530904087;12135.211211271238;12145.392730363446;12157.392130393446;12187.39063046844;230365;230944;231307;231353;231737;42170.57829421728;42935;50668;51977;52043;1406.2687402550616;1428.8285405751376;1431.5275958933528;1434.3688776938113;1440.877525410331;27019.72980270172;27362;27368;27411.31471713223;27599.44801104007;36493.27013459663;36516.452253216754;36738;36773;36816;193937;195975;196330;196502;196746;32255.193620159684;32524.674753252166;32956.34087318192;33031.83484082564;33417.331653367284;42511.362329564465;42940.78529607332;42978.570214297455;42983.355249671906;43023.354649679655;31112.533312000793;31253.843730781202;31573;31702.84148579242;31707.20731981719;30735.692643073282;30747.53878691777;31086.22284442907;31308.686913130576;31974.68025319717;35066.649333506335;35190;35380.64619353876;35606;35956.28087438289;30018.549721753756;30724.385512289184;30808.229794254425;31019.379612408076;31189.376212476076;23491.17780877661;23628.645570316803;23782.286531404086;23824.285271441884;24048.87975560181 09:01:45 INFO - PID 13675 | |2;jquery.html;566.388300635314;587.5446528940068;601.6330038676407;604.9153118563405;611.2023808929347;21958.45103872402;22648.54702905943;22707.432314192134;22775.20286789963;22781.4304642384;26060.86969565154;26777.464450710973;27058.729412705867;27173.456530869422;27209.86395068027;7138.678759455837;7262.709491620329;7285.0165227694115;7298.1971983082085;7306.232845551193;6444.387783160616;7134.143902731654;7135.607541585211;7171.53385029974;7204.675789589481;7140.714371425162;7148.035015272923;7150.356467917886;7159.856802863939;7165.928340716604;7046.753363632249;7126.322999315057;7128.073350464432;7138.821529461753;7158.606276654782;6922.238553759083;6961.547499412522;6965.651717414109;6978.685959131852;6991.615461149635;29969.70030299691;30480.695193048006;31105.377892442026;31173;31368.843155784074;2072.7098206251135;2122.80894719476;2124.5219825539284;2130.052126803573;2137.4549489879983;20660.276890308916;21067.894660526752;21130.894345528326;21149.68275475869;21242.256521021845;2518.0809004713333;2544.9745502544924;2617.9869100654373;2618.56793629051;2622.8164028518013;127185.36407317904;129016.35491822574;129729;129890.3505482476;129980.3500982489;20486;20817.58364832695;21801.890990544947;21836.781632183793;22211.222607208994;41358.79320603378;41869.79065104655;41899.58100419018;42045.159096818505;42086.15827683429;10642.148628109733;10696.839547406795;10836.620718274822;10920.945395272973;11055.281406708538;8780.253678437404;8824.161704638049;8824.470531768115;8905.821883562292;8937.553122343987;9473.384230025027;10946.616868409727;10998.285111467729;11429.714257143472;11476.88523114775;3882.3400021996326;3966.920661586752;4166.2295622461725;4244.490661120685;4422.867313980586;909.1090731083575;935.2377812083131;935.4340623922565;948.7106432538004;959.8944116147218;18731.719024214646;19008.61982760365;19172.520686982938;19236.615267694568;19249;977;984.1241295247236;984.7242772023844;989.1789814453986;991.4051569058652;10358.430286334173;10596.364218146937;10631.574737010587;10847.02376786093;10952.123830093573;485473;485953;494423;500567;503609;107060.46469767601;111546;114208;115621;116461.417692911;1149.7010777197822;1164.336328292882;1166.719987203065;1167.64970508847;1169.216624861328;17555.210015549586;17577.033263170648;17727.290908364037;17765.555861103578;17999.2800287987;54190.18714719361;54602.72698636481;55823.16265255943;55889.72055139698;56903;65524;65687.67156164188;65834;65836.67081664561;66125.33874661192;19273;19739.901300493406;19751.90124049428;19865.404037878885;19906.90046549758;22316.66525002094;22495.550088998454;22555.09779608863;22600.321990340315;22753.772462275167;18032.459026229233;18071.728924065887;18133.637327253644;18375.724364134283;18456.723149153044;15572.766408503654;16117.758233626739;16294.185290735179;16316.510504684878;16626.916865415595;18641.627167456303;18847.811521884607;19001.42995710131;19015.239390424227;19080.522986925436;18522.536936576693;19237.807621924163;19483.70774438413;19539.218431263158;19546.90226548858;17903.820961790214;18033.729494057337;18091.638167236844;18216.72674909851;18302.81697183011 09:01:45 INFO - PID 13675 | |3;mootools.html;1314.0015827746338;1379.2758801629143;1384.7922811578262;1402.5441731437286;1403.2001758997376;14794;15938.68122637548;15974.361025558963;15990;15992.280347384367;15980.600484987881;16124.032558046496;16213.675726485464;16232.918835405806;16252.805871207383;2822.6612806463204;2870.081573896354;2870.7129287071334;2871.770258379325;2871.7846161537864;2717.782577393804;2806.031918987946;2816.985915070422;2825.4631619992238;2826.519491686408;2665.0672264707296;2736.616873637692;2743.5747459143863;2776.0977682253247;2779.0551212587716;2817.5491921292596;2845.01846862832;2845.729655682707;2859.37093839355;2861.5850701648246;2646.4177880866177;2692.5018871508832;2725.1824452664123;2727.754502094821;2750.3124218945263;14893.106413615218;14984.850151498455;15036.548903532912;15047.849521504864;15083.622909427351;7846.646900889474;8083.8787418188185;8120.472169308976;8140.267375936135;8166;5545;5802.535797136261;5828.3297420796725;5939.851503712442;5954.4938680212235;1961.529232984088;1967.6753335699593;1979.3666026871406;2003.5892642008353;2015.2845739762467;27154.72845271542;27179.184624461297;27185.45629087407;27339.726602734117;27431.17706468789;6980.511364204558;7041.788746337618;7131.179914309817;7139.964300178466;7354.742584009641;17521.211545480484;17558.64882702339;17636.647267054588;17650.470485885446;17672;7801.180876008051;7907.367410607138;8496.447730897471;8745.212930836255;8745.212930836255;7288.70845166198;7456.105267367951;7552.848943021108;7769.145394006655;7771.961140194376;5265.657732247391;5411.538884501241;5437.211604317352;5483.698396588146;5498.422665620133;1630.5597488678227;1643.1373528897425;1654.6856097341467;1656.4450908945398;1673.790776152981;867.7526904832092;876.5967654878827;881.9955900220458;900.7297810656908;902.4449963272672;7407.296306850841;7417.740379086706;7466.991956085967;7493.85012299751;7539.811504712426;699.912510936133;705.5696025424487;706.0891450029507;712.0529695504966;717.1394326807851;5048.0913435581215;5061.5950723942;5093.134167191586;5271.604629652791;5374.48942350476;21595.784042159376;22420;22443.326700198693;22688.20591279297;23066.53866922652;21482.78517214808;21877.67183492249;21950.231741888958;22317;22373.776262237494;11687;11793.11551633631;11822.522184726737;11830.763384732429;11876.940615296868;7939.483933544301;8016.358691304798;8095.55474448911;8104.149064348394;8113.026436827618;18419.81580184181;19224;19247.90376048111;19341.12964916554;19568.510787230432;19193.520161995504;19580.11953821127;19714.901425493354;20217;20355.79644203539;10824.24230303871;10838.837417438903;11019.504122314675;11046.889531104907;11052.778944421227;14095.154290742588;14125.505607303696;14194.432222710975;14201.928990354982;14256;10667.733306667395;10705.090067344363;10723.463826808473;10799;11030.834537481784;10764.03123718869;10877.564897404016;10937.453127343442;11102.500387482422;11139.665810025712;10232;10257.076863082359;10266.178705703376;10298.279120461495;10351.275410721177;7311.926880731125;7416.66625001887;7421.257874212752;7460.776176714708;7492.62536873165;7101.183363913216;7103.25415831351;7132.572045677276;7176.282371762782;7182.317679820409 09:01:45 INFO - PID 13675 | |4;prototype.html;514.806947394727;520.539322699411;532.5127508329879;540.2976131029661;556.3129535024244;6433.1315272438205;6523.347665233486;6545.8363540911505;6545.901811472826;6583.177102862142;6321.589096708711;6366.713497892594;6401.839954001152;6447.516436267275;6463.935360646392;4976.900461990776;5304.443033481487;5316.644255714797;5366.892662146754;5380.542653874406;5124.871878203037;5143.614228932826;5144.022635699205;5159.406668233145;5193.16909294513;5082.440931497532;5103.693778373291;5107.514786095334;5109.284700141983;5115.335006449156;5115.10485665009;5116.155834287338;5127.5385215330425;5136.948630513722;5165.819196328111;4620.722756634613;4648.5119062498625;4655.371524844137;4666.183417901888;4670.112678591091;6138.6494971106285;6182.629042257434;6215.192025036761;6317.5893566918;6381.138546296237;5774.884502309972;5788.131780232957;5795.2176456178295;5798.304203495608;5817.883642327172;6660.267370589231;6671.232808227068;6682.331766823328;6700.631465269408;6723.899141512881;4982.825601103944;4989.476105008958;4997.575206107485;5027.265593370282;5041.823536176253;6889.931100689029;7009.474289428314;7035.472339574552;7049.89425158623;7070.858582828366;5138.126518491866;5144.819931302386;5161.27742116104;5171.689698618095;5177.559907407837;5219.973900130475;5234.659747116425;5241.842744717588;5256.763445644955;5277.445868183862;5788.450097240755;5799.681017544076;5803.390643982406;5808.361080281165;5821.592488525763;6391.520635952322;6406.615603063831;6550.901736473957;6619.470442364599;6695.163104611924;1767.920443580042;1770.9905353948127;1783.233209719833;1797.8381945624956;1801.2614827920752;1068.71144790906;1244.9875501245053;1253.9686507837196;1264.2288204195434;1269.8888472586486;5623.409541998113;5805.216295800013;5826.94173058264;5829.679367634736;5892.292924849045;6964.686589103502;6964.8856183010475;6968.989496522976;6976.19773726028;7005.579665220103;5693.259876216065;5738.512226460714;5806.796762113306;5816.011278082736;5840.474357307778;3580.5703315601772;3590.425531914881;3597.1726502903957;3624.1483251435893;3669;6600.768973085919;6623.714818387649;6626.867462650816;6646.567973081735;6674.965380366051;6977.965110174417;6977.965110174417;7003.299670032956;7020.894686579603;7042.964785176041;6436.80689579304;6468.838279043061;6529;6568.868622627616;6581.372926148075;6668.333166683293;6742.6628668567355;6744.865102698017;6819.727210911508;6828.419584335188;6748.662566871735;6789.93210067893;6809.978503224358;6877.415419689382;6887.111519650827;6598.538102332791;6599.208095028627;6621.966890165519;6652.567583107082;6689.866202676017;5055.469175736494;5075.137226671401;5086.287919691172;5115.18157094863;5138.691678499302;6643.667816609247;6751.56114852533;6751.932480675327;6793.796186114425;6834.760783372558;6453.838309104406;6478.4169424752;6480.8703825922275;6534.640594767334;6542.214934207926;6335.474461304863;6453;6499.707513161825;6514.283428822731;6555.573887697285;6541.70562324706;6559.770408035696;6573.211214654272;6598.37315455031;6608.7026083825385;6250.998881252844;6611.768588099393;6709.396154346132;6714.824905641395;6740.595564266159;6425.5502114851515;6450.935595626669;6467.838304042437;6482.416582507597;6485.254195767548 09:01:45 INFO - PID 13675 | |5;yui.html;906.8141031088626;914.1818072824826;922.7646950027741;922.8338898998181;923.7228831350593;18561.443156705303;19237.23051077957;22399.776002239974;23155.536889262246;23195.3041408758;20817.791822081774;21113.15547378107;22046.669299960515;22048.228312009083;22074.33776986689;970.5292932927524;974.449436068619;975.790205105902;978.3396207559904;978.9951050244739;965.8020105878278;966.2270183852925;993.4784238274891;994.2642444590987;1004.969850904474;1033.4729288063104;1040.4537617750666;1040.5317607076809;1041.073444634276;1041.6927006533053;1033.7208953582528;1037.6368271105127;1038.2939601071268;1038.8234000219982;1040.599369242843;753.9698412063511;755.0486387152173;759.8442319324525;760.3499008347839;770.0643717882799;19591.216351346073;20038.899805501023;20101.39695809128;20131.597368052702;20362.79637203624;21688.89155554228;22073.448163795874;22309.665355019686;22331.10675572975;22354.776452235434;18024.098795060327;18115.094245287684;18134.09329533518;18155.72766408505;18211.908940455345;3776.8866933992026;3785.867494637702;3835.3096442640312;3837.0982819037504;3871.7483363581277;144081;145720.27139864338;146663.99999999892;147052.2647386756;148465;16746.330146794236;16776.1611919406;17107.230174642173;17129.571760705832;17312.653746925243;25235.11677091293;25655.615165772528;32102.678973209968;32160.678393215767;32208.35583288321;7972.242636949481;9168.908310916806;9201.171894529525;9206.723798286062;9274.582643781046;4381.518033016366;4503.392042074278;4506.233940230169;4512.435945506812;4512.954870451254;5528.364238112588;5618.9604923089355;5646.8023619173955;5655.745491452894;5677.545796336283;1096.9780604387868;1114.9163812713916;1133.3313345126414;1142.0749193153572;1145.4902568357002;652.6573548886872;666.1839246922481;676.4655921821706;682.8054004608762;688.6350234375789;11727.4136293185;12042.39788010596;12148.45331960064;12792.680182995313;12798.552050678181;694.2952902803659;706.4595584377955;707.3209718670031;724.0044938209961;725.633555054694;5693.971530142323;5710.800121995793;5822.301323841166;5840.853978650568;5862.062070068769;125791.37104314603;127603.36198318949;127677.39070117897;128536.35731821468;131166.03250951244;107563.5796545098;109515;110246.44876775565;110622.89377106287;110636;92475;93804.53097734605;94186.5290673556;97926;98119.99999999857;10715.41065241388;10775.568977241137;10823.188260880623;10877.347359158475;11046.171537134587;43955;44531.33203001893;45463.77268113638;45885.77057114693;46897.76551117223;56950.43049569451;56953.43046569647;57604.42395576158;59987.70006149941;60541.394586053575;16028.198590070682;16480.42318518846;16523.091229982467;16784.24470898788;16790.916045419694;17479.82520174782;17507.649847002733;17557.648847023243;17603.119844008004;17807.109644517983;15922.920385397998;15952.760708589612;16150;16211.837881621033;16482.83517164813;16580.419685311437;16787;16915.7462638063;16939.745903811207;17081.658366832842;15141.242937853283;15151.166685832384;15356.232188390311;15424.614384640474;15623.687526249185;12077.27536347822;12162.817557736818;12409.565665201675;12412.875871241173;12492.31292278897;11153.107751379708;11254.606088786853;11269.380184089954;11288.492017859051;11432.314061156358 09:01:45 INFO - PID 13675 | __end_tp_report 09:01:45 INFO - PID 13675 | __start_cc_report 09:01:45 INFO - PID 13675 | _x_x_mozilla_cycle_collect,296 09:01:45 INFO - PID 13675 | __end_cc_report 09:01:45 INFO - PID 13675 | __startTimestamp1506009705838__endTimestamp 09:01:45 INFO - PID 13675 | 09:01:45 INFO - PID 13675 | ------- Summary: start ------- 09:01:45 INFO - PID 13675 | Number of tests: 6 09:01:45 INFO - PID 13675 | 09:01:45 INFO - PID 13675 | [#0] dojo.html Cycles:165 Average:6241.34 Median:6494.38 stddev:754.06 (11.6%) stddev-sans-first:716.25 09:01:45 INFO - PID 13675 | Values: 3147.2 3182.0 3182.3 3199.0 3203.9 6174.3 6303.5 6314.0 6364.9 6429.1 6259.1 6274.4 6292.0 6310.1 6333.8 5804.2 5822.7 5835.1 5846.6 5951.7 5895.0 5940.9 5962.6 5969.9 5990.8 5844.0 5866.1 5906.6 5972.3 6017.7 5649.0 5755.4 5841.7 5855.9 5904.7 5764.6 5794.5 5847.4 5853.5 5897.0 6367.5 6380.0 6392.1 6427.3 6458.2 6793.5 6860.8 6870.3 6873.3 6889.0 6821.4 6859.5 6916.6 6937.1 6941.9 6146.4 6308.7 6340.3 6412.1 6447.0 6883.1 6956.8 7005.5 7033.3 7062.0 6670.7 6675.1 6718.9 6737.0 6760.9 6726.2 6729.5 6770.8 6834.4 6853.4 6571.9 6683.3 6716.1 6816.3 6818.4 6815.7 6842.8 6892.2 6894.6 6896.8 5324.7 5324.9 5330.8 5381.6 5399.6 4572.1 4629.4 4632.7 4658.9 4674.5 5716.7 5719.1 5722.3 5724.1 5736.7 6695.8 6707.8 6713.3 6720.5 6727.7 5642.7 5718.6 5730.5 5741.2 5747.3 5816.4 5838.0 5845.3 5850.2 5875.4 6516.4 6532.6 6538.8 6594.4 6606.0 6620.6 6750.3 6760.5 6850.7 6856.9 6484.9 6505.0 6534.9 6591.5 6605.5 6713.4 6724.8 6748.2 6752.5 6767.5 6810.9 6825.5 6836.9 6897.9 6931.7 6382.1 6458.3 6494.4 6582.5 6643.9 6537.7 6539.6 6560.9 6563.1 6625.3 6519.1 6573.2 6590.4 6632.4 6647.1 6627.5 6662.5 6699.2 6750.0 6787.6 6264.5 6408.8 6431.6 6445.2 6548.4 09:01:45 INFO - PID 13675 | 09:01:45 INFO - PID 13675 | [#1] ext.html Cycles:180 Average:36905.18 Median:35128.32 stddev:53283.05 (151.7%) stddev-sans-first:53363.79 09:01:45 INFO - PID 13675 | Values: 863.3 864.3 867.6 911.2 913.2 39571.0 40271.6 40299.8 40338.8 40373.2 36195.8 36411.3 36483.0 36580.5 36716.0 7100.3 7231.4 7233.9 7251.0 7257.1 7150.4 7226.2 7240.3 7242.8 7248.1 7791.8 7969.8 7983.7 7991.0 7995.9 7863.1 7944.7 7945.5 7946.4 7948.1 7712.6 7866.8 7902.2 7910.7 7915.4 36011.8 36016.8 36066.8 36310.8 36319.0 3494.8 3558.1 3560.1 3566.6 3586.4 31343.5 31401.5 31409.2 31417.2 31424.7 5166.6 5176.8 5184.9 5219.9 5282.9 187025.0 187650.0 188004.0 188466.0 188817.0 47080.3 47219.3 47241.3 47260.8 47327.3 48953.8 48991.0 49056.5 49062.5 49082.8 14292.1 14671.1 14684.6 14696.6 14703.9 11935.0 11968.3 11968.8 11969.1 11973.1 13935.6 14000.9 14166.9 14172.4 14267.0 5646.3 5705.2 5741.8 5838.1 5882.9 999.6 1001.7 1020.3 1024.4 1027.1 22668.2 22731.7 22852.9 22934.8 23130.9 1091.1 1091.7 1099.9 1111.6 1111.9 12115.6 12135.2 12145.4 12157.4 12187.4 230365.0 230944.0 231307.0 231353.0 231737.0 42170.6 42935.0 50668.0 51977.0 52043.0 1406.3 1428.8 1431.5 1434.4 1440.9 27019.7 27362.0 27368.0 27411.3 27599.4 36493.3 36516.5 36738.0 36773.0 36816.0 193937.0 195975.0 196330.0 196502.0 196746.0 32255.2 32524.7 32956.3 33031.8 33417.3 42511.4 42940.8 42978.6 42983.4 43023.4 31112.5 31253.8 31573.0 31702.8 31707.2 30735.7 30747.5 31086.2 31308.7 31974.7 35066.6 35190.0 35380.6 35606.0 35956.3 30018.5 30724.4 30808.2 31019.4 31189.4 23491.2 23628.6 23782.3 23824.3 24048.9 09:01:45 INFO - PID 13675 | 09:01:45 INFO - PID 13675 | [#2] jquery.html Cycles:180 Average:35583.86 Median:22730.60 stddev:82583.08 (363.3%) stddev-sans-first:82772.90 09:01:45 INFO - PID 13675 | Values: 566.4 587.5 601.6 604.9 611.2 21958.5 22648.5 22707.4 22775.2 22781.4 26060.9 26777.5 27058.7 27173.5 27209.9 7138.7 7262.7 7285.0 7298.2 7306.2 6444.4 7134.1 7135.6 7171.5 7204.7 7140.7 7148.0 7150.4 7159.9 7165.9 7046.8 7126.3 7128.1 7138.8 7158.6 6922.2 6961.5 6965.7 6978.7 6991.6 29969.7 30480.7 31105.4 31173.0 31368.8 2072.7 2122.8 2124.5 2130.1 2137.5 20660.3 21067.9 21130.9 21149.7 21242.3 2518.1 2545.0 2618.0 2618.6 2622.8 127185.4 129016.4 129729.0 129890.4 129980.4 20486.0 20817.6 21801.9 21836.8 22211.2 41358.8 41869.8 41899.6 42045.2 42086.2 10642.1 10696.8 10836.6 10920.9 11055.3 8780.3 8824.2 8824.5 8905.8 8937.6 9473.4 10946.6 10998.3 11429.7 11476.9 3882.3 3966.9 4166.2 4244.5 4422.9 909.1 935.2 935.4 948.7 959.9 18731.7 19008.6 19172.5 19236.6 19249.0 977.0 984.1 984.7 989.2 991.4 10358.4 10596.4 10631.6 10847.0 10952.1 485473.0 485953.0 494423.0 500567.0 503609.0 107060.5 111546.0 114208.0 115621.0 116461.4 1149.7 1164.3 1166.7 1167.6 1169.2 17555.2 17577.0 17727.3 17765.6 17999.3 54190.2 54602.7 55823.2 55889.7 56903.0 65524.0 65687.7 65834.0 65836.7 66125.3 19273.0 19739.9 19751.9 19865.4 19906.9 22316.7 22495.6 22555.1 22600.3 22753.8 18032.5 18071.7 18133.6 18375.7 18456.7 15572.8 16117.8 16294.2 16316.5 16626.9 18641.6 18847.8 19001.4 19015.2 19080.5 18522.5 19237.8 19483.7 19539.2 19546.9 17903.8 18033.7 18091.6 18216.7 18302.8 09:01:45 INFO - PID 13675 | 09:01:45 INFO - PID 13675 | [#3] mootools.html Cycles:180 Average:9508.47 Median:27182.32 stddev:6873.94 (25.3%) stddev-sans-first:6865.65 09:01:45 INFO - PID 13675 | Values: 1314.0 1379.3 1384.8 1402.5 1403.2 14794.0 15938.7 15974.4 15990.0 15992.3 15980.6 16124.0 16213.7 16232.9 16252.8 2822.7 2870.1 2870.7 2871.8 2871.8 2717.8 2806.0 2817.0 2825.5 2826.5 2665.1 2736.6 2743.6 2776.1 2779.1 2817.5 2845.0 2845.7 2859.4 2861.6 2646.4 2692.5 2725.2 2727.8 2750.3 14893.1 14984.9 15036.5 15047.8 15083.6 7846.6 8083.9 8120.5 8140.3 8166.0 5545.0 5802.5 5828.3 5939.9 5954.5 1961.5 1967.7 1979.4 2003.6 2015.3 27154.7 27179.2 27185.5 27339.7 27431.2 6980.5 7041.8 7131.2 7140.0 7354.7 17521.2 17558.6 17636.6 17650.5 17672.0 7801.2 7907.4 8496.4 8745.2 8745.2 7288.7 7456.1 7552.8 7769.1 7772.0 5265.7 5411.5 5437.2 5483.7 5498.4 1630.6 1643.1 1654.7 1656.4 1673.8 867.8 876.6 882.0 900.7 902.4 7407.3 7417.7 7467.0 7493.9 7539.8 699.9 705.6 706.1 712.1 717.1 5048.1 5061.6 5093.1 5271.6 5374.5 21595.8 22420.0 22443.3 22688.2 23066.5 21482.8 21877.7 21950.2 22317.0 22373.8 11687.0 11793.1 11822.5 11830.8 11876.9 7939.5 8016.4 8095.6 8104.1 8113.0 18419.8 19224.0 19247.9 19341.1 19568.5 19193.5 19580.1 19714.9 20217.0 20355.8 10824.2 10838.8 11019.5 11046.9 11052.8 14095.2 14125.5 14194.4 14201.9 14256.0 10667.7 10705.1 10723.5 10799.0 11030.8 10764.0 10877.6 10937.5 11102.5 11139.7 10232.0 10257.1 10266.2 10298.3 10351.3 7311.9 7416.7 7421.3 7460.8 7492.6 7101.2 7103.3 7132.6 7176.3 7182.3 09:01:45 INFO - PID 13675 | 09:01:45 INFO - PID 13675 | [#4] prototype.html Cycles:180 Average:5618.41 Median:6328.53 stddev:1563.32 (24.7%) stddev-sans-first:1520.05 09:01:45 INFO - PID 13675 | Values: 514.8 520.5 532.5 540.3 556.3 6433.1 6523.3 6545.8 6545.9 6583.2 6321.6 6366.7 6401.8 6447.5 6463.9 4976.9 5304.4 5316.6 5366.9 5380.5 5124.9 5143.6 5144.0 5159.4 5193.2 5082.4 5103.7 5107.5 5109.3 5115.3 5115.1 5116.2 5127.5 5136.9 5165.8 4620.7 4648.5 4655.4 4666.2 4670.1 6138.6 6182.6 6215.2 6317.6 6381.1 5774.9 5788.1 5795.2 5798.3 5817.9 6660.3 6671.2 6682.3 6700.6 6723.9 4982.8 4989.5 4997.6 5027.3 5041.8 6889.9 7009.5 7035.5 7049.9 7070.9 5138.1 5144.8 5161.3 5171.7 5177.6 5220.0 5234.7 5241.8 5256.8 5277.4 5788.5 5799.7 5803.4 5808.4 5821.6 6391.5 6406.6 6550.9 6619.5 6695.2 1767.9 1771.0 1783.2 1797.8 1801.3 1068.7 1245.0 1254.0 1264.2 1269.9 5623.4 5805.2 5826.9 5829.7 5892.3 6964.7 6964.9 6969.0 6976.2 7005.6 5693.3 5738.5 5806.8 5816.0 5840.5 3580.6 3590.4 3597.2 3624.1 3669.0 6600.8 6623.7 6626.9 6646.6 6675.0 6978.0 6978.0 7003.3 7020.9 7043.0 6436.8 6468.8 6529.0 6568.9 6581.4 6668.3 6742.7 6744.9 6819.7 6828.4 6748.7 6789.9 6810.0 6877.4 6887.1 6598.5 6599.2 6622.0 6652.6 6689.9 5055.5 5075.1 5086.3 5115.2 5138.7 6643.7 6751.6 6751.9 6793.8 6834.8 6453.8 6478.4 6480.9 6534.6 6542.2 6335.5 6453.0 6499.7 6514.3 6555.6 6541.7 6559.8 6573.2 6598.4 6608.7 6251.0 6611.8 6709.4 6714.8 6740.6 6425.6 6450.9 6467.8 6482.4 6485.3 09:01:45 INFO - PID 13675 | 09:01:45 INFO - PID 13675 | [#5] yui.html Cycles:180 Average:24976.98 Median:20116.50 stddev:36393.04 (180.9%) stddev-sans-first:36450.26 09:01:45 INFO - PID 13675 | Values: 906.8 914.2 922.8 922.8 923.7 18561.4 19237.2 22399.8 23155.5 23195.3 20817.8 21113.2 22046.7 22048.2 22074.3 970.5 974.4 975.8 978.3 979.0 965.8 966.2 993.5 994.3 1005.0 1033.5 1040.5 1040.5 1041.1 1041.7 1033.7 1037.6 1038.3 1038.8 1040.6 754.0 755.0 759.8 760.3 770.1 19591.2 20038.9 20101.4 20131.6 20362.8 21688.9 22073.4 22309.7 22331.1 22354.8 18024.1 18115.1 18134.1 18155.7 18211.9 3776.9 3785.9 3835.3 3837.1 3871.7 144081.0 145720.3 146664.0 147052.3 148465.0 16746.3 16776.2 17107.2 17129.6 17312.7 25235.1 25655.6 32102.7 32160.7 32208.4 7972.2 9168.9 9201.2 9206.7 9274.6 4381.5 4503.4 4506.2 4512.4 4513.0 5528.4 5619.0 5646.8 5655.7 5677.5 1097.0 1114.9 1133.3 1142.1 1145.5 652.7 666.2 676.5 682.8 688.6 11727.4 12042.4 12148.5 12792.7 12798.6 694.3 706.5 707.3 724.0 725.6 5694.0 5710.8 5822.3 5840.9 5862.1 125791.4 127603.4 127677.4 128536.4 131166.0 107563.6 109515.0 110246.4 110622.9 110636.0 92475.0 93804.5 94186.5 97926.0 98120.0 10715.4 10775.6 10823.2 10877.3 11046.2 43955.0 44531.3 45463.8 45885.8 46897.8 56950.4 56953.4 57604.4 59987.7 60541.4 16028.2 16480.4 16523.1 16784.2 16790.9 17479.8 17507.6 17557.6 17603.1 17807.1 15922.9 15952.8 16150.0 16211.8 16482.8 16580.4 16787.0 16915.7 16939.7 17081.7 15141.2 15151.2 15356.2 15424.6 15623.7 12077.3 12162.8 12409.6 12412.9 12492.3 11153.1 11254.6 11269.4 11288.5 11432.3 09:01:45 INFO - PID 13675 | -------- Summary: end -------- 09:01:45 INFO - PID 13675 | 09:01:46 INFO - TEST-INFO | 13675: exit 0 09:01:46 INFO - TEST-OK | dromaeo_css | took 1109292ms 09:01:46 INFO - TEST-START | kraken 09:01:46 INFO - Initialising browser for kraken test... 09:01:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43968/getInfo.html -profile /tmp/tmpSMypQa/profile 09:01:46 INFO - TEST-INFO | started process 14047 (/builds/slave/test/build/application/firefox/firefox http://localhost:43968/getInfo.html) 09:01:51 INFO - TEST-INFO | 14047: exit 0 09:01:52 INFO - Browser initialized. 09:01:52 INFO - Running cycle 1/1 for kraken test... 09:01:52 INFO - Using env: {'DISPLAY': ':0', 09:01:52 INFO - 'HOME': '/home/cltbld', 09:01:52 INFO - 'JSGC_DISABLE_POISONING': '1', 09:01:52 INFO - 'LANG': 'en_US.UTF-8', 09:01:52 INFO - 'LANGUAGE': 'en_US:en', 09:01:52 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:01:52 INFO - 'LOGNAME': 'cltbld', 09:01:52 INFO - 'MAIL': '/var/mail/cltbld', 09:01:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:01:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:01:52 INFO - 'MOZ_CRASHREPORTER': '1', 09:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:52 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:01:52 INFO - 'MOZ_NO_REMOTE': '1', 09:01:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:52 INFO - 'NO_EM_RESTART': '1', 09:01:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:52 INFO - 'PWD': '/builds/slave/test', 09:01:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:01:52 INFO - 'RUST_BACKTRACE': 'full', 09:01:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:01:52 INFO - 'SHELL': '/bin/bash', 09:01:52 INFO - 'SHLVL': '1', 09:01:52 INFO - 'TERM': 'linux', 09:01:52 INFO - 'TMOUT': '86400', 09:01:52 INFO - 'USER': 'cltbld', 09:01:52 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451', 09:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:52 INFO - '_': '/tools/buildbot/bin/python'} 09:01:52 INFO - TEST-INFO | started process 14280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSMypQa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:52 INFO - PID 14280 | 09:01:52 INFO - PID 14280 | (/builds/slave/test/build/application/firefox/firefox:14329): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:01:52 INFO - PID 14280 | 09:02:03 INFO - PID 14280 | RSS: Main: 154800128 09:02:03 INFO - PID 14280 | 09:02:05 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43968/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:06 INFO - PID 14280 | RSS: Main: 160911360 09:02:06 INFO - PID 14280 | 09:02:09 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43968/tests/kraken/driver.html?testName=audio-dft) 09:02:10 INFO - PID 14280 | RSS: Main: 161124352 09:02:10 INFO - PID 14280 | 09:02:13 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43968/tests/kraken/driver.html?testName=audio-fft) 09:02:13 INFO - PID 14280 | RSS: Main: 156860416 09:02:13 INFO - PID 14280 | 09:02:15 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43968/tests/kraken/driver.html?testName=audio-oscillator) 09:02:16 INFO - PID 14280 | RSS: Main: 157396992 09:02:16 INFO - PID 14280 | 09:02:18 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43968/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:19 INFO - PID 14280 | RSS: Main: 157147136 09:02:19 INFO - PID 14280 | 09:02:22 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43968/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:22 INFO - PID 14280 | RSS: Main: 159784960 09:02:22 INFO - PID 14280 | 09:02:26 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43968/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:27 INFO - PID 14280 | RSS: Main: 160133120 09:02:27 INFO - PID 14280 | 09:02:30 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43968/tests/kraken/driver.html?testName=json-parse-financial) 09:02:30 INFO - PID 14280 | RSS: Main: 160067584 09:02:30 INFO - PID 14280 | 09:02:32 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43968/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:33 INFO - PID 14280 | RSS: Main: 159449088 09:02:33 INFO - PID 14280 | 09:02:34 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43968/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:35 INFO - PID 14280 | RSS: Main: 160034816 09:02:35 INFO - PID 14280 | 09:02:37 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43968/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:38 INFO - PID 14280 | RSS: Main: 157147136 09:02:38 INFO - PID 14280 | 09:02:40 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:41 INFO - PID 14280 | RSS: Main: 157327360 09:02:41 INFO - PID 14280 | 09:02:44 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:44 INFO - PID 14280 | RSS: Main: 157483008 09:02:44 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | Cycle 1(1): loaded http://localhost:43968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43968/tests/kraken/driver.html?testName=ai-astar) 09:02:46 INFO - PID 14280 | RSS: Main: 158699520 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | __start_tp_report 09:02:46 INFO - PID 14280 | _x_x_mozilla_page_load 09:02:46 INFO - PID 14280 | _x_x_mozilla_page_load_details 09:02:46 INFO - PID 14280 | |i|pagename|runs| 09:02:46 INFO - PID 14280 | |0;ai-astar;106;107;106;106;111;107;106;106;106;108 09:02:46 INFO - PID 14280 | |1;audio-beat-detection;116;115;116;123;115;118;143;118;117;117 09:02:46 INFO - PID 14280 | |2;audio-dft;163;162;162;164;164;163;161;164;166;166 09:02:46 INFO - PID 14280 | |3;audio-fft;76;74;74;73;85;74;73;75;74;73 09:02:46 INFO - PID 14280 | |4;audio-oscillator;80;79;80;79;82;81;79;80;80;79 09:02:46 INFO - PID 14280 | |5;imaging-gaussian-blur;113;113;115;113;113;114;114;114;113;116 09:02:46 INFO - PID 14280 | |6;imaging-darkroom;151;148;148;149;148;152;148;149;149;149 09:02:46 INFO - PID 14280 | |7;imaging-desaturate;94;93;99;98;93;93;95;95;94;95 09:02:46 INFO - PID 14280 | |8;json-parse-financial;52;52;52;52;57;50;50;51;59;52 09:02:46 INFO - PID 14280 | |9;json-stringify-tinderbox;38;38;43;39;38;38;38;38;38;39 09:02:46 INFO - PID 14280 | |10;stanford-crypto-aes;72;73;72;74;76;72;73;72;74;73 09:02:46 INFO - PID 14280 | |11;stanford-crypto-ccm;116;109;118;107;110;111;109;115;114;111 09:02:46 INFO - PID 14280 | |12;stanford-crypto-pbkdf2;166;169;166;168;169;166;171;183;168;167 09:02:46 INFO - PID 14280 | |13;stanford-crypto-sha256-iterative;70;69;67;66;66;68;65;67;68;65 09:02:46 INFO - PID 14280 | __end_tp_report 09:02:46 INFO - PID 14280 | __start_cc_report 09:02:46 INFO - PID 14280 | _x_x_mozilla_cycle_collect,747 09:02:46 INFO - PID 14280 | __end_cc_report 09:02:46 INFO - PID 14280 | __startTimestamp1506009766724__endTimestamp 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | ------- Summary: start ------- 09:02:46 INFO - PID 14280 | Number of tests: 14 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#0] ai-astar Cycles:10 Average:106.90 Median:106.50 stddev:1.60 (1.5%) stddev-sans-first:1.66 09:02:46 INFO - PID 14280 | Values: 106.0 107.0 106.0 106.0 111.0 107.0 106.0 106.0 106.0 108.0 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:117.50 stddev:8.47 (7.2%) stddev-sans-first:8.87 09:02:46 INFO - PID 14280 | Values: 116.0 115.0 116.0 123.0 115.0 118.0 143.0 118.0 117.0 117.0 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 09:02:46 INFO - PID 14280 | Values: 163.0 162.0 162.0 164.0 164.0 163.0 161.0 164.0 166.0 166.0 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#3] audio-fft Cycles:10 Average:75.10 Median:74.00 stddev:3.60 (4.9%) stddev-sans-first:3.81 09:02:46 INFO - PID 14280 | Values: 76.0 74.0 74.0 73.0 85.0 74.0 73.0 75.0 74.0 73.0 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#4] audio-oscillator Cycles:10 Average:79.90 Median:80.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 09:02:46 INFO - PID 14280 | Values: 80.0 79.0 80.0 79.0 82.0 81.0 79.0 80.0 80.0 79.0 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.03 (0.9%) stddev-sans-first:1.05 09:02:46 INFO - PID 14280 | Values: 113.0 113.0 115.0 113.0 113.0 114.0 114.0 114.0 113.0 116.0 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:1.37 (0.9%) stddev-sans-first:1.27 09:02:46 INFO - PID 14280 | Values: 151.0 148.0 148.0 149.0 148.0 152.0 148.0 149.0 149.0 149.0 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:2.08 (2.2%) stddev-sans-first:2.18 09:02:46 INFO - PID 14280 | Values: 94.0 93.0 99.0 98.0 93.0 93.0 95.0 95.0 94.0 95.0 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.00 stddev:2.95 (5.7%) stddev-sans-first:3.11 09:02:46 INFO - PID 14280 | Values: 52.0 52.0 52.0 52.0 57.0 50.0 50.0 51.0 59.0 52.0 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#9] json-stringify-tinderbox Cycles:10 Average:38.70 Median:38.00 stddev:1.57 (4.1%) stddev-sans-first:1.64 09:02:46 INFO - PID 14280 | Values: 38.0 38.0 43.0 39.0 38.0 38.0 38.0 38.0 38.0 39.0 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.00 stddev:1.29 (1.8%) stddev-sans-first:1.30 09:02:46 INFO - PID 14280 | Values: 72.0 73.0 72.0 74.0 76.0 72.0 73.0 72.0 74.0 73.0 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#11] stanford-crypto-ccm Cycles:10 Average:112.00 Median:112.50 stddev:3.56 (3.2%) stddev-sans-first:3.47 09:02:46 INFO - PID 14280 | Values: 116.0 109.0 118.0 107.0 110.0 111.0 109.0 115.0 114.0 111.0 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:168.50 stddev:5.08 (3.0%) stddev-sans-first:5.24 09:02:46 INFO - PID 14280 | Values: 166.0 169.0 166.0 168.0 169.0 166.0 171.0 183.0 168.0 167.0 09:02:46 INFO - PID 14280 | 09:02:46 INFO - PID 14280 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.66 (2.5%) stddev-sans-first:1.39 09:02:46 INFO - PID 14280 | Values: 70.0 69.0 67.0 66.0 66.0 68.0 65.0 67.0 68.0 65.0 09:02:46 INFO - PID 14280 | -------- Summary: end -------- 09:02:46 INFO - PID 14280 | 09:02:47 INFO - PID 14280 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:02:47 INFO - TEST-INFO | 14280: exit 0 09:02:47 INFO - TEST-OK | kraken | took 60790ms 09:02:47 INFO - SUITE-END | took 1170s 09:02:47 INFO - Completed test suite (00:19:30) 09:02:47 INFO - javascript benchmark 09:02:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8676.471187896199, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3147.197464646515, 3182.013575791505, 3182.283986103126, 3199.0402879136254, 3203.887863924763, 6174.289956654986, 6303.495720342373, 6314.0, 6364.872702545947, 6429.067785171153, 6259.123722678817, 6274.4353008229255, 6292.0, 6310.1165836782775, 6333.8099857004245, 5804.187413762077, 5822.679752613626, 5835.124731290319, 5846.649201047951, 5951.732172052247, 5895.0, 5940.910886336708, 5962.552808539355, 5969.940300596982, 5990.760369585233, 5844.035734103868, 5866.120081987693, 5906.586538942232, 5972.283326000886, 6017.669028203447, 5649.0, 5755.366909639936, 5841.7371218295275, 5855.8536036599, 5904.704764761745, 5764.587676019402, 5794.536437085023, 5847.415258474119, 5853.473187413153, 5897.0, 6367.4906007519285, 6380.042993550958, 6392.137061496732, 6427.2929977702415, 6458.160439142881, 6793.490488213404, 6860.828479288008, 6870.31296870309, 6873.347032031949, 6889.0, 6821.420179284767, 6859.451243900476, 6916.55042422241, 6937.098177236978, 6941.895871561931, 6146.416090471398, 6308.747650093991, 6340.334264902165, 6412.102305677209, 6447.032945058232, 6883.070785444002, 6956.756513522002, 7005.50961432705, 7033.331833475811, 7062.0, 6670.666466676646, 6675.065490831287, 6718.899216511756, 6737.023131645884, 6760.898586521206, 6726.192856857208, 6729.528932974743, 6770.83072923171, 6834.384905358542, 6853.383195512428, 6571.901421478682, 6683.298253683391, 6716.093327400836, 6816.318368163144, 6818.386345228953, 6815.659217039228, 6842.794716158523, 6892.207396149407, 6894.586324820527, 6896.827579310457, 5324.6805191687845, 5324.946750532445, 5330.760115794798, 5381.623286369917, 5399.649022813504, 4572.0855828834365, 4629.421322334708, 4632.72203667781, 4658.930116048262, 4674.5325467452985, 5716.685582292931, 5719.056355701263, 5722.341930677942, 5724.0841465366175, 5736.741846616912, 6695.799126026227, 6707.798766037026, 6713.295104014106, 6720.462363010947, 6727.66361681914, 5642.689652069093, 5718.628289161275, 5730.455606717355, 5741.19623252745, 5747.310322761212, 5816.418358164235, 5838.0, 5845.327787304429, 5850.23946886902, 5875.353711091777, 6516.380943810425, 6532.608043517404, 6538.803835884931, 6594.439472644879, 6605.966970165215, 6620.602763834186, 6750.32496750321, 6760.526763126731, 6850.725970961205, 6856.897146542906, 6484.902726459012, 6505.0, 6534.901976470452, 6591.472682185317, 6605.471562275103, 6713.362230588086, 6724.831879203059, 6748.223954245324, 6752.527323087336, 6767.526273160832, 6810.897836532555, 6825.488088393291, 6836.93163068363, 6897.896531552131, 6931.653417329214, 6382.0745991831855, 6458.289588145394, 6494.383033611799, 6582.539222254396, 6643.900341494785, 6537.7058032389605, 6539.6403197824575, 6560.901586476302, 6563.113979612691, 6625.304343044104, 6519.119918810899, 6573.1783527059115, 6590.439812615981, 6632.369924857131, 6647.069410282467, 6627.502937279627, 6662.533622646368, 6699.162604674416, 6749.966250168718, 6787.626680532618, 6264.5301602379095, 6408.775692850728, 6431.5819471734185, 6445.1943507061615, 6548.443382312556], "value": 6183.490433172513, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.343858667413, 864.2912811494575, 867.5878957495195, 911.2300106410081, 913.2009491694768, 39571.0, 40271.59728402715, 40299.79850100753, 40338.79830600843, 40373.19253614926, 36195.819020904855, 36411.27177456449, 36483.0, 36580.451293230624, 36716.0, 7100.254473280309, 7231.385332246739, 7233.855322893539, 7250.963745181267, 7257.129144502641, 7150.392216661564, 7226.241244669312, 7240.312170343809, 7242.818929526751, 7248.1302243730825, 7791.844163116734, 7969.800754981114, 7983.680652773911, 7991.041075071, 7995.880061799048, 7863.13505514393, 7944.682212711485, 7945.483543569679, 7946.443748937577, 7948.085970113453, 7712.57580833054, 7866.842663146762, 7902.20977902211, 7910.723124690666, 7915.366770658334, 36011.819940900124, 36016.819915900516, 36066.8196659015, 36310.8184459076, 36319.0, 3494.825258737053, 3558.074900525856, 3560.0565850049757, 3566.6433356664384, 3586.4261718124976, 31343.529847052312, 31401.52897706536, 31409.214769630715, 31417.21456963594, 31424.685753142403, 5166.5866730661455, 5176.7929282828645, 5184.948150518522, 5219.921701174448, 5282.947170528284, 187025.0, 187650.0, 188004.0, 188466.0, 188817.0, 47080.29379559309, 47219.29171062437, 47241.291380629315, 47260.76369618199, 47327.29009064867, 48953.75523122433, 48991.0, 49056.509434905194, 49062.509374906505, 49082.75458622755, 14292.071015383966, 14671.119732815852, 14684.559463216121, 14696.55910322692, 14703.852961470462, 11935.0, 11968.281903085843, 11968.760624787456, 11969.102317326235, 11973.102017348734, 13935.58193254204, 14000.859991399955, 14166.929165354108, 14172.433102675777, 14267.0, 5646.265985421869, 5705.229793977843, 5741.770329186786, 5838.065909454467, 5882.852758743028, 999.5551979369111, 1001.7395477175987, 1020.3316827478013, 1024.3802499487851, 1027.121810851726, 22668.206612768474, 22731.659025114637, 22852.885735571548, 22934.7706522936, 23130.884345578164, 1091.0834898685143, 1091.6997825598023, 1099.912007039435, 1111.6220485034964, 1111.8888111188817, 12115.636530904087, 12135.211211271238, 12145.392730363446, 12157.392130393446, 12187.39063046844, 230365.0, 230944.0, 231307.0, 231353.0, 231737.0, 42170.57829421728, 42935.0, 50668.0, 51977.0, 52043.0, 1406.2687402550616, 1428.8285405751376, 1431.5275958933528, 1434.3688776938113, 1440.877525410331, 27019.72980270172, 27362.0, 27368.0, 27411.31471713223, 27599.44801104007, 36493.27013459663, 36516.452253216754, 36738.0, 36773.0, 36816.0, 193937.0, 195975.0, 196330.0, 196502.0, 196746.0, 32255.193620159684, 32524.674753252166, 32956.34087318192, 33031.83484082564, 33417.331653367284, 42511.362329564465, 42940.78529607332, 42978.570214297455, 42983.355249671906, 43023.354649679655, 31112.533312000793, 31253.843730781202, 31573.0, 31702.84148579242, 31707.20731981719, 30735.692643073282, 30747.53878691777, 31086.22284442907, 31308.686913130576, 31974.68025319717, 35066.649333506335, 35190.0, 35380.64619353876, 35606.0, 35956.28087438289, 30018.549721753756, 30724.385512289184, 30808.229794254425, 31019.379612408076, 31189.376212476076, 23491.17780877661, 23628.645570316803, 23782.286531404086, 23824.285271441884, 24048.87975560181], "value": 16871.376428193857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.388300635314, 587.5446528940068, 601.6330038676407, 604.9153118563405, 611.2023808929347, 21958.45103872402, 22648.54702905943, 22707.432314192134, 22775.20286789963, 22781.4304642384, 26060.86969565154, 26777.464450710973, 27058.729412705867, 27173.456530869422, 27209.86395068027, 7138.678759455837, 7262.709491620329, 7285.0165227694115, 7298.1971983082085, 7306.232845551193, 6444.387783160616, 7134.143902731654, 7135.607541585211, 7171.53385029974, 7204.675789589481, 7140.714371425162, 7148.035015272923, 7150.356467917886, 7159.856802863939, 7165.928340716604, 7046.753363632249, 7126.322999315057, 7128.073350464432, 7138.821529461753, 7158.606276654782, 6922.238553759083, 6961.547499412522, 6965.651717414109, 6978.685959131852, 6991.615461149635, 29969.70030299691, 30480.695193048006, 31105.377892442026, 31173.0, 31368.843155784074, 2072.7098206251135, 2122.80894719476, 2124.5219825539284, 2130.052126803573, 2137.4549489879983, 20660.276890308916, 21067.894660526752, 21130.894345528326, 21149.68275475869, 21242.256521021845, 2518.0809004713333, 2544.9745502544924, 2617.9869100654373, 2618.56793629051, 2622.8164028518013, 127185.36407317904, 129016.35491822574, 129729.0, 129890.3505482476, 129980.3500982489, 20486.0, 20817.58364832695, 21801.890990544947, 21836.781632183793, 22211.222607208994, 41358.79320603378, 41869.79065104655, 41899.58100419018, 42045.159096818505, 42086.15827683429, 10642.148628109733, 10696.839547406795, 10836.620718274822, 10920.945395272973, 11055.281406708538, 8780.253678437404, 8824.161704638049, 8824.470531768115, 8905.821883562292, 8937.553122343987, 9473.384230025027, 10946.616868409727, 10998.285111467729, 11429.714257143472, 11476.88523114775, 3882.3400021996326, 3966.920661586752, 4166.2295622461725, 4244.490661120685, 4422.867313980586, 909.1090731083575, 935.2377812083131, 935.4340623922565, 948.7106432538004, 959.8944116147218, 18731.719024214646, 19008.61982760365, 19172.520686982938, 19236.615267694568, 19249.0, 977.0, 984.1241295247236, 984.7242772023844, 989.1789814453986, 991.4051569058652, 10358.430286334173, 10596.364218146937, 10631.574737010587, 10847.02376786093, 10952.123830093573, 485473.0, 485953.0, 494423.0, 500567.0, 503609.0, 107060.46469767601, 111546.0, 114208.0, 115621.0, 116461.417692911, 1149.7010777197822, 1164.336328292882, 1166.719987203065, 1167.64970508847, 1169.216624861328, 17555.210015549586, 17577.033263170648, 17727.290908364037, 17765.555861103578, 17999.2800287987, 54190.18714719361, 54602.72698636481, 55823.16265255943, 55889.72055139698, 56903.0, 65524.0, 65687.67156164188, 65834.0, 65836.67081664561, 66125.33874661192, 19273.0, 19739.901300493406, 19751.90124049428, 19865.404037878885, 19906.90046549758, 22316.66525002094, 22495.550088998454, 22555.09779608863, 22600.321990340315, 22753.772462275167, 18032.459026229233, 18071.728924065887, 18133.637327253644, 18375.724364134283, 18456.723149153044, 15572.766408503654, 16117.758233626739, 16294.185290735179, 16316.510504684878, 16626.916865415595, 18641.627167456303, 18847.811521884607, 19001.42995710131, 19015.239390424227, 19080.522986925436, 18522.536936576693, 19237.807621924163, 19483.70774438413, 19539.218431263158, 19546.90226548858, 17903.820961790214, 18033.729494057337, 18091.638167236844, 18216.72674909851, 18302.81697183011], "value": 12832.438259183076, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.0015827746338, 1379.2758801629143, 1384.7922811578262, 1402.5441731437286, 1403.2001758997376, 14794.0, 15938.68122637548, 15974.361025558963, 15990.0, 15992.280347384367, 15980.600484987881, 16124.032558046496, 16213.675726485464, 16232.918835405806, 16252.805871207383, 2822.6612806463204, 2870.081573896354, 2870.7129287071334, 2871.770258379325, 2871.7846161537864, 2717.782577393804, 2806.031918987946, 2816.985915070422, 2825.4631619992238, 2826.519491686408, 2665.0672264707296, 2736.616873637692, 2743.5747459143863, 2776.0977682253247, 2779.0551212587716, 2817.5491921292596, 2845.01846862832, 2845.729655682707, 2859.37093839355, 2861.5850701648246, 2646.4177880866177, 2692.5018871508832, 2725.1824452664123, 2727.754502094821, 2750.3124218945263, 14893.106413615218, 14984.850151498455, 15036.548903532912, 15047.849521504864, 15083.622909427351, 7846.646900889474, 8083.8787418188185, 8120.472169308976, 8140.267375936135, 8166.0, 5545.0, 5802.535797136261, 5828.3297420796725, 5939.851503712442, 5954.4938680212235, 1961.529232984088, 1967.6753335699593, 1979.3666026871406, 2003.5892642008353, 2015.2845739762467, 27154.72845271542, 27179.184624461297, 27185.45629087407, 27339.726602734117, 27431.17706468789, 6980.511364204558, 7041.788746337618, 7131.179914309817, 7139.964300178466, 7354.742584009641, 17521.211545480484, 17558.64882702339, 17636.647267054588, 17650.470485885446, 17672.0, 7801.180876008051, 7907.367410607138, 8496.447730897471, 8745.212930836255, 8745.212930836255, 7288.70845166198, 7456.105267367951, 7552.848943021108, 7769.145394006655, 7771.961140194376, 5265.657732247391, 5411.538884501241, 5437.211604317352, 5483.698396588146, 5498.422665620133, 1630.5597488678227, 1643.1373528897425, 1654.6856097341467, 1656.4450908945398, 1673.790776152981, 867.7526904832092, 876.5967654878827, 881.9955900220458, 900.7297810656908, 902.4449963272672, 7407.296306850841, 7417.740379086706, 7466.991956085967, 7493.85012299751, 7539.811504712426, 699.912510936133, 705.5696025424487, 706.0891450029507, 712.0529695504966, 717.1394326807851, 5048.0913435581215, 5061.5950723942, 5093.134167191586, 5271.604629652791, 5374.48942350476, 21595.784042159376, 22420.0, 22443.326700198693, 22688.20591279297, 23066.53866922652, 21482.78517214808, 21877.67183492249, 21950.231741888958, 22317.0, 22373.776262237494, 11687.0, 11793.11551633631, 11822.522184726737, 11830.763384732429, 11876.940615296868, 7939.483933544301, 8016.358691304798, 8095.55474448911, 8104.149064348394, 8113.026436827618, 18419.81580184181, 19224.0, 19247.90376048111, 19341.12964916554, 19568.510787230432, 19193.520161995504, 19580.11953821127, 19714.901425493354, 20217.0, 20355.79644203539, 10824.24230303871, 10838.837417438903, 11019.504122314675, 11046.889531104907, 11052.778944421227, 14095.154290742588, 14125.505607303696, 14194.432222710975, 14201.928990354982, 14256.0, 10667.733306667395, 10705.090067344363, 10723.463826808473, 10799.0, 11030.834537481784, 10764.03123718869, 10877.564897404016, 10937.453127343442, 11102.500387482422, 11139.665810025712, 10232.0, 10257.076863082359, 10266.178705703376, 10298.279120461495, 10351.275410721177, 7311.926880731125, 7416.66625001887, 7421.257874212752, 7460.776176714708, 7492.62536873165, 7101.183363913216, 7103.25415831351, 7132.572045677276, 7176.282371762782, 7182.317679820409], "value": 6743.892320719155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.806947394727, 520.539322699411, 532.5127508329879, 540.2976131029661, 556.3129535024244, 6433.1315272438205, 6523.347665233486, 6545.8363540911505, 6545.901811472826, 6583.177102862142, 6321.589096708711, 6366.713497892594, 6401.839954001152, 6447.516436267275, 6463.935360646392, 4976.900461990776, 5304.443033481487, 5316.644255714797, 5366.892662146754, 5380.542653874406, 5124.871878203037, 5143.614228932826, 5144.022635699205, 5159.406668233145, 5193.16909294513, 5082.440931497532, 5103.693778373291, 5107.514786095334, 5109.284700141983, 5115.335006449156, 5115.10485665009, 5116.155834287338, 5127.5385215330425, 5136.948630513722, 5165.819196328111, 4620.722756634613, 4648.5119062498625, 4655.371524844137, 4666.183417901888, 4670.112678591091, 6138.6494971106285, 6182.629042257434, 6215.192025036761, 6317.5893566918, 6381.138546296237, 5774.884502309972, 5788.131780232957, 5795.2176456178295, 5798.304203495608, 5817.883642327172, 6660.267370589231, 6671.232808227068, 6682.331766823328, 6700.631465269408, 6723.899141512881, 4982.825601103944, 4989.476105008958, 4997.575206107485, 5027.265593370282, 5041.823536176253, 6889.931100689029, 7009.474289428314, 7035.472339574552, 7049.89425158623, 7070.858582828366, 5138.126518491866, 5144.819931302386, 5161.27742116104, 5171.689698618095, 5177.559907407837, 5219.973900130475, 5234.659747116425, 5241.842744717588, 5256.763445644955, 5277.445868183862, 5788.450097240755, 5799.681017544076, 5803.390643982406, 5808.361080281165, 5821.592488525763, 6391.520635952322, 6406.615603063831, 6550.901736473957, 6619.470442364599, 6695.163104611924, 1767.920443580042, 1770.9905353948127, 1783.233209719833, 1797.8381945624956, 1801.2614827920752, 1068.71144790906, 1244.9875501245053, 1253.9686507837196, 1264.2288204195434, 1269.8888472586486, 5623.409541998113, 5805.216295800013, 5826.94173058264, 5829.679367634736, 5892.292924849045, 6964.686589103502, 6964.8856183010475, 6968.989496522976, 6976.19773726028, 7005.579665220103, 5693.259876216065, 5738.512226460714, 5806.796762113306, 5816.011278082736, 5840.474357307778, 3580.5703315601772, 3590.425531914881, 3597.1726502903957, 3624.1483251435893, 3669.0, 6600.768973085919, 6623.714818387649, 6626.867462650816, 6646.567973081735, 6674.965380366051, 6977.965110174417, 6977.965110174417, 7003.299670032956, 7020.894686579603, 7042.964785176041, 6436.80689579304, 6468.838279043061, 6529.0, 6568.868622627616, 6581.372926148075, 6668.333166683293, 6742.6628668567355, 6744.865102698017, 6819.727210911508, 6828.419584335188, 6748.662566871735, 6789.93210067893, 6809.978503224358, 6877.415419689382, 6887.111519650827, 6598.538102332791, 6599.208095028627, 6621.966890165519, 6652.567583107082, 6689.866202676017, 5055.469175736494, 5075.137226671401, 5086.287919691172, 5115.18157094863, 5138.691678499302, 6643.667816609247, 6751.56114852533, 6751.932480675327, 6793.796186114425, 6834.760783372558, 6453.838309104406, 6478.4169424752, 6480.8703825922275, 6534.640594767334, 6542.214934207926, 6335.474461304863, 6453.0, 6499.707513161825, 6514.283428822731, 6555.573887697285, 6541.70562324706, 6559.770408035696, 6573.211214654272, 6598.37315455031, 6608.7026083825385, 6250.998881252844, 6611.768588099393, 6709.396154346132, 6714.824905641395, 6740.595564266159, 6425.5502114851515, 6450.935595626669, 6467.838304042437, 6482.416582507597, 6485.254195767548], "value": 5157.743351284615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.8141031088626, 914.1818072824826, 922.7646950027741, 922.8338898998181, 923.7228831350593, 18561.443156705303, 19237.23051077957, 22399.776002239974, 23155.536889262246, 23195.3041408758, 20817.791822081774, 21113.15547378107, 22046.669299960515, 22048.228312009083, 22074.33776986689, 970.5292932927524, 974.449436068619, 975.790205105902, 978.3396207559904, 978.9951050244739, 965.8020105878278, 966.2270183852925, 993.4784238274891, 994.2642444590987, 1004.969850904474, 1033.4729288063104, 1040.4537617750666, 1040.5317607076809, 1041.073444634276, 1041.6927006533053, 1033.7208953582528, 1037.6368271105127, 1038.2939601071268, 1038.8234000219982, 1040.599369242843, 753.9698412063511, 755.0486387152173, 759.8442319324525, 760.3499008347839, 770.0643717882799, 19591.216351346073, 20038.899805501023, 20101.39695809128, 20131.597368052702, 20362.79637203624, 21688.89155554228, 22073.448163795874, 22309.665355019686, 22331.10675572975, 22354.776452235434, 18024.098795060327, 18115.094245287684, 18134.09329533518, 18155.72766408505, 18211.908940455345, 3776.8866933992026, 3785.867494637702, 3835.3096442640312, 3837.0982819037504, 3871.7483363581277, 144081.0, 145720.27139864338, 146663.99999999892, 147052.2647386756, 148465.0, 16746.330146794236, 16776.1611919406, 17107.230174642173, 17129.571760705832, 17312.653746925243, 25235.11677091293, 25655.615165772528, 32102.678973209968, 32160.678393215767, 32208.35583288321, 7972.242636949481, 9168.908310916806, 9201.171894529525, 9206.723798286062, 9274.582643781046, 4381.518033016366, 4503.392042074278, 4506.233940230169, 4512.435945506812, 4512.954870451254, 5528.364238112588, 5618.9604923089355, 5646.8023619173955, 5655.745491452894, 5677.545796336283, 1096.9780604387868, 1114.9163812713916, 1133.3313345126414, 1142.0749193153572, 1145.4902568357002, 652.6573548886872, 666.1839246922481, 676.4655921821706, 682.8054004608762, 688.6350234375789, 11727.4136293185, 12042.39788010596, 12148.45331960064, 12792.680182995313, 12798.552050678181, 694.2952902803659, 706.4595584377955, 707.3209718670031, 724.0044938209961, 725.633555054694, 5693.971530142323, 5710.800121995793, 5822.301323841166, 5840.853978650568, 5862.062070068769, 125791.37104314603, 127603.36198318949, 127677.39070117897, 128536.35731821468, 131166.03250951244, 107563.5796545098, 109515.0, 110246.44876775565, 110622.89377106287, 110636.0, 92475.0, 93804.53097734605, 94186.5290673556, 97926.0, 98119.99999999857, 10715.41065241388, 10775.568977241137, 10823.188260880623, 10877.347359158475, 11046.171537134587, 43955.0, 44531.33203001893, 45463.77268113638, 45885.77057114693, 46897.76551117223, 56950.43049569451, 56953.43046569647, 57604.42395576158, 59987.70006149941, 60541.394586053575, 16028.198590070682, 16480.42318518846, 16523.091229982467, 16784.24470898788, 16790.916045419694, 17479.82520174782, 17507.649847002733, 17557.648847023243, 17603.119844008004, 17807.109644517983, 15922.920385397998, 15952.760708589612, 16150.0, 16211.837881621033, 16482.83517164813, 16580.419685311437, 16787.0, 16915.7462638063, 16939.745903811207, 17081.658366832842, 15141.242937853283, 15151.166685832384, 15356.232188390311, 15424.614384640474, 15623.687526249185, 12077.27536347822, 12162.817557736818, 12409.565665201675, 12412.875871241173, 12492.31292278897, 11153.107751379708, 11254.606088786853, 11269.380184089954, 11288.492017859051, 11432.314061156358], "value": 9161.56219110595, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1415.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 107.0, 106.0, 106.0, 111.0, 107.0, 106.0, 106.0, 106.0, 108.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 116.0, 123.0, 115.0, 118.0, 143.0, 118.0, 117.0, 117.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 164.0, 164.0, 163.0, 161.0, 164.0, 166.0, 166.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 73.0, 85.0, 74.0, 73.0, 75.0, 74.0, 73.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 79.0, 82.0, 81.0, 79.0, 80.0, 80.0, 79.0], "value": 79.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 115.0, 113.0, 113.0, 114.0, 114.0, 114.0, 113.0, 116.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 148.0, 149.0, 148.0, 152.0, 148.0, 149.0, 149.0, 149.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 99.0, 98.0, 93.0, 93.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 57.0, 50.0, 50.0, 51.0, 59.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 43.0, 39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0], "value": 38.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 74.0, 76.0, 72.0, 73.0, 72.0, 74.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 118.0, 107.0, 110.0, 111.0, 109.0, 115.0, 114.0, 111.0], "value": 112.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 166.0, 168.0, 169.0, 166.0, 171.0, 183.0, 168.0, 167.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 67.0, 66.0, 66.0, 68.0, 65.0, 67.0, 68.0, 65.0], "value": 67.1, "unit": "score"}]}]} 09:02:47 INFO - Return code: 0 09:02:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:02:48 INFO - # TBPL SUCCESS # 09:02:48 INFO - Running post-action listener: _package_coverage_data 09:02:48 INFO - Running post-action listener: _resource_record_post_action 09:02:48 INFO - [mozharness: 2017-09-21 16:02:48.008855Z] Finished run-tests step (success) 09:02:48 INFO - Running post-run listener: _resource_record_post_run 09:02:48 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 135168; Write bytes: 345305088; Read time: 572; Write time: 231756 09:02:48 INFO - TinderboxPrint: CPU usage
13.1% 09:02:48 INFO - TinderboxPrint: I/O read bytes / time
135,168 / 572 09:02:48 INFO - TinderboxPrint: I/O write bytes / time
345,305,088 / 231,756 09:02:48 INFO - TinderboxPrint: CPU idle
8,236.6 (86.9%) 09:02:48 INFO - TinderboxPrint: CPU user
1,193.4 (12.6%) 09:02:48 INFO - TinderboxPrint: Swap in / out
0 / 0 09:02:48 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9818112; Read time: 0; Write time: 1564 09:02:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:02:48 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 131072; Write bytes: 335486976; Read time: 560; Write time: 230192 09:02:48 INFO - Running post-run listener: _upload_blobber_files 09:02:48 INFO - Blob upload gear active. 09:02:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:48 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 09:02:48 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'] 09:02:48 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 09:02:49 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:02:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:02:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:50 INFO - (blobuploader) - INFO - Done attempting. 09:02:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:02:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:02:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:51 INFO - (blobuploader) - INFO - Done attempting. 09:02:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:02:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:02:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:57 INFO - (blobuploader) - INFO - Done attempting. 09:02:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:02:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:02:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:58 INFO - (blobuploader) - INFO - Done attempting. 09:02:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:02:58 INFO - Return code: 0 09:02:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:02:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:02:58 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b40f1690b87d3e5311059491e1c7dbd6d8689b95e0bc88cd1e0ba92089189717c4b9aaa78e72ff2eea3382dfb9b8226b050f1f920baabf865b19910845fd10e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/980cbd3e4f4a055f7711f4f49df859231b7917b7a50dd686acd58b8fdc3989469bb9592e750bd89a0d59fe7e25252d8c280c9a773a96d56972fae6f73f0debf9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51f9db3fc4ba86a3f9823a26a3d345f818e5070d2ab06476d5283ad8b20e9c7d564cb05625c62f60775b291af200ed2ef59732effc70195355ce04df18992bb1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4309dd96b72a897676cd4734d757900f90e084147fdfcac54ba26ffdf7024c3891fa006d2f26fa9f295c990b55fadf706ca5ef0b49441d5534dd60dc92ddb4a2"} 09:02:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:02:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:02:58 INFO - Contents: 09:02:58 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b40f1690b87d3e5311059491e1c7dbd6d8689b95e0bc88cd1e0ba92089189717c4b9aaa78e72ff2eea3382dfb9b8226b050f1f920baabf865b19910845fd10e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/980cbd3e4f4a055f7711f4f49df859231b7917b7a50dd686acd58b8fdc3989469bb9592e750bd89a0d59fe7e25252d8c280c9a773a96d56972fae6f73f0debf9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51f9db3fc4ba86a3f9823a26a3d345f818e5070d2ab06476d5283ad8b20e9c7d564cb05625c62f60775b291af200ed2ef59732effc70195355ce04df18992bb1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4309dd96b72a897676cd4734d757900f90e084147fdfcac54ba26ffdf7024c3891fa006d2f26fa9f295c990b55fadf706ca5ef0b49441d5534dd60dc92ddb4a2"} 09:02:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:02:58 INFO - Copying logs to upload dir... 09:02:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:02:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.809238 ========= master_lag: -0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-21 09:02:59.106152) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 09:02:59.114069) ========= 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=a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451 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/3b40f1690b87d3e5311059491e1c7dbd6d8689b95e0bc88cd1e0ba92089189717c4b9aaa78e72ff2eea3382dfb9b8226b050f1f920baabf865b19910845fd10e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/980cbd3e4f4a055f7711f4f49df859231b7917b7a50dd686acd58b8fdc3989469bb9592e750bd89a0d59fe7e25252d8c280c9a773a96d56972fae6f73f0debf9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51f9db3fc4ba86a3f9823a26a3d345f818e5070d2ab06476d5283ad8b20e9c7d564cb05625c62f60775b291af200ed2ef59732effc70195355ce04df18992bb1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4309dd96b72a897676cd4734d757900f90e084147fdfcac54ba26ffdf7024c3891fa006d2f26fa9f295c990b55fadf706ca5ef0b49441d5534dd60dc92ddb4a2"} build_url:https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011508 build_url: 'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b40f1690b87d3e5311059491e1c7dbd6d8689b95e0bc88cd1e0ba92089189717c4b9aaa78e72ff2eea3382dfb9b8226b050f1f920baabf865b19910845fd10e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/980cbd3e4f4a055f7711f4f49df859231b7917b7a50dd686acd58b8fdc3989469bb9592e750bd89a0d59fe7e25252d8c280c9a773a96d56972fae6f73f0debf9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51f9db3fc4ba86a3f9823a26a3d345f818e5070d2ab06476d5283ad8b20e9c7d564cb05625c62f60775b291af200ed2ef59732effc70195355ce04df18992bb1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4309dd96b72a897676cd4734d757900f90e084147fdfcac54ba26ffdf7024c3891fa006d2f26fa9f295c990b55fadf706ca5ef0b49441d5534dd60dc92ddb4a2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 09:02:59.145244) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:02:59.145537) ========= 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=a0d2d2de893abaa8702a9954000001a7-1506006962.57-482477451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004854 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:02:59.224563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 09:02:59.227886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 09:02:59.228187) ========= ========= Total master_lag: 0.16 =========