builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1505775505.29 results: success (0) revision: 948dc86aabc97e16d51ad19ea90debab6f93a628 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:25.292151) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:25.292576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:25.292870) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:25.552832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:25.553143) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 15:58:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2017-09-18 15:58:25 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.228381 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:25.860745) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:25.861038) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016639 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:25.968985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:25.972311) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 948dc86aabc97e16d51ad19ea90debab6f93a628 --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 948dc86aabc97e16d51ad19ea90debab6f93a628 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 15:58:25,919 truncating revision to first 12 chars 2017-09-18 15:58:25,920 Setting DEBUG logging. 2017-09-18 15:58:25,920 attempt 1/10 2017-09-18 15:58:25,920 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/948dc86aabc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 15:58:26,326 unpacking tar archive at: mozilla-central-948dc86aabc9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681713 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.690041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.693378) ========= script_repo_revision: 948dc86aabc97e16d51ad19ea90debab6f93a628 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.693796) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.694066) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.710960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-18 15:58:26.711237) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:58:26 INFO - MultiFileLogger online at 20170918 15:58:26 in /builds/slave/test 15:58:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:58:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:58:26 INFO - {'append_to_log': False, 15:58:26 INFO - 'base_work_dir': '/builds/slave/test', 15:58:26 INFO - 'blob_upload_branch': 'Firefox', 15:58:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:58:26 INFO - 'branch': 'Firefox', 15:58:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:26 INFO - 'code_coverage': False, 15:58:26 INFO - 'config_files': ('talos/linux_config.py',), 15:58:26 INFO - 'default_actions': ('clobber', 15:58:26 INFO - 'read-buildbot-config', 15:58:26 INFO - 'download-and-extract', 15:58:26 INFO - 'populate-webroot', 15:58:26 INFO - 'create-virtualenv', 15:58:26 INFO - 'install', 15:58:26 INFO - 'setup-mitmproxy', 15:58:26 INFO - 'run-tests'), 15:58:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:26 INFO - 'disable_ccov_upload': False, 15:58:26 INFO - 'disable_stylo': False, 15:58:26 INFO - 'download_minidump_stackwalk': True, 15:58:26 INFO - 'download_symbols': 'ondemand', 15:58:26 INFO - 'enable_stylo': False, 15:58:26 INFO - 'enable_webrender': False, 15:58:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:58:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:26 INFO - 'gecko_profile': False, 15:58:26 INFO - 'gecko_profile_interval': 0, 15:58:26 INFO - 'installer_path': 'installer.exe', 15:58:26 INFO - 'log_level': 'info', 15:58:26 INFO - 'log_name': 'talos', 15:58:26 INFO - 'log_to_console': True, 15:58:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:58:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:58:26 INFO - 'opt_config_files': (), 15:58:26 INFO - 'pip_index': False, 15:58:26 INFO - 'suite': 'dromaeojs-e10s', 15:58:26 INFO - 'system_bits': '32', 15:58:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:26 INFO - 'title': 'talos-linux64-ix-041', 15:58:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:26 INFO - 'use_talos_json': True, 15:58:26 INFO - 'verify': 'False', 15:58:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:58:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:26 INFO - 'work_dir': 'build'} 15:58:26 INFO - [mozharness: 2017-09-18 22:58:26.910630Z] Running clobber step. 15:58:26 INFO - Running pre-action listener: _resource_record_pre_action 15:58:26 INFO - Running main action method: clobber 15:58:26 INFO - rmtree: /builds/slave/test/build 15:58:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:58:27 INFO - Running post-action listener: _resource_record_post_action 15:58:27 INFO - [mozharness: 2017-09-18 22:58:27.928917Z] Finished clobber step (success) 15:58:27 INFO - [mozharness: 2017-09-18 22:58:27.929014Z] Running read-buildbot-config step. 15:58:27 INFO - Running pre-action listener: _resource_record_pre_action 15:58:27 INFO - Running main action method: read_buildbot_config 15:58:27 INFO - Using buildbot properties: 15:58:27 INFO - { 15:58:27 INFO - "project": "", 15:58:27 INFO - "product": "firefox", 15:58:27 INFO - "who": "kwierso@gmail.com", 15:58:27 INFO - "installer_path": "public/build/target.tar.bz2", 15:58:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 15:58:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:58:27 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 15:58:27 INFO - "stage_platform": "linux64-qr", 15:58:27 INFO - "basedir": "/builds/slave/test", 15:58:27 INFO - "buildnumber": 74, 15:58:27 INFO - "platform": "ubuntu64_hw_qr", 15:58:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:58:27 INFO - "slavebuilddir": "test", 15:58:27 INFO - "taskId": "Wy8z4R9ISeygLSfz0QuhmQ", 15:58:27 INFO - "branch": "mozilla-central", 15:58:27 INFO - "script_repo_revision": "production", 15:58:27 INFO - "revision": "948dc86aabc97e16d51ad19ea90debab6f93a628", 15:58:27 INFO - "slavename": "talos-linux64-ix-041", 15:58:27 INFO - "repo_path": "mozilla-central" 15:58:27 INFO - } 15:58:27 INFO - Finding installer, test and symbols from parent task. 15:58:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wy8z4R9ISeygLSfz0QuhmQ'}, attempt #1 15:58:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wy8z4R9ISeygLSfz0QuhmQ'}, attempt #1 15:58:28 INFO - Task dependencies: TRftx86zRh69GCHnj0hY_Q 15:58:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q'}, attempt #1 15:58:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 15:58:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.test_packages.json 15:58:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.crashreporter-symbols.zip 15:58:29 INFO - Running post-action listener: _resource_record_post_action 15:58:29 INFO - [mozharness: 2017-09-18 22:58:29.316520Z] Finished read-buildbot-config step (success) 15:58:29 INFO - [mozharness: 2017-09-18 22:58:29.316751Z] Running download-and-extract step. 15:58:29 INFO - Running pre-action listener: _resource_record_pre_action 15:58:29 INFO - Running main action method: download_and_extract 15:58:29 INFO - mkdir: /builds/slave/test/build/tests 15:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:29 INFO - trying https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.test_packages.json 15:58:29 INFO - Downloading https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:58:29 INFO - Downloaded 989 bytes. 15:58:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:58:29 INFO - Using the following test package requirements: 15:58:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:58:29 INFO - u'common': [u'target.common.tests.zip'], 15:58:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:58:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:58:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:58:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:58:29 INFO - u'mozbase': [u'target.common.tests.zip'], 15:58:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:58:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:58:29 INFO - u'web-platform': [u'target.common.tests.zip', 15:58:29 INFO - u'target.web-platform.tests.tar.gz'], 15:58:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:58:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:58:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.common.tests.zip 15:58:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:58:29 INFO - Fetch https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.common.tests.zip into memory 15:58:33 INFO - Content-Length response header: 54731251 15:58:33 INFO - Bytes received: 54731251 15:58:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.talos.tests.zip 15:58:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:58:44 INFO - Fetch https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.talos.tests.zip into memory 15:58:46 INFO - Content-Length response header: 14508748 15:58:46 INFO - Bytes received: 14508748 15:58:46 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')]} 15:58:46 INFO - trying https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 15:58:46 INFO - Downloading https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:58:51 INFO - Downloaded 61376718 bytes. 15:58:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 15:58:51 INFO - mkdir: /builds/slave/test/properties 15:58:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:58:51 INFO - Writing to file /builds/slave/test/properties/build_url 15:58:51 INFO - Contents: 15:58:51 INFO - build_url:https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 15:58:51 INFO - Running post-action listener: _resource_record_post_action 15:58:51 INFO - Running post-action listener: find_tests_for_verification 15:58:51 INFO - Running post-action listener: set_extra_try_arguments 15:58:51 INFO - [mozharness: 2017-09-18 22:58:51.267541Z] Finished download-and-extract step (success) 15:58:51 INFO - [mozharness: 2017-09-18 22:58:51.267769Z] Running populate-webroot step. 15:58:51 INFO - Running pre-action listener: _resource_record_pre_action 15:58:51 INFO - Running main action method: populate_webroot 15:58:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:58:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['tresize', 15:58:51 INFO - 'tcanvasmark']}, 15:58:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:58:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['dromaeo_css', 15:58:51 INFO - 'kraken']}, 15:58:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'tests': ['damp', 'tps']}, 15:58:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['damp', 'tps']}, 15:58:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:58:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['dromaeo_dom']}, 15:58:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:58:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['basic_compositor_video', 15:58:51 INFO - 'glvideo']}, 15:58:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:58:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['ts_paint_webext', 15:58:51 INFO - 'tp5o_webext']}, 15:58:51 INFO - 'other-e10s': {'tests': ['a11yr', 15:58:51 INFO - 'ts_paint', 15:58:51 INFO - 'tpaint', 15:58:51 INFO - 'sessionrestore', 15:58:51 INFO - 'sessionrestore_many_windows', 15:58:51 INFO - 'sessionrestore_no_auto_restore', 15:58:51 INFO - 'tabpaint']}, 15:58:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['a11yr', 15:58:51 INFO - 'ts_paint', 15:58:51 INFO - 'tpaint', 15:58:51 INFO - 'sessionrestore', 15:58:51 INFO - 'sessionrestore_many_windows', 15:58:51 INFO - 'sessionrestore_no_auto_restore', 15:58:51 INFO - 'tabpaint']}, 15:58:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:58:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:58:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['perf_reftest_singletons']}, 15:58:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['bloom_basic']}, 15:58:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:58:51 INFO - 'tsvgr_opacity', 15:58:51 INFO - 'tart', 15:58:51 INFO - 'tscrollx', 15:58:51 INFO - 'tsvg_static']}, 15:58:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['tsvgx', 15:58:51 INFO - 'tsvgr_opacity', 15:58:51 INFO - 'tart', 15:58:51 INFO - 'tscrollx', 15:58:51 INFO - 'tsvg_static']}, 15:58:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:58:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['tp5o']}, 15:58:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:58:51 INFO - 'talos_options': ['--mitmproxy', 15:58:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:58:51 INFO - '--firstNonBlankPaint'], 15:58:51 INFO - 'tests': ['tp6_google', 15:58:51 INFO - 'tp6_youtube', 15:58:51 INFO - 'tp6_amazon', 15:58:51 INFO - 'tp6_facebook']}, 15:58:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo', 15:58:51 INFO - '--mitmproxy', 15:58:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:58:51 INFO - '--firstNonBlankPaint'], 15:58:51 INFO - 'tests': ['tp6_google', 15:58:51 INFO - 'tp6_youtube', 15:58:51 INFO - 'tp6_amazon', 15:58:51 INFO - 'tp6_facebook']}, 15:58:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:58:51 INFO - 'talos_options': ['--stylo-threads=1', 15:58:51 INFO - '--mitmproxy', 15:58:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:58:51 INFO - '--firstNonBlankPaint'], 15:58:51 INFO - 'tests': ['tp6_google', 15:58:51 INFO - 'tp6_youtube', 15:58:51 INFO - 'tp6_amazon', 15:58:51 INFO - 'tp6_facebook']}, 15:58:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--xperf_path', 15:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:51 INFO - 'tests': ['tp5n']}, 15:58:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo', 15:58:51 INFO - '--xperf_path', 15:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:51 INFO - 'tests': ['tp5n']}}} 15:58:51 INFO - Running post-action listener: _resource_record_post_action 15:58:51 INFO - [mozharness: 2017-09-18 22:58:51.288282Z] Finished populate-webroot step (success) 15:58:51 INFO - [mozharness: 2017-09-18 22:58:51.288372Z] Running create-virtualenv step. 15:58:51 INFO - Running pre-action listener: _resource_record_pre_action 15:58:51 INFO - Running main action method: create_virtualenv 15:58:51 INFO - Creating virtualenv /builds/slave/test/build/venv 15:58:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:58:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:58:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:58:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:58:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:58:52 INFO - Installing distribute.............................................................................................................................................................................................done. 15:58:52 INFO - Installing pip...............done. 15:58:52 INFO - Return code: 0 15:58:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:58:52 INFO - Reading from file tmpfile_stdout 15:58:52 INFO - Output received: 15:58:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:58:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a82a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a86090>, '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 0x2a86d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a80f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', '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 15:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:58:52 INFO - Using env: {'DISPLAY': ':0', 15:58:52 INFO - 'HOME': '/home/cltbld', 15:58:52 INFO - 'LANG': 'en_US.UTF-8', 15:58:52 INFO - 'LANGUAGE': 'en_US:en', 15:58:52 INFO - 'LOGNAME': 'cltbld', 15:58:52 INFO - 'MAIL': '/var/mail/cltbld', 15:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:52 INFO - 'MOZ_NO_REMOTE': '1', 15:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:52 INFO - 'NO_EM_RESTART': '1', 15:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:52 INFO - 'PWD': '/builds/slave/test', 15:58:52 INFO - 'SHELL': '/bin/bash', 15:58:52 INFO - 'SHLVL': '1', 15:58:52 INFO - 'TERM': 'linux', 15:58:52 INFO - 'TMOUT': '86400', 15:58:52 INFO - 'USER': 'cltbld', 15:58:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', 15:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:52 INFO - '_': '/tools/buildbot/bin/python'} 15:58:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:58:54 INFO - Downloading/unpacking pip>=1.5 15:58:54 INFO - Running setup.py egg_info for package pip 15:58:54 INFO - warning: no files found matching 'pip/cacert.pem' 15:58:54 INFO - warning: no files found matching '*.html' under directory 'docs' 15:58:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:58:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:58:54 INFO - Installing collected packages: pip 15:58:54 INFO - Found existing installation: pip 1.1 15:58:54 INFO - Uninstalling pip: 15:58:54 INFO - Successfully uninstalled pip 15:58:54 INFO - Running setup.py install for pip 15:58:54 INFO - warning: no files found matching 'pip/cacert.pem' 15:58:54 INFO - warning: no files found matching '*.html' under directory 'docs' 15:58:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:58:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:58:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:58:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:58:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:58:54 INFO - Successfully installed pip 15:58:54 INFO - Cleaning up... 15:58:54 INFO - Return code: 0 15:58:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:58:54 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')]} 15:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:54 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')]} 15:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:54 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 0x27161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a82a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a86090>, '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 0x2a86d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a80f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', '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 15:58:54 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 15:58:54 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 15:58:54 INFO - Using env: {'DISPLAY': ':0', 15:58:54 INFO - 'HOME': '/home/cltbld', 15:58:54 INFO - 'LANG': 'en_US.UTF-8', 15:58:54 INFO - 'LANGUAGE': 'en_US:en', 15:58:54 INFO - 'LOGNAME': 'cltbld', 15:58:54 INFO - 'MAIL': '/var/mail/cltbld', 15:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:54 INFO - 'MOZ_NO_REMOTE': '1', 15:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:54 INFO - 'NO_EM_RESTART': '1', 15:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:54 INFO - 'PWD': '/builds/slave/test', 15:58:54 INFO - 'SHELL': '/bin/bash', 15:58:54 INFO - 'SHLVL': '1', 15:58:54 INFO - 'TERM': 'linux', 15:58:54 INFO - 'TMOUT': '86400', 15:58:54 INFO - 'USER': 'cltbld', 15:58:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', 15:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:54 INFO - '_': '/tools/buildbot/bin/python'} 15:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:55 INFO - Downloading/unpacking psutil>=3.1.1 15:58:55 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 15:58:55 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 15:58:55 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 15:58:55 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 15:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:58:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:56 INFO - Installing collected packages: psutil 15:58:56 INFO - Running setup.py install for psutil 15:58:56 INFO - building 'psutil._psutil_linux' extension 15:58:56 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 15:58:57 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 15:58:57 INFO - building 'psutil._psutil_posix' extension 15:58:57 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 15:58:57 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 15:58:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:58 INFO - Successfully installed psutil 15:58:58 INFO - Cleaning up... 15:58:58 INFO - Return code: 0 15:58:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58: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')]} 15:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a82a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a86090>, '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 0x2a86d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a80f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', '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 15:58: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:58: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 mozsystemmonitor==0.3 15:58:58 INFO - Using env: {'DISPLAY': ':0', 15:58:58 INFO - 'HOME': '/home/cltbld', 15:58:58 INFO - 'LANG': 'en_US.UTF-8', 15:58:58 INFO - 'LANGUAGE': 'en_US:en', 15:58:58 INFO - 'LOGNAME': 'cltbld', 15:58:58 INFO - 'MAIL': '/var/mail/cltbld', 15:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:58 INFO - 'MOZ_NO_REMOTE': '1', 15:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:58 INFO - 'NO_EM_RESTART': '1', 15:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:58 INFO - 'PWD': '/builds/slave/test', 15:58:58 INFO - 'SHELL': '/bin/bash', 15:58:58 INFO - 'SHLVL': '1', 15:58:58 INFO - 'TERM': 'linux', 15:58:58 INFO - 'TMOUT': '86400', 15:58:58 INFO - 'USER': 'cltbld', 15:58:58 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', 15:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:58 INFO - '_': '/tools/buildbot/bin/python'} 15:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:58:58 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 15:58:58 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 15:58:58 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 15:58:58 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 15:58:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:58:59 INFO - Installing collected packages: mozsystemmonitor 15:58:59 INFO - Running setup.py install for mozsystemmonitor 15:58:59 INFO - Successfully installed mozsystemmonitor 15:58:59 INFO - Cleaning up... 15:58:59 INFO - Return code: 0 15:58:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:58:59 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')]} 15:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:59 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')]} 15:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:59 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 0x27161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a82a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a86090>, '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 0x2a86d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a80f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', '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 15:58:59 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 15:58:59 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 15:58:59 INFO - Using env: {'DISPLAY': ':0', 15:58:59 INFO - 'HOME': '/home/cltbld', 15:58:59 INFO - 'LANG': 'en_US.UTF-8', 15:58:59 INFO - 'LANGUAGE': 'en_US:en', 15:58:59 INFO - 'LOGNAME': 'cltbld', 15:58:59 INFO - 'MAIL': '/var/mail/cltbld', 15:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:59 INFO - 'MOZ_NO_REMOTE': '1', 15:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:59 INFO - 'NO_EM_RESTART': '1', 15:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:59 INFO - 'PWD': '/builds/slave/test', 15:58:59 INFO - 'SHELL': '/bin/bash', 15:58:59 INFO - 'SHLVL': '1', 15:58:59 INFO - 'TERM': 'linux', 15:58:59 INFO - 'TMOUT': '86400', 15:58:59 INFO - 'USER': 'cltbld', 15:58:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', 15:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:59 INFO - '_': '/tools/buildbot/bin/python'} 15:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:59 INFO - Downloading/unpacking jsonschema==2.5.1 15:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:59:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:59:00 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 15:59:00 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 15:59:00 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 15:59:00 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 15:59:01 INFO - Downloading functools32-3.2.3-2.tar.gz 15:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:59:01 INFO - warning: no files found matching '*.txt' 15:59:01 INFO - no previously-included directories found matching 'build' 15:59:01 INFO - no previously-included directories found matching 'dist' 15:59:01 INFO - no previously-included directories found matching '.git*' 15:59:01 INFO - Installing collected packages: jsonschema, functools32 15:59:01 INFO - Running setup.py install for functools32 15:59:01 INFO - warning: no files found matching '*.txt' 15:59:01 INFO - no previously-included directories found matching 'build' 15:59:01 INFO - no previously-included directories found matching 'dist' 15:59:01 INFO - no previously-included directories found matching '.git*' 15:59:01 INFO - Successfully installed jsonschema functools32 15:59:01 INFO - Cleaning up... 15:59:01 INFO - Return code: 0 15:59:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:01 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 0x27161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a82a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a86090>, '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 0x2a86d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a80f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', '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 15:59:01 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 15:59:01 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 15:59:01 INFO - Using env: {'DISPLAY': ':0', 15:59:01 INFO - 'HOME': '/home/cltbld', 15:59:01 INFO - 'LANG': 'en_US.UTF-8', 15:59:01 INFO - 'LANGUAGE': 'en_US:en', 15:59:01 INFO - 'LOGNAME': 'cltbld', 15:59:01 INFO - 'MAIL': '/var/mail/cltbld', 15:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:01 INFO - 'MOZ_NO_REMOTE': '1', 15:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:01 INFO - 'NO_EM_RESTART': '1', 15:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:01 INFO - 'PWD': '/builds/slave/test', 15:59:01 INFO - 'SHELL': '/bin/bash', 15:59:01 INFO - 'SHLVL': '1', 15:59:01 INFO - 'TERM': 'linux', 15:59:01 INFO - 'TMOUT': '86400', 15:59:01 INFO - 'USER': 'cltbld', 15:59:01 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', 15:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:01 INFO - '_': '/tools/buildbot/bin/python'} 15:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:59:01 INFO - Cleaning up... 15:59:01 INFO - Return code: 0 15:59:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:01 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 0x27161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a82a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a86090>, '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 0x2a86d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a80f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', '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 15:59:01 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 15:59:01 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 15:59:01 INFO - Using env: {'DISPLAY': ':0', 15:59:01 INFO - 'HOME': '/home/cltbld', 15:59:01 INFO - 'LANG': 'en_US.UTF-8', 15:59:01 INFO - 'LANGUAGE': 'en_US:en', 15:59:01 INFO - 'LOGNAME': 'cltbld', 15:59:01 INFO - 'MAIL': '/var/mail/cltbld', 15:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:01 INFO - 'MOZ_NO_REMOTE': '1', 15:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:01 INFO - 'NO_EM_RESTART': '1', 15:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:01 INFO - 'PWD': '/builds/slave/test', 15:59:01 INFO - 'SHELL': '/bin/bash', 15:59:01 INFO - 'SHLVL': '1', 15:59:01 INFO - 'TERM': 'linux', 15:59:01 INFO - 'TMOUT': '86400', 15:59:01 INFO - 'USER': 'cltbld', 15:59:01 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', 15:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:01 INFO - '_': '/tools/buildbot/bin/python'} 15:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:01 INFO - Downloading/unpacking blobuploader==1.2.4 15:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:02 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59:02 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 15:59:02 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 15:59:02 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 15:59:02 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 15:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:59:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59:03 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 15:59:03 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 15:59:03 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 15:59:03 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 15:59:03 INFO - Downloading docopt-0.6.1.tar.gz 15:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:03 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:03 INFO - Running setup.py install for blobuploader 15:59:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:59:03 INFO - Running setup.py install for requests 15:59:03 INFO - Running setup.py install for docopt 15:59:03 INFO - Successfully installed blobuploader requests docopt 15:59:03 INFO - Cleaning up... 15:59:03 INFO - Return code: 0 15:59:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:03 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 0x27161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a82a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a86090>, '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 0x2a86d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a80f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', '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 15:59:03 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 15:59:03 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 15:59:03 INFO - Using env: {'DISPLAY': ':0', 15:59:03 INFO - 'HOME': '/home/cltbld', 15:59:03 INFO - 'LANG': 'en_US.UTF-8', 15:59:03 INFO - 'LANGUAGE': 'en_US:en', 15:59:03 INFO - 'LOGNAME': 'cltbld', 15:59:03 INFO - 'MAIL': '/var/mail/cltbld', 15:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:03 INFO - 'MOZ_NO_REMOTE': '1', 15:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:03 INFO - 'NO_EM_RESTART': '1', 15:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:03 INFO - 'PWD': '/builds/slave/test', 15:59:03 INFO - 'SHELL': '/bin/bash', 15:59:03 INFO - 'SHLVL': '1', 15:59:03 INFO - 'TERM': 'linux', 15:59:03 INFO - 'TMOUT': '86400', 15:59:03 INFO - 'USER': 'cltbld', 15:59:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', 15:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:03 INFO - '_': '/tools/buildbot/bin/python'} 15:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:04 INFO - Running setup.py (path:/tmp/pip-GCY16_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:04 INFO - Running setup.py (path:/tmp/pip-yPzfOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:04 INFO - Running setup.py (path:/tmp/pip-TGvC11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:04 INFO - Running setup.py (path:/tmp/pip-2x1ysI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:04 INFO - Running setup.py (path:/tmp/pip-o5I0K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:04 INFO - Running setup.py (path:/tmp/pip-8LKg7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:04 INFO - Running setup.py (path:/tmp/pip-Z02ZvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:04 INFO - Running setup.py (path:/tmp/pip-QdHSL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:04 INFO - Running setup.py (path:/tmp/pip-81d_JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:04 INFO - Running setup.py (path:/tmp/pip-k8Jr4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:04 INFO - Running setup.py (path:/tmp/pip-6umZSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:04 INFO - Running setup.py (path:/tmp/pip-7E_MFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:05 INFO - Running setup.py (path:/tmp/pip-M5w2Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:05 INFO - Running setup.py (path:/tmp/pip-1q_508-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:05 INFO - Running setup.py (path:/tmp/pip-6A7nFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:05 INFO - Running setup.py (path:/tmp/pip-rdPXEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:05 INFO - Running setup.py (path:/tmp/pip-bO04Z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:05 INFO - Running setup.py install for manifestparser 15:59:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:59:05 INFO - Running setup.py install for mozcrash 15:59:05 INFO - Running setup.py install for mozdebug 15:59:05 INFO - Running setup.py install for mozdevice 15:59:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:59:05 INFO - Running setup.py install for mozfile 15:59:05 INFO - Running setup.py install for mozhttpd 15:59:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Running setup.py install for mozinfo 15:59:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Running setup.py install for mozInstall 15:59:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Running setup.py install for mozleak 15:59:06 INFO - Running setup.py install for mozlog 15:59:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Running setup.py install for moznetwork 15:59:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Running setup.py install for mozprocess 15:59:06 INFO - Running setup.py install for mozprofile 15:59:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Running setup.py install for mozrunner 15:59:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Running setup.py install for mozscreenshot 15:59:06 INFO - Running setup.py install for moztest 15:59:07 INFO - Running setup.py install for mozversion 15:59:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:59:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:07 INFO - Cleaning up... 15:59:07 INFO - Return code: 0 15:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:07 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 0x27161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a82a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a86090>, '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 0x2a86d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a80f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', '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 15:59:07 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 15:59:07 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 15:59:07 INFO - Using env: {'DISPLAY': ':0', 15:59:07 INFO - 'HOME': '/home/cltbld', 15:59:07 INFO - 'LANG': 'en_US.UTF-8', 15:59:07 INFO - 'LANGUAGE': 'en_US:en', 15:59:07 INFO - 'LOGNAME': 'cltbld', 15:59:07 INFO - 'MAIL': '/var/mail/cltbld', 15:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:07 INFO - 'MOZ_NO_REMOTE': '1', 15:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:07 INFO - 'NO_EM_RESTART': '1', 15:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:07 INFO - 'PWD': '/builds/slave/test', 15:59:07 INFO - 'SHELL': '/bin/bash', 15:59:07 INFO - 'SHLVL': '1', 15:59:07 INFO - 'TERM': 'linux', 15:59:07 INFO - 'TMOUT': '86400', 15:59:07 INFO - 'USER': 'cltbld', 15:59:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', 15:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:07 INFO - '_': '/tools/buildbot/bin/python'} 15:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:07 INFO - Running setup.py (path:/tmp/pip-rmr9LN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:07 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)) 15:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:07 INFO - Running setup.py (path:/tmp/pip-2sIXKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:07 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)) 15:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:07 INFO - Running setup.py (path:/tmp/pip-BGIzEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:07 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)) 15:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:07 INFO - Running setup.py (path:/tmp/pip-3J0ChL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:07 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)) 15:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:07 INFO - Running setup.py (path:/tmp/pip-hFd7fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:07 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)) 15:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:07 INFO - Running setup.py (path:/tmp/pip-tkIaS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:07 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)) 15:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:07 INFO - Running setup.py (path:/tmp/pip-uUZWxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:07 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)) 15:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:07 INFO - Running setup.py (path:/tmp/pip-ZincY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:07 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)) 15:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:07 INFO - Running setup.py (path:/tmp/pip-Ndau95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:08 INFO - Running setup.py (path:/tmp/pip-_4sLJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:08 INFO - Running setup.py (path:/tmp/pip-a1P0bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:08 INFO - Running setup.py (path:/tmp/pip-wUje6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:08 INFO - Running setup.py (path:/tmp/pip-FsUlg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:08 INFO - Running setup.py (path:/tmp/pip-rMGlFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:08 INFO - Running setup.py (path:/tmp/pip-VtYZvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:08 INFO - Running setup.py (path:/tmp/pip-YhKNMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:08 INFO - Running setup.py (path:/tmp/pip-PanlSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:09 INFO - Downloading blessings-1.6.tar.gz 15:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:09 INFO - Installing collected packages: blessings 15:59:09 INFO - Running setup.py install for blessings 15:59:09 INFO - Successfully installed blessings 15:59:09 INFO - Cleaning up... 15:59:09 INFO - Return code: 0 15:59:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:59:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:10 INFO - Reading from file tmpfile_stdout 15:59:10 INFO - Current package versions: 15:59:10 INFO - argparse == 1.2.1 15:59:10 INFO - blessings == 1.6 15:59:10 INFO - blobuploader == 1.2.4 15:59:10 INFO - docopt == 0.6.1 15:59:10 INFO - functools32 == 3.2.3-2 15:59:10 INFO - jsonschema == 2.5.1 15:59:10 INFO - manifestparser == 1.1 15:59:10 INFO - mozInstall == 1.13 15:59:10 INFO - mozcrash == 1.0 15:59:10 INFO - mozdebug == 0.1 15:59:10 INFO - mozdevice == 0.51 15:59:10 INFO - mozfile == 1.2 15:59:10 INFO - mozhttpd == 0.7 15:59:10 INFO - mozinfo == 0.10 15:59:10 INFO - mozleak == 0.1 15:59:10 INFO - mozlog == 3.5 15:59:10 INFO - moznetwork == 0.27 15:59:10 INFO - mozprocess == 0.25 15:59:10 INFO - mozprofile == 0.28 15:59:10 INFO - mozrunner == 6.13 15:59:10 INFO - mozscreenshot == 0.1 15:59:10 INFO - mozsystemmonitor == 0.3 15:59:10 INFO - moztest == 0.8 15:59:10 INFO - mozversion == 1.4 15:59:10 INFO - psutil == 3.1.1 15:59:10 INFO - requests == 1.2.3 15:59:10 INFO - wsgiref == 0.1.2 15:59:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:10 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 0x27161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a82a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a86090>, '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 0x2a86d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a80f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', '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 15:59:10 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 15:59:10 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 15:59:10 INFO - Using env: {'DISPLAY': ':0', 15:59:10 INFO - 'HOME': '/home/cltbld', 15:59:10 INFO - 'LANG': 'en_US.UTF-8', 15:59:10 INFO - 'LANGUAGE': 'en_US:en', 15:59:10 INFO - 'LOGNAME': 'cltbld', 15:59:10 INFO - 'MAIL': '/var/mail/cltbld', 15:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:10 INFO - 'MOZ_NO_REMOTE': '1', 15:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:10 INFO - 'NO_EM_RESTART': '1', 15:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:10 INFO - 'PWD': '/builds/slave/test', 15:59:10 INFO - 'SHELL': '/bin/bash', 15:59:10 INFO - 'SHLVL': '1', 15:59:10 INFO - 'TERM': 'linux', 15:59:10 INFO - 'TMOUT': '86400', 15:59:10 INFO - 'USER': 'cltbld', 15:59:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', 15:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:10 INFO - '_': '/tools/buildbot/bin/python'} 15:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:10 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)) 15:59:10 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)) 15:59:10 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)) 15:59:10 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)) 15:59:10 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)) 15:59:10 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)) 15:59:10 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)) 15:59:10 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)) 15:59:10 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)) 15:59:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:59:11 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)) 15:59:11 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)) 15:59:11 INFO - Installing collected packages: simplejson 15:59:11 INFO - Running setup.py install for simplejson 15:59:11 INFO - building 'simplejson._speedups' extension 15:59:11 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 15:59:12 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 15:59:12 INFO - Successfully installed simplejson 15:59:12 INFO - Cleaning up... 15:59:12 INFO - Return code: 0 15:59:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:59:12 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')]} 15:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:12 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')]} 15:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:12 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 0x27161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a82a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a86090>, '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 0x2a86d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a80f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', '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 15:59:12 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 15:59:12 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 15:59:12 INFO - Using env: {'DISPLAY': ':0', 15:59:12 INFO - 'HOME': '/home/cltbld', 15:59:12 INFO - 'LANG': 'en_US.UTF-8', 15:59:12 INFO - 'LANGUAGE': 'en_US:en', 15:59:12 INFO - 'LOGNAME': 'cltbld', 15:59:12 INFO - 'MAIL': '/var/mail/cltbld', 15:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:12 INFO - 'MOZ_NO_REMOTE': '1', 15:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:12 INFO - 'NO_EM_RESTART': '1', 15:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:12 INFO - 'PWD': '/builds/slave/test', 15:59:12 INFO - 'SHELL': '/bin/bash', 15:59:12 INFO - 'SHLVL': '1', 15:59:12 INFO - 'TERM': 'linux', 15:59:12 INFO - 'TMOUT': '86400', 15:59:12 INFO - 'USER': 'cltbld', 15:59:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', 15:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:12 INFO - '_': '/tools/buildbot/bin/python'} 15:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:59:12 INFO - Cleaning up... 15:59:12 INFO - Return code: 0 15:59:12 INFO - Running post-action listener: _resource_record_post_action 15:59:12 INFO - Running post-action listener: _start_resource_monitoring 15:59:12 INFO - Starting resource monitoring. 15:59:12 INFO - [mozharness: 2017-09-18 22:59:12.927822Z] Finished create-virtualenv step (success) 15:59:12 INFO - [mozharness: 2017-09-18 22:59:12.928840Z] Running install step. 15:59:12 INFO - Running pre-action listener: _resource_record_pre_action 15:59:12 INFO - Running main action method: install 15:59:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:13 INFO - Reading from file tmpfile_stdout 15:59:13 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:59:13 INFO - Reading from file tmpfile_stdout 15:59:13 INFO - Output received: 15:59:13 INFO - Usage: mozinstall [options] installer 15:59:13 INFO - Options: 15:59:13 INFO - -h, --help show this help message and exit 15:59:13 INFO - -d DEST, --destination=DEST 15:59:13 INFO - Directory to install application into. [default: 15:59:13 INFO - "/builds/slave/test"] 15:59:13 INFO - --app=APP Application being installed. [default: firefox] 15:59:13 INFO - mkdir: /builds/slave/test/build/application 15:59:13 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'] 15:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:59:31 INFO - Reading from file tmpfile_stdout 15:59:31 INFO - Output received: 15:59:31 INFO - /builds/slave/test/build/application/firefox/firefox 15:59:31 INFO - Running post-action listener: _resource_record_post_action 15:59:31 INFO - [mozharness: 2017-09-18 22:59:31.034904Z] Finished install step (success) 15:59:31 INFO - [mozharness: 2017-09-18 22:59:31.035157Z] Running setup-mitmproxy step. 15:59:31 INFO - Running pre-action listener: _resource_record_pre_action 15:59:31 INFO - Running main action method: setup_mitmproxy 15:59:31 INFO - Skipping: mitmproxy is not required 15:59:31 INFO - Running post-action listener: _resource_record_post_action 15:59:31 INFO - [mozharness: 2017-09-18 22:59:31.036291Z] Finished setup-mitmproxy step (success) 15:59:31 INFO - [mozharness: 2017-09-18 22:59:31.036576Z] Running run-tests step. 15:59:31 INFO - Running pre-action listener: _resource_record_pre_action 15:59:31 INFO - Running pre-action listener: _set_gcov_prefix 15:59:31 INFO - Running main action method: run_tests 15:59:31 WARNING - Try message not found. 15:59:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:59:31 INFO - Python 2.7.3 15:59:31 INFO - Return code: 0 15:59:31 INFO - grabbing minidump binary from tooltool 15:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:31 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 0x2a86090>, '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 0x2a86d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a80f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:59:31 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 15:59:31 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 15:59:31 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 15:59:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:59:31 INFO - Return code: 0 15:59:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:59:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:59:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:59:31 INFO - ENV: RUST_BACKTRACE is now full 15:59:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:59:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:59:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 15:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 15:59:31 INFO - Using env: {'DISPLAY': ':0', 15:59:31 INFO - 'HOME': '/home/cltbld', 15:59:31 INFO - 'LANG': 'en_US.UTF-8', 15:59:31 INFO - 'LANGUAGE': 'en_US:en', 15:59:31 INFO - 'LOGNAME': 'cltbld', 15:59:31 INFO - 'MAIL': '/var/mail/cltbld', 15:59:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:59:31 INFO - 'MOZ_ACCELERATED': '1', 15:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:31 INFO - 'MOZ_NO_REMOTE': '1', 15:59:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:31 INFO - 'MOZ_WEBRENDER': '1', 15:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:31 INFO - 'NO_EM_RESTART': '1', 15:59:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:31 INFO - 'PWD': '/builds/slave/test', 15:59:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:31 INFO - 'RUST_BACKTRACE': 'full', 15:59:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:59:31 INFO - 'SHELL': '/bin/bash', 15:59:31 INFO - 'SHLVL': '1', 15:59:31 INFO - 'TERM': 'linux', 15:59:31 INFO - 'TMOUT': '86400', 15:59:31 INFO - 'USER': 'cltbld', 15:59:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', 15:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:31 INFO - '_': '/tools/buildbot/bin/python'} 15:59:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 15:59:31 INFO - mozversion application_buildid: 20170918220821 15:59:31 INFO - mozversion application_changeset: 948dc86aabc97e16d51ad19ea90debab6f93a628 15:59:31 INFO - mozversion application_display_name: Nightly 15:59:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:59:31 INFO - mozversion application_name: Firefox 15:59:31 INFO - mozversion application_remotingname: firefox 15:59:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:59:31 INFO - mozversion application_vendor: Mozilla 15:59:31 INFO - mozversion application_version: 57.0a1 15:59:31 INFO - mozversion platform_buildid: 20170918220821 15:59:31 INFO - mozversion platform_changeset: 948dc86aabc97e16d51ad19ea90debab6f93a628 15:59:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:59:31 INFO - mozversion platform_version: 57.0a1 15:59:31 INFO - using testdate: 1505775571 15:59:31 INFO - actual date: 1505775571 15:59:31 INFO - starting webserver on 'localhost:35193' 15:59:31 INFO - SUITE-START | Running 2 tests 15:59:31 INFO - TEST-START | dromaeo_css 15:59:31 INFO - Initialising browser for dromaeo_css test... 15:59:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35193/getInfo.html -profile /tmp/tmpC5EC9z/profile 15:59:31 INFO - TEST-INFO | started process 3536 (/builds/slave/test/build/application/firefox/firefox http://localhost:35193/getInfo.html) 15:59:39 INFO - TEST-INFO | 3536: exit 0 15:59:39 INFO - Browser initialized. 15:59:39 INFO - Running cycle 1/1 for dromaeo_css test... 15:59:39 INFO - Using env: {'DISPLAY': ':0', 15:59:39 INFO - 'HOME': '/home/cltbld', 15:59:39 INFO - 'JSGC_DISABLE_POISONING': '1', 15:59:39 INFO - 'LANG': 'en_US.UTF-8', 15:59:39 INFO - 'LANGUAGE': 'en_US:en', 15:59:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:59:39 INFO - 'LOGNAME': 'cltbld', 15:59:39 INFO - 'MAIL': '/var/mail/cltbld', 15:59:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:59:39 INFO - 'MOZ_ACCELERATED': '1', 15:59:39 INFO - 'MOZ_CRASHREPORTER': '1', 15:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:59:39 INFO - 'MOZ_NO_REMOTE': '1', 15:59:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:39 INFO - 'MOZ_WEBRENDER': '1', 15:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:39 INFO - 'NO_EM_RESTART': '1', 15:59:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:39 INFO - 'PWD': '/builds/slave/test', 15:59:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:39 INFO - 'RUST_BACKTRACE': 'full', 15:59:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:59:39 INFO - 'SHELL': '/bin/bash', 15:59:39 INFO - 'SHLVL': '1', 15:59:39 INFO - 'TERM': 'linux', 15:59:39 INFO - 'TMOUT': '86400', 15:59:39 INFO - 'USER': 'cltbld', 15:59:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', 15:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:39 INFO - '_': '/tools/buildbot/bin/python'} 15:59:39 INFO - TEST-INFO | started process 3785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC5EC9z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:40 INFO - PID 3785 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:59:40 INFO - PID 3785 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:59:40 INFO - PID 3785 | 15:59:40 INFO - PID 3785 | (/builds/slave/test/build/application/firefox/firefox:3844): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:59:40 INFO - PID 3785 | 15:59:50 INFO - PID 3785 | RSS: Main: 191541248 15:59:50 INFO - PID 3785 | 16:02:48 INFO - PID 3785 | Cycle 1(1): loaded http://localhost:35193/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35193/tests/dromaeo/cssquery-ext.html) 16:02:50 INFO - PID 3785 | RSS: Main: 193486848 16:02:50 INFO - PID 3785 | 16:05:52 INFO - PID 3785 | Cycle 1(1): loaded http://localhost:35193/tests/dromaeo/cssquery-ext.html (next: http://localhost:35193/tests/dromaeo/cssquery-jquery.html) 16:05:52 INFO - PID 3785 | RSS: Main: 190611456 16:05:52 INFO - PID 3785 | 16:08:54 INFO - PID 3785 | Cycle 1(1): loaded http://localhost:35193/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35193/tests/dromaeo/cssquery-mootools.html) 16:08:55 INFO - PID 3785 | RSS: Main: 192987136 16:08:55 INFO - PID 3785 | 16:11:57 INFO - PID 3785 | Cycle 1(1): loaded http://localhost:35193/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35193/tests/dromaeo/cssquery-prototype.html) 16:11:58 INFO - PID 3785 | RSS: Main: 191983616 16:11:58 INFO - PID 3785 | 16:15:01 INFO - PID 3785 | Cycle 1(1): loaded http://localhost:35193/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35193/tests/dromaeo/cssquery-yui.html) 16:15:02 INFO - PID 3785 | RSS: Main: 193388544 16:15:02 INFO - PID 3785 | 16:18:04 INFO - PID 3785 | Cycle 1(1): loaded http://localhost:35193/tests/dromaeo/cssquery-yui.html (next: http://localhost:35193/tests/dromaeo/cssquery-dojo.html) 16:18:04 INFO - PID 3785 | RSS: Main: 195858432 16:18:04 INFO - PID 3785 | 16:18:04 INFO - PID 3785 | __start_tp_report 16:18:04 INFO - PID 3785 | _x_x_mozilla_page_load 16:18:04 INFO - PID 3785 | _x_x_mozilla_page_load_details 16:18:04 INFO - PID 3785 | |i|pagename|runs| 16:18:04 INFO - PID 3785 | |0;dojo.html;3115.2056225662454;3120.0639808057585;3120.8595613197417;3180.252640629452;3192.521121831725;6307.684615769211;6317.0208617664275;6323.525735569828;6348.428641422271;6361.491080713543;6143.109249158881;6191.411815877495;6208.875822483547;6218.22272215973;6232.937670623292;5695.77216911323;5739.282589676291;5757.510611597998;5792.478676919077;5811.883762324751;5800.622959507639;5805.709714514279;5885;5901.881962360751;5959;5800.796972105977;5858.648481091127;5859.355470898197;5903.675297858616;5909.586328956974;5567.47109024642;5665.2351932489;5665.745041473102;5841.970790146022;5859.619124756877;5199.818006369759;5709.714514274311;5758.942410575924;5790.13148027795;5822.068469044975;6291.937080629181;6310.400511951358;6354.491640668735;6363.713632886485;6374.394432528902;6573.506986975996;6578.76974305897;6659.167604049494;6766.627835469048;6766.7969960901255;6573.57271777333;6806.659667016679;6882.03651488792;6885.380315771605;6892.207396149457;6226.719797609118;6227.314995350508;6237.844053898643;6242.375762423767;6287.088372186007;6943.097397338313;6948.096747422803;6962.547434416747;7010.824729381704;7030.507864449542;6628;6644;6687.732490700415;6701.430378417889;6709.597424154566;6563.803085907431;6607.933920660828;6663.966680166665;6722.462203023746;6831.555948863308;6734.629595372302;6738.528303018839;6759.053732477457;6773.221079575814;6773.762918297836;6689.9965005249605;6706.631135287508;6792.864142717118;6809.829754256183;6816.284290149463;5172.741362931838;5209.843704688866;5294.549963253166;5323.707196104174;5324.1747529133045;4454.5990860822685;4530.977345113253;4610.515895830889;4691.7184968901975;4692.4603670577635;5733.827985160452;5786.826395208151;5797.913031304533;5840.561957853178;5861;6726.428253598499;6780.355866192704;6782.966085169543;6802.047713320139;6875.796735571255;5775.5090817281;5814.59297849155;5868.911966320508;5874.206982057453;5887.470127688529;5634.295713035871;5693.68684722336;5704.34400043992;5714.114312281603;5780.971095144498;6533.020046992989;6617.7683781067435;6620.8344791380605;6623.834404139839;6624.304448032984;6699.866002680016;6726.529142960141;6736.393724564813;6799.252082270947;6869.519133660596;6485.3514648534765;6497.8700425992165;6594.670266486561;6599.208095028627;6609.041688954979;6461.547691661539;6548.050532672641;6549.181352330958;6682.131322927989;6685.364890335411;6766.661666916733;6799.184097908283;6826.658667066726;6845.212800528003;6872.244053154249;6450.548461607643;6509.576877502947;6578.04618330349;6603.966980165068;6613.272540020497;6346.174997250328;6400.1679781629955;6525.314841941527;6529.934700652932;6639.236487803964;6435.388638079375;6501.902471462838;6507.609543427409;6520.739170433129;6530.151080359523;6548.508861835287;6631.403173714389;6665.800025999228;6704.463642908653;6712.463002959654;6394.136791533084;6406.487481001415;6459.9031014533875;6489.8702025960165;6491.967540162269 16:18:04 INFO - PID 3785 | |1;ext.html;852.6163226548055;862.6894318045503;865;867.496851825941;889.5329951775317;39875.40186897195;41203;41319.58680413203;41346.37980430296;41415.79292103543;37346;37830.621693783054;41298.174036519325;41776.164476710444;41940.37089443661;7677.155512893577;7810.453268271223;7835.764927052198;7845.411594130434;7850.803729906741;7559;7752.573608451533;7768.611569421535;7768.65041073153;7789.987301650777;7738.18749031352;7791.298783109519;7813.609319534029;7820.491668041587;7851.175626559215;7691.23087691232;7748.108967468757;7750.922490775077;7760.107587627439;7767.262110099559;7614.124375696811;7661.961690191569;7685.154632990367;7693.346065584432;7703.114141873701;37343.8132809337;37813.621863781285;37850.43224351637;37862.62137378618;37954.81022594869;3495.8252087395526;3549.6095429502734;3551.964480355189;3554.306910152521;3556.413191823346;31244.37511249785;31344.52983205231;31382.843085784654;31414.842925785455;31495.37009259802;4977.129002424597;5171.586273098181;5184.766685499124;5196.714180720059;5226.111561034595;183294;184939;185216;185873;185899.07050464797;46315.30527042097;46473.30290045652;47032.5296747035;47037.29444058342;47079;48586;48724.756376218604;53423;54615.45384546183;54952;15969.281382337822;16085;16107.355705771872;16215.10816905058;16241.2691428886;13400.932995335155;13436.126651767603;13438.193708377334;13441.663958400923;13461.798073028913;14160.716785664228;14166.150030998173;14249.358778854976;14260.42958281657;14290.42838286457;5687.0663974248955;5700.401457846866;5721.599488035798;5760;5802.767889284466;988.7775250568565;997.7405874472544;1002.1682003936716;1003.4832061488339;1031.896810318962;22908.770912291;23031.654525182137;23285.7671423287;23394.532109358057;23544.058237670644;1096.4037955505953;1108.2906939558527;1108.4457771114444;1111.5442668506034;1117.536222467667;12168.878311216775;12212.511499539918;12232.510699572096;12339.197952133083;12449.25304481734;238149;239204;239923;239947;240584;42465.36301955473;43242.56757432449;49908.75045624821;50510.74744626253;50753.238701419505;1378.7862881253423;1438.1946110178333;1442.6177063078292;1446.3997441062052;1448.898577099614;26728;26742;26772.59841102424;26888.59667105034;27089.72910270872;35285.823570881985;35350.29299414049;35531.644683553866;35533.82233088921;35685.28629427449;181297;181846.0907695453;182233;183259;184055;33925.83037084799;34040.48939265864;34064.65935340714;34107.31785364328;34232.14419639529;41103.58896410998;42255.366169506866;42402.36396453994;42834;43438.13123737571;29281.70718292875;30544.847275763477;30724.846375768873;30961.535576966813;31284.374312513166;30524.389512210077;30540.694593054675;30551;30603.54094688537;30734.385312293183;35322;35327;35415;35470.64529354673;35566.11084722799;30328.696713032587;30775.538366924065;31132.37735245237;31229.063128106194;31402.21494462565;22735;23089.88455057714;23279.76720232776;23386.64920026167;23419.180328688413 16:18:04 INFO - PID 3785 | |2;jquery.html;550.8044644151327;560.3807792389412;565.1466285908278;578.9073748200288;593.6467801658014;21595.35213943582;22432.66351004732;22540.32379028628;22571.999999999978;22608.321750347495;23691.881540592316;24281.75718242817;24541.63187552188;25266.747332526716;25493.36266593336;6456.967715161418;6496.805095847132;6561.3438656134485;6568.934310656904;6574;6394.6482943438095;6491.156149700556;6495.31799161086;6499.220093588776;6513.120728701636;6180.814575562717;6442.613443193423;6447.516436267299;6448.065030570565;6451.129097571838;6458.5479016468635;6465.094886715863;6533.673316334164;6539.215294164707;6543.116679248288;5997.4002599740115;6043.516518678495;6053.878922421571;6057.939420605826;6062.514998800129;27917.860410697816;28142.718572814214;28963.420731585462;28979.710202898124;29726.554101688493;2047.8771273723623;2070.4616799632204;2079.5009197792574;2087.09211493001;2103.137713537458;18208.90895545514;18789.90605046966;18885.527861803428;19011.429657110308;19018.71471927922;2395.0792009144875;2396.5566370221563;2432.525657496789;2435.2694191742407;2480;117733;122725.38637306845;123601.38199309036;131289.34355328162;138926;20709.68935465969;21203.78796212049;22024.559508809733;22031.567948083324;22639.660405093935;42342.36486452706;42362.364564531556;42548.36177457341;42564;42744.57255427468;11561.07511399086;11584.42077896102;11709.531618735326;11784.823227651592;11828.645140645795;9931.453770042572;9947.104760571583;10018.949905250427;10045.69862904114;10228.897711022943;10758.300710453796;11099.334039957628;11135;11271.774564508827;11569.595064172714;3839.155385815116;4045.6358927696647;4063;4188.874333769992;4216.852410165629;962.259060523393;973.3673112476947;982.2682101834037;983.9704808855746;994.5773046455228;19070.90464547696;19220.231190752493;19260.422187334403;19640.70538941917;20058.997050147434;990.5096976996433;1029.8352263637782;1032.390889375272;1035.2701345551368;1039.0285083447002;10811.945940270405;10897.727556811144;10914.290571112851;11120.054795342325;11170.050545703707;432078;450805;456852;463884;471245;107743.46128269465;108263;109125;109153.45423272991;110147;1112.260346869339;1124.4995976790412;1128.8758236593967;1143.8684551276542;1150.5742875136252;17388.565285867953;17427.82572174262;17439.651206975537;17944;17946.91026544859;52909;53478;53863.192052118466;54200.186997195866;54853;65958;66236.66881665561;66324.6683766578;66588.33411665821;66747;19568.80431195727;19680.507987299858;19772.90113549423;19799.208031679147;20148.697769533763;22037.779622204213;22074.33776986693;22178;22324.21865234709;22562.661560076285;17423.56441088983;17532;18028.54928626795;18073.36743213981;18122.637547249244;14946.327415266556;14962;14974;15342.15618141013;15489.380424782883;16462.917685411496;16548;16565.42021029258;16586.58533536671;17731.290748370437;17983.10084495796;18114.456566303033;18254;18281;18357.632847342713;16455.177241137655;16485.093319867523;16492.587685307964;16495.092769897772;17597.384091556734 16:18:04 INFO - PID 3785 | |3;mootools.html;1334.6996925691722;1386.0477183598932;1403.0459287684378;1407.774756039034;1408.4718230663502;14702.485413010547;15203.391864325427;15213.695726085472;15230.695386092271;15358.155301458415;14809.11145331281;14867.776983345231;14968.476103336385;14982.101073935572;14992.700145997102;2657.269250955993;2747.1346525844397;2748.5877118432195;2749.230215539652;2749.3676454415495;2567.3453269416273;2643.8017148713925;2684.302081458825;2693.636359091527;2706.3640044589506;2240.955180896381;2352.7059117610297;2356.2813341930705;2707.6344693466426;2811.12855014945;2788.2053614719807;2795.622590950216;2797.9860100699366;2800.2999250187454;2808.283887608657;2707.1201859395774;2733.3439974406197;2734.6855111662217;2738.123800383878;2740.4245108527234;14620.634484137876;14692.779608305884;14749.115053096848;14878.256087195598;14921.925390373088;7849.4897831640765;8189.918100818975;8198.344132469389;8218.096009439018;8233.46482478637;5186.273921650972;5436.429174936614;5607.327120745495;5673.943260567424;5687.772489100431;1622.594351412147;1907.294301108585;1935.3032908153054;1952.4825921130912;1961.6076784643128;23837.7616223839;25279.87360063206;25878.87060564685;25924;26039.088631897794;7315;7398.149212840484;7401.33387995083;7507.436942229246;7572.258380572499;19798.109085091204;19828.60342793136;19829.30597429083;19842.60314793696;19867.105980230925;8339.166083391612;8392.580370981426;8507.532085735344;8526;8528.104549022264;7487.625618719042;7505.774826755206;7533.54798712079;7562.978997835332;7579.279968402993;5570.832875013756;5728.283964504437;5765.827025189251;5789.392113828072;6026;1800.9279628814963;1822.180018991459;1828.8994105324334;1852.8599467614927;1869.3924474545554;900.5452246615548;902.3908861518448;906.9682561110329;915.9313051521162;920.8710780490736;7392.186859445456;7466.738664146837;7524.699012039567;7536.171021187665;7614.35278001365;729.4128226777495;731.3637135691876;731.4550659758407;734.071399679406;739.7115125101108;4645.349651048856;4666.95333046672;4675.509071547506;4727.669063165614;4729.5743383095;20276.18895244174;21147.47131321729;21317.68023479649;21320;21362.679559806616;20040.298589549588;20791.272305469236;20802.791972080387;20819.687704684442;21015.684764728543;9484.952575237217;9808.558614862348;10932.726681833177;11312.886871131182;11382.373969431595;8970.37207395476;9006.459612423276;9044.547772611475;9090;9236.861447078434;17771.644567108844;18078.728819067986;18180.909095454437;18445.723314150568;18481.72277415813;18698.252069917595;19095.427137185907;19254;19258.325958591384;20027;11537;11644.184907056424;11652.417379131179;11659.53361865516;11857.288562686266;13218.140820846998;13340.19958802475;13346.599602011955;13348.93325533366;13363.53227637028;11197.88802112001;11205.775884482428;11438.771224575628;11472.426378680866;11545.134114941246;10881;11019.779604408028;11289.71775705614;11342.886571134182;11355.37545435009;9872.605095796374;9889.950550247202;9984.450855203033;9988.550515226978;10010.149137323118;6934.826629334307;6945.68744406513;6976.302369762983;7005.334493223339;7104.822379440348;7215.314545118205;7487.850242995;7579.848403032019;7582.848343032998;7602.391808655405 16:18:04 INFO - PID 3785 | |4;prototype.html;497.83194189305596;501.53495569277015;527.7915223486721;527.9392869819972;530.4907786171409;6262.874742505152;6295.874082518347;6299.77950771723;6310.432061114493;6390.3929126733;6234.501239900808;6240.219972503437;6252.437280644741;6257.780977665782;6262.3111457739615;5143.485651434864;5201.0756020272365;5217.426083130853;5233.4243233244315;5233.842984710464;5166.974165129169;5219;5233.502817232356;5238.345206849125;5266.104762190418;4662.930056049162;4915.9754201229125;4952.232403977371;4952.232403977389;5076.477056882939;4870.756462176894;4890.388701412324;4910.950890491103;4930.630202734809;4949.331840201598;4294.957050429487;4389.495208051083;4399.208142534342;4422.137683151786;4425.7565833879125;5969.820905372846;6005.249343832021;6009.248843894513;6029.246344206974;6105.786297479612;5614.6631202128;5624.409437009137;5628.465295796893;5639.718014099279;5649.152627105926;6333.524985626051;6427.58220715652;6459.67701614922;6480.902786458207;6501.284858665543;4545.613622842063;4804.711717296974;4829.589484893788;4864.343313652647;4876.341693871317;6570.817252894477;6659;6769.1876974763345;6798.966005170041;6799.252082270947;4820.975895120502;4849.781759820817;4853.490383509751;4857.854264372075;4863.781129849165;4935.111679897653;4936.136176169156;4940.209566469348;4947.529984651453;4965.988774546315;5570.916436253459;5626.381098079208;5632.493075623213;5641.9435805641415;5650.208970744099;6503.479721622353;6549.836254093686;6569.6058236505005;6574.605523668595;6603.570767900071;1732.12064909572;1733.8699597530235;1736.5571779196225;1751.6584266068248;1755.95520665204;1138.3056335635256;1196.4795314038422;1198.844150260478;1210.3464129370218;1215.8844909733562;5568.693721845257;5569.916451253234;5596.3284405870745;5652.491275785199;5669.886602267931;6414.775482858077;6485.805425837232;6489.480841532761;6527;6553;5618.578606604439;5632.183333416713;5652.236948012048;5657;5692.943070569241;3458.2737625098507;3472.652734726558;3483.8432270547887;3516.226430185355;3530.382183117944;6329.588576742497;6396.1045453636525;6441.838954026093;6448.774292899726;6451.548391612542;6693.866122677617;6746.494012949049;6775.695093720795;6814.62519561419;6849;6260.280067792262;6282.685865706696;6318.704665543461;6345.809625711236;6355.205599300088;6055.364186760503;6536.738530458919;6541.70562324687;6578.5395022347975;6641.966790166019;6408;6432.35676432353;6460.547761656639;6484.448821850006;6502.804915852532;6121.204243448323;6242.937570624235;6345.96827015862;6397.232332119989;6524.804255872332;4885.145099607484;4962.412028150957;4968.503149685002;4985.3020577118505;5005.174146265826;6394.648294343856;6619.900701489578;6660.400563949268;6728.596284222962;6736.989451582302;6286.874262514815;6353.506925872324;6420.775272865428;6489.156409666713;6511.967440162769;6311;6423.132877061536;6426.967865160831;6450.322716114741;6453.677316134268;6289.811305660837;6325.462335701517;6334.778282760081;6341;6383.521235907233;6421.325760795236;6439;6459.6770161490795;6476.481881449378;6499.050284914412;6252.781152659635;6254.2800729799665;6323.272823625158;6338.968305158444;6392.712327945346 16:18:04 INFO - PID 3785 | |5;yui.html;896.9596368163433;902.6840605787979;921.8985911549725;922.4188761080518;925.3984909808626;19918.302859399922;20497.59004819903;20559.794402055995;20586.279480218196;20608.89695551522;18234.452966410994;18472.16875240614;18569.721454178165;18617.348392806256;18638.906805465987;945.7541039329755;950.8098380323928;953.1802649721234;958.7123862841155;963.8072385522888;949.2074118111351;954.7326748510428;954.7947191353858;956.8612551180074;990.1484723138095;1005.8692369991927;1021.9591216351374;1024.359775140537;1028.4189432970347;1042.072555425668;1025.2054657640315;1028.0644613401769;1028.3264461777474;1030.464158637508;1044.984325235122;738.7488253993668;739.6856336057208;744.6351287868905;745.9291367320096;753.461275188243;19197.80802191974;19636;19810.70283945742;19860.70208946867;19878.70181947272;21267.46831329214;21533.784662153335;21598.35204943854;21733.565328693494;21930.342089737333;17031.403900863534;17133.657326853518;17192.484225473258;17199.054052027135;17276.481705548853;3679.300932822755;3715.294094122108;3719.1260053887586;3721.14413684854;3763.2473505298776;128813.35593322066;138634;138705.306473468;142916.71249862522;143624.28187858994;16948.23732932021;17241.741373879402;17320.133993300286;17401.82598174002;17579.64840703179;30237.395252094833;30251.848740756155;30671.2332191697;30873.228169295948;30999.69000309968;8836.513991730517;8979.281657467518;9005.549722513979;9133.588988495534;9177.128172823572;4215.915681686411;4291.699581029298;4299.699021068495;4331.328644060176;4332.155229730235;5390.97304513475;5535.114381698909;5543.334799824047;5570.2201691762375;5570.860728481739;1068.4070340960686;1093.4314156638504;1096.6874440784338;1099.999000909169;1101.031092638473;644.7195469970484;657.6087228099274;667.1493845347125;671.9596824190564;675.8073948924533;11902.642920712393;11949.402529873472;11959.222650527689;12764.872351276368;12918.483260669467;628.6291088257858;636.9044643303541;645.3159650770199;645.56101850741;648.1832890557931;5839.357670656224;5841.766329346779;5861.6189947653265;5888.263967004124;5936.9406305937255;124544.37727811302;125200.37399812942;125642;126182;127856;108105.45947270213;108216;111948;112281;114000;95274.5236273828;95948.9999999986;96195;98723.50638246906;99733.00266997382;10902.291351062155;10904.618338358438;10966.670999870017;11010.174236932422;11182.161337899854;43588;44237.33643995407;45399.09201816011;45535;46789.53210467852;54969.725151375584;57841.843163137346;57897.71051144717;58750;60120.39879601148;15855;15930.681386371976;15984.280707367963;16144.919275403548;16261.59346016359;18006.549836253675;18023.188956496728;18065.2773889043;18136.81863181404;18467.630647387246;16110.436134735228;16144.757828632815;16249.10629915366;16253.268602912662;16302.266398012354;16474.341026358812;16670.499885003468;16784.24470898788;16862.66274674524;17010.829891700923;15040.849591503946;15330.080195188324;15353.07881527112;15486.303116360015;15747.68504629878;11563;11746.647600571996;11900.988415984739;12030.27818330903;12067.698307542381;12120.393980300772;12171.208871423329;12182.512699491921;12274.386280686109;12400.441980110736 16:18:04 INFO - PID 3785 | __end_tp_report 16:18:04 INFO - PID 3785 | __start_cc_report 16:18:04 INFO - PID 3785 | _x_x_mozilla_cycle_collect,293 16:18:04 INFO - PID 3785 | __end_cc_report 16:18:04 INFO - PID 3785 | __startTimestamp1505776684693__endTimestamp 16:18:04 INFO - PID 3785 | 16:18:04 INFO - PID 3785 | ------- Summary: start ------- 16:18:04 INFO - PID 3785 | Number of tests: 6 16:18:04 INFO - PID 3785 | 16:18:04 INFO - PID 3785 | [#0] dojo.html Cycles:165 Average:6195.19 Median:6461.55 stddev:756.88 (11.7%) stddev-sans-first:719.60 16:18:04 INFO - PID 3785 | Values: 3115.2 3120.1 3120.9 3180.3 3192.5 6307.7 6317.0 6323.5 6348.4 6361.5 6143.1 6191.4 6208.9 6218.2 6232.9 5695.8 5739.3 5757.5 5792.5 5811.9 5800.6 5805.7 5885.0 5901.9 5959.0 5800.8 5858.6 5859.4 5903.7 5909.6 5567.5 5665.2 5665.7 5842.0 5859.6 5199.8 5709.7 5758.9 5790.1 5822.1 6291.9 6310.4 6354.5 6363.7 6374.4 6573.5 6578.8 6659.2 6766.6 6766.8 6573.6 6806.7 6882.0 6885.4 6892.2 6226.7 6227.3 6237.8 6242.4 6287.1 6943.1 6948.1 6962.5 7010.8 7030.5 6628.0 6644.0 6687.7 6701.4 6709.6 6563.8 6607.9 6664.0 6722.5 6831.6 6734.6 6738.5 6759.1 6773.2 6773.8 6690.0 6706.6 6792.9 6809.8 6816.3 5172.7 5209.8 5294.5 5323.7 5324.2 4454.6 4531.0 4610.5 4691.7 4692.5 5733.8 5786.8 5797.9 5840.6 5861.0 6726.4 6780.4 6783.0 6802.0 6875.8 5775.5 5814.6 5868.9 5874.2 5887.5 5634.3 5693.7 5704.3 5714.1 5781.0 6533.0 6617.8 6620.8 6623.8 6624.3 6699.9 6726.5 6736.4 6799.3 6869.5 6485.4 6497.9 6594.7 6599.2 6609.0 6461.5 6548.1 6549.2 6682.1 6685.4 6766.7 6799.2 6826.7 6845.2 6872.2 6450.5 6509.6 6578.0 6604.0 6613.3 6346.2 6400.2 6525.3 6529.9 6639.2 6435.4 6501.9 6507.6 6520.7 6530.2 6548.5 6631.4 6665.8 6704.5 6712.5 6394.1 6406.5 6459.9 6489.9 6492.0 16:18:04 INFO - PID 3785 | 16:18:04 INFO - PID 3785 | [#1] ext.html Cycles:180 Average:36944.29 Median:35324.50 stddev:52840.39 (149.6%) stddev-sans-first:52919.12 16:18:04 INFO - PID 3785 | Values: 852.6 862.7 865.0 867.5 889.5 39875.4 41203.0 41319.6 41346.4 41415.8 37346.0 37830.6 41298.2 41776.2 41940.4 7677.2 7810.5 7835.8 7845.4 7850.8 7559.0 7752.6 7768.6 7768.7 7790.0 7738.2 7791.3 7813.6 7820.5 7851.2 7691.2 7748.1 7750.9 7760.1 7767.3 7614.1 7662.0 7685.2 7693.3 7703.1 37343.8 37813.6 37850.4 37862.6 37954.8 3495.8 3549.6 3552.0 3554.3 3556.4 31244.4 31344.5 31382.8 31414.8 31495.4 4977.1 5171.6 5184.8 5196.7 5226.1 183294.0 184939.0 185216.0 185873.0 185899.1 46315.3 46473.3 47032.5 47037.3 47079.0 48586.0 48724.8 53423.0 54615.5 54952.0 15969.3 16085.0 16107.4 16215.1 16241.3 13400.9 13436.1 13438.2 13441.7 13461.8 14160.7 14166.2 14249.4 14260.4 14290.4 5687.1 5700.4 5721.6 5760.0 5802.8 988.8 997.7 1002.2 1003.5 1031.9 22908.8 23031.7 23285.8 23394.5 23544.1 1096.4 1108.3 1108.4 1111.5 1117.5 12168.9 12212.5 12232.5 12339.2 12449.3 238149.0 239204.0 239923.0 239947.0 240584.0 42465.4 43242.6 49908.8 50510.7 50753.2 1378.8 1438.2 1442.6 1446.4 1448.9 26728.0 26742.0 26772.6 26888.6 27089.7 35285.8 35350.3 35531.6 35533.8 35685.3 181297.0 181846.1 182233.0 183259.0 184055.0 33925.8 34040.5 34064.7 34107.3 34232.1 41103.6 42255.4 42402.4 42834.0 43438.1 29281.7 30544.8 30724.8 30961.5 31284.4 30524.4 30540.7 30551.0 30603.5 30734.4 35322.0 35327.0 35415.0 35470.6 35566.1 30328.7 30775.5 31132.4 31229.1 31402.2 22735.0 23089.9 23279.8 23386.6 23419.2 16:18:04 INFO - PID 3785 | 16:18:04 INFO - PID 3785 | [#2] jquery.html Cycles:180 Average:33933.31 Median:22028.06 stddev:76468.20 (347.1%) stddev-sans-first:76641.64 16:18:04 INFO - PID 3785 | Values: 550.8 560.4 565.1 578.9 593.6 21595.4 22432.7 22540.3 22572.0 22608.3 23691.9 24281.8 24541.6 25266.7 25493.4 6457.0 6496.8 6561.3 6568.9 6574.0 6394.6 6491.2 6495.3 6499.2 6513.1 6180.8 6442.6 6447.5 6448.1 6451.1 6458.5 6465.1 6533.7 6539.2 6543.1 5997.4 6043.5 6053.9 6057.9 6062.5 27917.9 28142.7 28963.4 28979.7 29726.6 2047.9 2070.5 2079.5 2087.1 2103.1 18208.9 18789.9 18885.5 19011.4 19018.7 2395.1 2396.6 2432.5 2435.3 2480.0 117733.0 122725.4 123601.4 131289.3 138926.0 20709.7 21203.8 22024.6 22031.6 22639.7 42342.4 42362.4 42548.4 42564.0 42744.6 11561.1 11584.4 11709.5 11784.8 11828.6 9931.5 9947.1 10018.9 10045.7 10228.9 10758.3 11099.3 11135.0 11271.8 11569.6 3839.2 4045.6 4063.0 4188.9 4216.9 962.3 973.4 982.3 984.0 994.6 19070.9 19220.2 19260.4 19640.7 20059.0 990.5 1029.8 1032.4 1035.3 1039.0 10811.9 10897.7 10914.3 11120.1 11170.1 432078.0 450805.0 456852.0 463884.0 471245.0 107743.5 108263.0 109125.0 109153.5 110147.0 1112.3 1124.5 1128.9 1143.9 1150.6 17388.6 17427.8 17439.7 17944.0 17946.9 52909.0 53478.0 53863.2 54200.2 54853.0 65958.0 66236.7 66324.7 66588.3 66747.0 19568.8 19680.5 19772.9 19799.2 20148.7 22037.8 22074.3 22178.0 22324.2 22562.7 17423.6 17532.0 18028.5 18073.4 18122.6 14946.3 14962.0 14974.0 15342.2 15489.4 16462.9 16548.0 16565.4 16586.6 17731.3 17983.1 18114.5 18254.0 18281.0 18357.6 16455.2 16485.1 16492.6 16495.1 17597.4 16:18:04 INFO - PID 3785 | 16:18:04 INFO - PID 3785 | [#3] mootools.html Cycles:180 Average:9337.40 Median:2688.97 stddev:6582.64 (244.8%) stddev-sans-first:6573.64 16:18:04 INFO - PID 3785 | Values: 1334.7 1386.0 1403.0 1407.8 1408.5 14702.5 15203.4 15213.7 15230.7 15358.2 14809.1 14867.8 14968.5 14982.1 14992.7 2657.3 2747.1 2748.6 2749.2 2749.4 2567.3 2643.8 2684.3 2693.6 2706.4 2241.0 2352.7 2356.3 2707.6 2811.1 2788.2 2795.6 2798.0 2800.3 2808.3 2707.1 2733.3 2734.7 2738.1 2740.4 14620.6 14692.8 14749.1 14878.3 14921.9 7849.5 8189.9 8198.3 8218.1 8233.5 5186.3 5436.4 5607.3 5673.9 5687.8 1622.6 1907.3 1935.3 1952.5 1961.6 23837.8 25279.9 25878.9 25924.0 26039.1 7315.0 7398.1 7401.3 7507.4 7572.3 19798.1 19828.6 19829.3 19842.6 19867.1 8339.2 8392.6 8507.5 8526.0 8528.1 7487.6 7505.8 7533.5 7563.0 7579.3 5570.8 5728.3 5765.8 5789.4 6026.0 1800.9 1822.2 1828.9 1852.9 1869.4 900.5 902.4 907.0 915.9 920.9 7392.2 7466.7 7524.7 7536.2 7614.4 729.4 731.4 731.5 734.1 739.7 4645.3 4667.0 4675.5 4727.7 4729.6 20276.2 21147.5 21317.7 21320.0 21362.7 20040.3 20791.3 20802.8 20819.7 21015.7 9485.0 9808.6 10932.7 11312.9 11382.4 8970.4 9006.5 9044.5 9090.0 9236.9 17771.6 18078.7 18180.9 18445.7 18481.7 18698.3 19095.4 19254.0 19258.3 20027.0 11537.0 11644.2 11652.4 11659.5 11857.3 13218.1 13340.2 13346.6 13348.9 13363.5 11197.9 11205.8 11438.8 11472.4 11545.1 10881.0 11019.8 11289.7 11342.9 11355.4 9872.6 9890.0 9984.5 9988.6 10010.1 6934.8 6945.7 6976.3 7005.3 7104.8 7215.3 7487.9 7579.8 7582.8 7602.4 16:18:04 INFO - PID 3785 | 16:18:04 INFO - PID 3785 | [#4] prototype.html Cycles:180 Average:5437.68 Median:6113.50 stddev:1514.60 (24.8%) stddev-sans-first:1472.76 16:18:04 INFO - PID 3785 | Values: 497.8 501.5 527.8 527.9 530.5 6262.9 6295.9 6299.8 6310.4 6390.4 6234.5 6240.2 6252.4 6257.8 6262.3 5143.5 5201.1 5217.4 5233.4 5233.8 5167.0 5219.0 5233.5 5238.3 5266.1 4662.9 4916.0 4952.2 4952.2 5076.5 4870.8 4890.4 4911.0 4930.6 4949.3 4295.0 4389.5 4399.2 4422.1 4425.8 5969.8 6005.2 6009.2 6029.2 6105.8 5614.7 5624.4 5628.5 5639.7 5649.2 6333.5 6427.6 6459.7 6480.9 6501.3 4545.6 4804.7 4829.6 4864.3 4876.3 6570.8 6659.0 6769.2 6799.0 6799.3 4821.0 4849.8 4853.5 4857.9 4863.8 4935.1 4936.1 4940.2 4947.5 4966.0 5570.9 5626.4 5632.5 5641.9 5650.2 6503.5 6549.8 6569.6 6574.6 6603.6 1732.1 1733.9 1736.6 1751.7 1756.0 1138.3 1196.5 1198.8 1210.3 1215.9 5568.7 5569.9 5596.3 5652.5 5669.9 6414.8 6485.8 6489.5 6527.0 6553.0 5618.6 5632.2 5652.2 5657.0 5692.9 3458.3 3472.7 3483.8 3516.2 3530.4 6329.6 6396.1 6441.8 6448.8 6451.5 6693.9 6746.5 6775.7 6814.6 6849.0 6260.3 6282.7 6318.7 6345.8 6355.2 6055.4 6536.7 6541.7 6578.5 6642.0 6408.0 6432.4 6460.5 6484.4 6502.8 6121.2 6242.9 6346.0 6397.2 6524.8 4885.1 4962.4 4968.5 4985.3 5005.2 6394.6 6619.9 6660.4 6728.6 6737.0 6286.9 6353.5 6420.8 6489.2 6512.0 6311.0 6423.1 6427.0 6450.3 6453.7 6289.8 6325.5 6334.8 6341.0 6383.5 6421.3 6439.0 6459.7 6476.5 6499.1 6252.8 6254.3 6323.3 6339.0 6392.7 16:18:04 INFO - PID 3785 | 16:18:04 INFO - PID 3785 | [#5] yui.html Cycles:180 Average:24645.04 Median:19416.90 stddev:35693.65 (183.8%) stddev-sans-first:35749.24 16:18:04 INFO - PID 3785 | Values: 897.0 902.7 921.9 922.4 925.4 19918.3 20497.6 20559.8 20586.3 20608.9 18234.5 18472.2 18569.7 18617.3 18638.9 945.8 950.8 953.2 958.7 963.8 949.2 954.7 954.8 956.9 990.1 1005.9 1022.0 1024.4 1028.4 1042.1 1025.2 1028.1 1028.3 1030.5 1045.0 738.7 739.7 744.6 745.9 753.5 19197.8 19636.0 19810.7 19860.7 19878.7 21267.5 21533.8 21598.4 21733.6 21930.3 17031.4 17133.7 17192.5 17199.1 17276.5 3679.3 3715.3 3719.1 3721.1 3763.2 128813.4 138634.0 138705.3 142916.7 143624.3 16948.2 17241.7 17320.1 17401.8 17579.6 30237.4 30251.8 30671.2 30873.2 30999.7 8836.5 8979.3 9005.5 9133.6 9177.1 4215.9 4291.7 4299.7 4331.3 4332.2 5391.0 5535.1 5543.3 5570.2 5570.9 1068.4 1093.4 1096.7 1100.0 1101.0 644.7 657.6 667.1 672.0 675.8 11902.6 11949.4 11959.2 12764.9 12918.5 628.6 636.9 645.3 645.6 648.2 5839.4 5841.8 5861.6 5888.3 5936.9 124544.4 125200.4 125642.0 126182.0 127856.0 108105.5 108216.0 111948.0 112281.0 114000.0 95274.5 95949.0 96195.0 98723.5 99733.0 10902.3 10904.6 10966.7 11010.2 11182.2 43588.0 44237.3 45399.1 45535.0 46789.5 54969.7 57841.8 57897.7 58750.0 60120.4 15855.0 15930.7 15984.3 16144.9 16261.6 18006.5 18023.2 18065.3 18136.8 18467.6 16110.4 16144.8 16249.1 16253.3 16302.3 16474.3 16670.5 16784.2 16862.7 17010.8 15040.8 15330.1 15353.1 15486.3 15747.7 11563.0 11746.6 11901.0 12030.3 12067.7 12120.4 12171.2 12182.5 12274.4 12400.4 16:18:04 INFO - PID 3785 | -------- Summary: end -------- 16:18:04 INFO - PID 3785 | 16:18:05 INFO - TEST-INFO | 3785: exit 0 16:18:05 INFO - TEST-OK | dromaeo_css | took 1114229ms 16:18:05 INFO - TEST-START | kraken 16:18:05 INFO - Initialising browser for kraken test... 16:18:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35193/getInfo.html -profile /tmp/tmpletYMq/profile 16:18:05 INFO - TEST-INFO | started process 4164 (/builds/slave/test/build/application/firefox/firefox http://localhost:35193/getInfo.html) 16:18:11 INFO - TEST-INFO | 4164: exit 0 16:18:11 INFO - Browser initialized. 16:18:11 INFO - Running cycle 1/1 for kraken test... 16:18:11 INFO - Using env: {'DISPLAY': ':0', 16:18:11 INFO - 'HOME': '/home/cltbld', 16:18:11 INFO - 'JSGC_DISABLE_POISONING': '1', 16:18:11 INFO - 'LANG': 'en_US.UTF-8', 16:18:11 INFO - 'LANGUAGE': 'en_US:en', 16:18:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:18:11 INFO - 'LOGNAME': 'cltbld', 16:18:11 INFO - 'MAIL': '/var/mail/cltbld', 16:18:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:18:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:18:11 INFO - 'MOZ_ACCELERATED': '1', 16:18:11 INFO - 'MOZ_CRASHREPORTER': '1', 16:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:18:11 INFO - 'MOZ_NO_REMOTE': '1', 16:18:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:18:11 INFO - 'MOZ_WEBRENDER': '1', 16:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:11 INFO - 'NO_EM_RESTART': '1', 16:18:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:11 INFO - 'PWD': '/builds/slave/test', 16:18:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:18:11 INFO - 'RUST_BACKTRACE': 'full', 16:18:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:18:11 INFO - 'SHELL': '/bin/bash', 16:18:11 INFO - 'SHLVL': '1', 16:18:11 INFO - 'TERM': 'linux', 16:18:11 INFO - 'TMOUT': '86400', 16:18:11 INFO - 'USER': 'cltbld', 16:18:11 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668', 16:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:11 INFO - '_': '/tools/buildbot/bin/python'} 16:18:11 INFO - TEST-INFO | started process 4408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpletYMq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:12 INFO - PID 4408 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:18:12 INFO - PID 4408 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:18:12 INFO - PID 4408 | 16:18:12 INFO - PID 4408 | (/builds/slave/test/build/application/firefox/firefox:4467): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:18:12 INFO - PID 4408 | 16:18:23 INFO - PID 4408 | RSS: Main: 188903424 16:18:23 INFO - PID 4408 | 16:18:26 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35193/tests/kraken/driver.html?testName=audio-beat-detection) 16:18:26 INFO - PID 4408 | RSS: Main: 190541824 16:18:26 INFO - PID 4408 | 16:18:29 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35193/tests/kraken/driver.html?testName=audio-dft) 16:18:30 INFO - PID 4408 | RSS: Main: 189759488 16:18:30 INFO - PID 4408 | 16:18:33 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35193/tests/kraken/driver.html?testName=audio-fft) 16:18:33 INFO - PID 4408 | RSS: Main: 186687488 16:18:33 INFO - PID 4408 | 16:18:36 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35193/tests/kraken/driver.html?testName=audio-oscillator) 16:18:36 INFO - PID 4408 | RSS: Main: 186757120 16:18:36 INFO - PID 4408 | 16:18:38 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35193/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:18:39 INFO - PID 4408 | RSS: Main: 188784640 16:18:39 INFO - PID 4408 | 16:18:42 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35193/tests/kraken/driver.html?testName=imaging-darkroom) 16:18:43 INFO - PID 4408 | RSS: Main: 191217664 16:18:43 INFO - PID 4408 | 16:18:47 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35193/tests/kraken/driver.html?testName=imaging-desaturate) 16:18:47 INFO - PID 4408 | RSS: Main: 190566400 16:18:47 INFO - PID 4408 | 16:18:50 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35193/tests/kraken/driver.html?testName=json-parse-financial) 16:18:51 INFO - PID 4408 | RSS: Main: 191647744 16:18:51 INFO - PID 4408 | 16:18:52 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35193/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:18:53 INFO - PID 4408 | RSS: Main: 190582784 16:18:53 INFO - PID 4408 | 16:18:55 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35193/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:18:55 INFO - PID 4408 | RSS: Main: 188125184 16:18:55 INFO - PID 4408 | 16:18:57 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35193/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:18:58 INFO - PID 4408 | RSS: Main: 187285504 16:18:58 INFO - PID 4408 | 16:19:01 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:01 INFO - PID 4408 | RSS: Main: 188100608 16:19:01 INFO - PID 4408 | 16:19:05 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:05 INFO - PID 4408 | RSS: Main: 188805120 16:19:05 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | Cycle 1(1): loaded http://localhost:35193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35193/tests/kraken/driver.html?testName=ai-astar) 16:19:07 INFO - PID 4408 | RSS: Main: 189075456 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | __start_tp_report 16:19:07 INFO - PID 4408 | _x_x_mozilla_page_load 16:19:07 INFO - PID 4408 | _x_x_mozilla_page_load_details 16:19:07 INFO - PID 4408 | |i|pagename|runs| 16:19:07 INFO - PID 4408 | |0;ai-astar;114;115;112;114;114;108;114;108;109;121 16:19:07 INFO - PID 4408 | |1;audio-beat-detection;116;117;129;130;118;125;142;119;144;195 16:19:07 INFO - PID 4408 | |2;audio-dft;162;165;172;162;167;175;174;166;165;162 16:19:07 INFO - PID 4408 | |3;audio-fft;77;81;77;84;73;75;75;73;75;80 16:19:07 INFO - PID 4408 | |4;audio-oscillator;88;86;89;78;81;80;78;78;83;80 16:19:07 INFO - PID 4408 | |5;imaging-gaussian-blur;110;117;115;113;116;111;116;114;118;115 16:19:07 INFO - PID 4408 | |6;imaging-darkroom;149;151;153;148;149;153;151;149;148;154 16:19:07 INFO - PID 4408 | |7;imaging-desaturate;100;95;94;96;95;94;94;94;95;96 16:19:07 INFO - PID 4408 | |8;json-parse-financial;55;58;56;66;53;54;55;56;53;53 16:19:07 INFO - PID 4408 | |9;json-stringify-tinderbox;43;50;38;45;43;44;38;38;37;43 16:19:07 INFO - PID 4408 | |10;stanford-crypto-aes;76;74;75;81;80;82;79;85;76;83 16:19:07 INFO - PID 4408 | |11;stanford-crypto-ccm;135;122;122;130;119;111;114;122;122;112 16:19:07 INFO - PID 4408 | |12;stanford-crypto-pbkdf2;166;167;170;170;181;179;167;168;176;166 16:19:07 INFO - PID 4408 | |13;stanford-crypto-sha256-iterative;70;66;67;68;65;70;66;67;65;67 16:19:07 INFO - PID 4408 | __end_tp_report 16:19:07 INFO - PID 4408 | __start_cc_report 16:19:07 INFO - PID 4408 | _x_x_mozilla_cycle_collect,769 16:19:07 INFO - PID 4408 | __end_cc_report 16:19:07 INFO - PID 4408 | __startTimestamp1505776747587__endTimestamp 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | ------- Summary: start ------- 16:19:07 INFO - PID 4408 | Number of tests: 14 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.93 (3.4%) stddev-sans-first:4.15 16:19:07 INFO - PID 4408 | Values: 114.0 115.0 112.0 114.0 114.0 108.0 114.0 108.0 109.0 121.0 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:129.50 stddev:23.80 (18.4%) stddev-sans-first:24.39 16:19:07 INFO - PID 4408 | Values: 116.0 117.0 129.0 130.0 118.0 125.0 142.0 119.0 144.0 195.0 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#2] audio-dft Cycles:10 Average:167.00 Median:166.50 stddev:4.97 (3.0%) stddev-sans-first:4.93 16:19:07 INFO - PID 4408 | Values: 162.0 165.0 172.0 162.0 167.0 175.0 174.0 166.0 165.0 162.0 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#3] audio-fft Cycles:10 Average:77.00 Median:77.00 stddev:3.62 (4.7%) stddev-sans-first:3.84 16:19:07 INFO - PID 4408 | Values: 77.0 81.0 77.0 84.0 73.0 75.0 75.0 73.0 75.0 80.0 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#4] audio-oscillator Cycles:10 Average:82.10 Median:82.00 stddev:4.20 (5.1%) stddev-sans-first:3.88 16:19:07 INFO - PID 4408 | Values: 88.0 86.0 89.0 78.0 81.0 80.0 78.0 78.0 83.0 80.0 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:115.50 stddev:2.55 (2.2%) stddev-sans-first:2.12 16:19:07 INFO - PID 4408 | Values: 110.0 117.0 115.0 113.0 116.0 111.0 116.0 114.0 118.0 115.0 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:2.22 (1.5%) stddev-sans-first:2.29 16:19:07 INFO - PID 4408 | Values: 149.0 151.0 153.0 148.0 149.0 153.0 151.0 149.0 148.0 154.0 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.83 (1.9%) stddev-sans-first:0.83 16:19:07 INFO - PID 4408 | Values: 100.0 95.0 94.0 96.0 95.0 94.0 94.0 94.0 95.0 96.0 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:3.90 (7.0%) stddev-sans-first:4.12 16:19:07 INFO - PID 4408 | Values: 55.0 58.0 56.0 66.0 53.0 54.0 55.0 56.0 53.0 53.0 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#9] json-stringify-tinderbox Cycles:10 Average:41.90 Median:43.00 stddev:4.12 (9.6%) stddev-sans-first:4.35 16:19:07 INFO - PID 4408 | Values: 43.0 50.0 38.0 45.0 43.0 44.0 38.0 38.0 37.0 43.0 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:80.50 stddev:3.73 (4.6%) stddev-sans-first:3.78 16:19:07 INFO - PID 4408 | Values: 76.0 74.0 75.0 81.0 80.0 82.0 79.0 85.0 76.0 83.0 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:122.00 stddev:7.56 (6.2%) stddev-sans-first:6.06 16:19:07 INFO - PID 4408 | Values: 135.0 122.0 122.0 130.0 119.0 111.0 114.0 122.0 122.0 112.0 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:170.00 stddev:5.60 (3.3%) stddev-sans-first:5.64 16:19:07 INFO - PID 4408 | Values: 166.0 167.0 170.0 170.0 181.0 179.0 167.0 168.0 176.0 166.0 16:19:07 INFO - PID 4408 | 16:19:07 INFO - PID 4408 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.79 (2.7%) stddev-sans-first:1.56 16:19:07 INFO - PID 4408 | Values: 70.0 66.0 67.0 68.0 65.0 70.0 66.0 67.0 65.0 67.0 16:19:07 INFO - PID 4408 | -------- Summary: end -------- 16:19:07 INFO - PID 4408 | 16:19:08 INFO - PID 4408 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:19:08 INFO - TEST-INFO | 4408: exit 0 16:19:08 INFO - TEST-OK | kraken | took 62794ms 16:19:08 INFO - SUITE-END | took 1177s 16:19:08 INFO - Completed test suite (00:19:37) 16:19:08 INFO - javascript benchmark 16:19:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8552.662795162, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3115.2056225662454, 3120.0639808057585, 3120.8595613197417, 3180.252640629452, 3192.521121831725, 6307.684615769211, 6317.0208617664275, 6323.525735569828, 6348.428641422271, 6361.491080713543, 6143.109249158881, 6191.411815877495, 6208.875822483547, 6218.22272215973, 6232.937670623292, 5695.77216911323, 5739.282589676291, 5757.510611597998, 5792.478676919077, 5811.883762324751, 5800.622959507639, 5805.709714514279, 5885.0, 5901.881962360751, 5959.0, 5800.796972105977, 5858.648481091127, 5859.355470898197, 5903.675297858616, 5909.586328956974, 5567.47109024642, 5665.2351932489, 5665.745041473102, 5841.970790146022, 5859.619124756877, 5199.818006369759, 5709.714514274311, 5758.942410575924, 5790.13148027795, 5822.068469044975, 6291.937080629181, 6310.400511951358, 6354.491640668735, 6363.713632886485, 6374.394432528902, 6573.506986975996, 6578.76974305897, 6659.167604049494, 6766.627835469048, 6766.7969960901255, 6573.57271777333, 6806.659667016679, 6882.03651488792, 6885.380315771605, 6892.207396149457, 6226.719797609118, 6227.314995350508, 6237.844053898643, 6242.375762423767, 6287.088372186007, 6943.097397338313, 6948.096747422803, 6962.547434416747, 7010.824729381704, 7030.507864449542, 6628.0, 6644.0, 6687.732490700415, 6701.430378417889, 6709.597424154566, 6563.803085907431, 6607.933920660828, 6663.966680166665, 6722.462203023746, 6831.555948863308, 6734.629595372302, 6738.528303018839, 6759.053732477457, 6773.221079575814, 6773.762918297836, 6689.9965005249605, 6706.631135287508, 6792.864142717118, 6809.829754256183, 6816.284290149463, 5172.741362931838, 5209.843704688866, 5294.549963253166, 5323.707196104174, 5324.1747529133045, 4454.5990860822685, 4530.977345113253, 4610.515895830889, 4691.7184968901975, 4692.4603670577635, 5733.827985160452, 5786.826395208151, 5797.913031304533, 5840.561957853178, 5861.0, 6726.428253598499, 6780.355866192704, 6782.966085169543, 6802.047713320139, 6875.796735571255, 5775.5090817281, 5814.59297849155, 5868.911966320508, 5874.206982057453, 5887.470127688529, 5634.295713035871, 5693.68684722336, 5704.34400043992, 5714.114312281603, 5780.971095144498, 6533.020046992989, 6617.7683781067435, 6620.8344791380605, 6623.834404139839, 6624.304448032984, 6699.866002680016, 6726.529142960141, 6736.393724564813, 6799.252082270947, 6869.519133660596, 6485.3514648534765, 6497.8700425992165, 6594.670266486561, 6599.208095028627, 6609.041688954979, 6461.547691661539, 6548.050532672641, 6549.181352330958, 6682.131322927989, 6685.364890335411, 6766.661666916733, 6799.184097908283, 6826.658667066726, 6845.212800528003, 6872.244053154249, 6450.548461607643, 6509.576877502947, 6578.04618330349, 6603.966980165068, 6613.272540020497, 6346.174997250328, 6400.1679781629955, 6525.314841941527, 6529.934700652932, 6639.236487803964, 6435.388638079375, 6501.902471462838, 6507.609543427409, 6520.739170433129, 6530.151080359523, 6548.508861835287, 6631.403173714389, 6665.800025999228, 6704.463642908653, 6712.463002959654, 6394.136791533084, 6406.487481001415, 6459.9031014533875, 6489.8702025960165, 6491.967540162269], "value": 6136.712019394694, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [852.6163226548055, 862.6894318045503, 865.0, 867.496851825941, 889.5329951775317, 39875.40186897195, 41203.0, 41319.58680413203, 41346.37980430296, 41415.79292103543, 37346.0, 37830.621693783054, 41298.174036519325, 41776.164476710444, 41940.37089443661, 7677.155512893577, 7810.453268271223, 7835.764927052198, 7845.411594130434, 7850.803729906741, 7559.0, 7752.573608451533, 7768.611569421535, 7768.65041073153, 7789.987301650777, 7738.18749031352, 7791.298783109519, 7813.609319534029, 7820.491668041587, 7851.175626559215, 7691.23087691232, 7748.108967468757, 7750.922490775077, 7760.107587627439, 7767.262110099559, 7614.124375696811, 7661.961690191569, 7685.154632990367, 7693.346065584432, 7703.114141873701, 37343.8132809337, 37813.621863781285, 37850.43224351637, 37862.62137378618, 37954.81022594869, 3495.8252087395526, 3549.6095429502734, 3551.964480355189, 3554.306910152521, 3556.413191823346, 31244.37511249785, 31344.52983205231, 31382.843085784654, 31414.842925785455, 31495.37009259802, 4977.129002424597, 5171.586273098181, 5184.766685499124, 5196.714180720059, 5226.111561034595, 183294.0, 184939.0, 185216.0, 185873.0, 185899.07050464797, 46315.30527042097, 46473.30290045652, 47032.5296747035, 47037.29444058342, 47079.0, 48586.0, 48724.756376218604, 53423.0, 54615.45384546183, 54952.0, 15969.281382337822, 16085.0, 16107.355705771872, 16215.10816905058, 16241.2691428886, 13400.932995335155, 13436.126651767603, 13438.193708377334, 13441.663958400923, 13461.798073028913, 14160.716785664228, 14166.150030998173, 14249.358778854976, 14260.42958281657, 14290.42838286457, 5687.0663974248955, 5700.401457846866, 5721.599488035798, 5760.0, 5802.767889284466, 988.7775250568565, 997.7405874472544, 1002.1682003936716, 1003.4832061488339, 1031.896810318962, 22908.770912291, 23031.654525182137, 23285.7671423287, 23394.532109358057, 23544.058237670644, 1096.4037955505953, 1108.2906939558527, 1108.4457771114444, 1111.5442668506034, 1117.536222467667, 12168.878311216775, 12212.511499539918, 12232.510699572096, 12339.197952133083, 12449.25304481734, 238149.0, 239204.0, 239923.0, 239947.0, 240584.0, 42465.36301955473, 43242.56757432449, 49908.75045624821, 50510.74744626253, 50753.238701419505, 1378.7862881253423, 1438.1946110178333, 1442.6177063078292, 1446.3997441062052, 1448.898577099614, 26728.0, 26742.0, 26772.59841102424, 26888.59667105034, 27089.72910270872, 35285.823570881985, 35350.29299414049, 35531.644683553866, 35533.82233088921, 35685.28629427449, 181297.0, 181846.0907695453, 182233.0, 183259.0, 184055.0, 33925.83037084799, 34040.48939265864, 34064.65935340714, 34107.31785364328, 34232.14419639529, 41103.58896410998, 42255.366169506866, 42402.36396453994, 42834.0, 43438.13123737571, 29281.70718292875, 30544.847275763477, 30724.846375768873, 30961.535576966813, 31284.374312513166, 30524.389512210077, 30540.694593054675, 30551.0, 30603.54094688537, 30734.385312293183, 35322.0, 35327.0, 35415.0, 35470.64529354673, 35566.11084722799, 30328.696713032587, 30775.538366924065, 31132.37735245237, 31229.063128106194, 31402.21494462565, 22735.0, 23089.88455057714, 23279.76720232776, 23386.64920026167, 23419.180328688413], "value": 17033.33351244815, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.8044644151327, 560.3807792389412, 565.1466285908278, 578.9073748200288, 593.6467801658014, 21595.35213943582, 22432.66351004732, 22540.32379028628, 22571.999999999978, 22608.321750347495, 23691.881540592316, 24281.75718242817, 24541.63187552188, 25266.747332526716, 25493.36266593336, 6456.967715161418, 6496.805095847132, 6561.3438656134485, 6568.934310656904, 6574.0, 6394.6482943438095, 6491.156149700556, 6495.31799161086, 6499.220093588776, 6513.120728701636, 6180.814575562717, 6442.613443193423, 6447.516436267299, 6448.065030570565, 6451.129097571838, 6458.5479016468635, 6465.094886715863, 6533.673316334164, 6539.215294164707, 6543.116679248288, 5997.4002599740115, 6043.516518678495, 6053.878922421571, 6057.939420605826, 6062.514998800129, 27917.860410697816, 28142.718572814214, 28963.420731585462, 28979.710202898124, 29726.554101688493, 2047.8771273723623, 2070.4616799632204, 2079.5009197792574, 2087.09211493001, 2103.137713537458, 18208.90895545514, 18789.90605046966, 18885.527861803428, 19011.429657110308, 19018.71471927922, 2395.0792009144875, 2396.5566370221563, 2432.525657496789, 2435.2694191742407, 2480.0, 117733.0, 122725.38637306845, 123601.38199309036, 131289.34355328162, 138926.0, 20709.68935465969, 21203.78796212049, 22024.559508809733, 22031.567948083324, 22639.660405093935, 42342.36486452706, 42362.364564531556, 42548.36177457341, 42564.0, 42744.57255427468, 11561.07511399086, 11584.42077896102, 11709.531618735326, 11784.823227651592, 11828.645140645795, 9931.453770042572, 9947.104760571583, 10018.949905250427, 10045.69862904114, 10228.897711022943, 10758.300710453796, 11099.334039957628, 11135.0, 11271.774564508827, 11569.595064172714, 3839.155385815116, 4045.6358927696647, 4063.0, 4188.874333769992, 4216.852410165629, 962.259060523393, 973.3673112476947, 982.2682101834037, 983.9704808855746, 994.5773046455228, 19070.90464547696, 19220.231190752493, 19260.422187334403, 19640.70538941917, 20058.997050147434, 990.5096976996433, 1029.8352263637782, 1032.390889375272, 1035.2701345551368, 1039.0285083447002, 10811.945940270405, 10897.727556811144, 10914.290571112851, 11120.054795342325, 11170.050545703707, 432078.0, 450805.0, 456852.0, 463884.0, 471245.0, 107743.46128269465, 108263.0, 109125.0, 109153.45423272991, 110147.0, 1112.260346869339, 1124.4995976790412, 1128.8758236593967, 1143.8684551276542, 1150.5742875136252, 17388.565285867953, 17427.82572174262, 17439.651206975537, 17944.0, 17946.91026544859, 52909.0, 53478.0, 53863.192052118466, 54200.186997195866, 54853.0, 65958.0, 66236.66881665561, 66324.6683766578, 66588.33411665821, 66747.0, 19568.80431195727, 19680.507987299858, 19772.90113549423, 19799.208031679147, 20148.697769533763, 22037.779622204213, 22074.33776986693, 22178.0, 22324.21865234709, 22562.661560076285, 17423.56441088983, 17532.0, 18028.54928626795, 18073.36743213981, 18122.637547249244, 14946.327415266556, 14962.0, 14974.0, 15342.15618141013, 15489.380424782883, 16462.917685411496, 16548.0, 16565.42021029258, 16586.58533536671, 17731.290748370437, 17983.10084495796, 18114.456566303033, 18254.0, 18281.0, 18357.632847342713, 16455.177241137655, 16485.093319867523, 16492.587685307964, 16495.092769897772, 17597.384091556734], "value": 12444.60222665949, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.6996925691722, 1386.0477183598932, 1403.0459287684378, 1407.774756039034, 1408.4718230663502, 14702.485413010547, 15203.391864325427, 15213.695726085472, 15230.695386092271, 15358.155301458415, 14809.11145331281, 14867.776983345231, 14968.476103336385, 14982.101073935572, 14992.700145997102, 2657.269250955993, 2747.1346525844397, 2748.5877118432195, 2749.230215539652, 2749.3676454415495, 2567.3453269416273, 2643.8017148713925, 2684.302081458825, 2693.636359091527, 2706.3640044589506, 2240.955180896381, 2352.7059117610297, 2356.2813341930705, 2707.6344693466426, 2811.12855014945, 2788.2053614719807, 2795.622590950216, 2797.9860100699366, 2800.2999250187454, 2808.283887608657, 2707.1201859395774, 2733.3439974406197, 2734.6855111662217, 2738.123800383878, 2740.4245108527234, 14620.634484137876, 14692.779608305884, 14749.115053096848, 14878.256087195598, 14921.925390373088, 7849.4897831640765, 8189.918100818975, 8198.344132469389, 8218.096009439018, 8233.46482478637, 5186.273921650972, 5436.429174936614, 5607.327120745495, 5673.943260567424, 5687.772489100431, 1622.594351412147, 1907.294301108585, 1935.3032908153054, 1952.4825921130912, 1961.6076784643128, 23837.7616223839, 25279.87360063206, 25878.87060564685, 25924.0, 26039.088631897794, 7315.0, 7398.149212840484, 7401.33387995083, 7507.436942229246, 7572.258380572499, 19798.109085091204, 19828.60342793136, 19829.30597429083, 19842.60314793696, 19867.105980230925, 8339.166083391612, 8392.580370981426, 8507.532085735344, 8526.0, 8528.104549022264, 7487.625618719042, 7505.774826755206, 7533.54798712079, 7562.978997835332, 7579.279968402993, 5570.832875013756, 5728.283964504437, 5765.827025189251, 5789.392113828072, 6026.0, 1800.9279628814963, 1822.180018991459, 1828.8994105324334, 1852.8599467614927, 1869.3924474545554, 900.5452246615548, 902.3908861518448, 906.9682561110329, 915.9313051521162, 920.8710780490736, 7392.186859445456, 7466.738664146837, 7524.699012039567, 7536.171021187665, 7614.35278001365, 729.4128226777495, 731.3637135691876, 731.4550659758407, 734.071399679406, 739.7115125101108, 4645.349651048856, 4666.95333046672, 4675.509071547506, 4727.669063165614, 4729.5743383095, 20276.18895244174, 21147.47131321729, 21317.68023479649, 21320.0, 21362.679559806616, 20040.298589549588, 20791.272305469236, 20802.791972080387, 20819.687704684442, 21015.684764728543, 9484.952575237217, 9808.558614862348, 10932.726681833177, 11312.886871131182, 11382.373969431595, 8970.37207395476, 9006.459612423276, 9044.547772611475, 9090.0, 9236.861447078434, 17771.644567108844, 18078.728819067986, 18180.909095454437, 18445.723314150568, 18481.72277415813, 18698.252069917595, 19095.427137185907, 19254.0, 19258.325958591384, 20027.0, 11537.0, 11644.184907056424, 11652.417379131179, 11659.53361865516, 11857.288562686266, 13218.140820846998, 13340.19958802475, 13346.599602011955, 13348.93325533366, 13363.53227637028, 11197.88802112001, 11205.775884482428, 11438.771224575628, 11472.426378680866, 11545.134114941246, 10881.0, 11019.779604408028, 11289.71775705614, 11342.886571134182, 11355.37545435009, 9872.605095796374, 9889.950550247202, 9984.450855203033, 9988.550515226978, 10010.149137323118, 6934.826629334307, 6945.68744406513, 6976.302369762983, 7005.334493223339, 7104.822379440348, 7215.314545118205, 7487.850242995, 7579.848403032019, 7582.848343032998, 7602.391808655405], "value": 6677.991621445222, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.83194189305596, 501.53495569277015, 527.7915223486721, 527.9392869819972, 530.4907786171409, 6262.874742505152, 6295.874082518347, 6299.77950771723, 6310.432061114493, 6390.3929126733, 6234.501239900808, 6240.219972503437, 6252.437280644741, 6257.780977665782, 6262.3111457739615, 5143.485651434864, 5201.0756020272365, 5217.426083130853, 5233.4243233244315, 5233.842984710464, 5166.974165129169, 5219.0, 5233.502817232356, 5238.345206849125, 5266.104762190418, 4662.930056049162, 4915.9754201229125, 4952.232403977371, 4952.232403977389, 5076.477056882939, 4870.756462176894, 4890.388701412324, 4910.950890491103, 4930.630202734809, 4949.331840201598, 4294.957050429487, 4389.495208051083, 4399.208142534342, 4422.137683151786, 4425.7565833879125, 5969.820905372846, 6005.249343832021, 6009.248843894513, 6029.246344206974, 6105.786297479612, 5614.6631202128, 5624.409437009137, 5628.465295796893, 5639.718014099279, 5649.152627105926, 6333.524985626051, 6427.58220715652, 6459.67701614922, 6480.902786458207, 6501.284858665543, 4545.613622842063, 4804.711717296974, 4829.589484893788, 4864.343313652647, 4876.341693871317, 6570.817252894477, 6659.0, 6769.1876974763345, 6798.966005170041, 6799.252082270947, 4820.975895120502, 4849.781759820817, 4853.490383509751, 4857.854264372075, 4863.781129849165, 4935.111679897653, 4936.136176169156, 4940.209566469348, 4947.529984651453, 4965.988774546315, 5570.916436253459, 5626.381098079208, 5632.493075623213, 5641.9435805641415, 5650.208970744099, 6503.479721622353, 6549.836254093686, 6569.6058236505005, 6574.605523668595, 6603.570767900071, 1732.12064909572, 1733.8699597530235, 1736.5571779196225, 1751.6584266068248, 1755.95520665204, 1138.3056335635256, 1196.4795314038422, 1198.844150260478, 1210.3464129370218, 1215.8844909733562, 5568.693721845257, 5569.916451253234, 5596.3284405870745, 5652.491275785199, 5669.886602267931, 6414.775482858077, 6485.805425837232, 6489.480841532761, 6527.0, 6553.0, 5618.578606604439, 5632.183333416713, 5652.236948012048, 5657.0, 5692.943070569241, 3458.2737625098507, 3472.652734726558, 3483.8432270547887, 3516.226430185355, 3530.382183117944, 6329.588576742497, 6396.1045453636525, 6441.838954026093, 6448.774292899726, 6451.548391612542, 6693.866122677617, 6746.494012949049, 6775.695093720795, 6814.62519561419, 6849.0, 6260.280067792262, 6282.685865706696, 6318.704665543461, 6345.809625711236, 6355.205599300088, 6055.364186760503, 6536.738530458919, 6541.70562324687, 6578.5395022347975, 6641.966790166019, 6408.0, 6432.35676432353, 6460.547761656639, 6484.448821850006, 6502.804915852532, 6121.204243448323, 6242.937570624235, 6345.96827015862, 6397.232332119989, 6524.804255872332, 4885.145099607484, 4962.412028150957, 4968.503149685002, 4985.3020577118505, 5005.174146265826, 6394.648294343856, 6619.900701489578, 6660.400563949268, 6728.596284222962, 6736.989451582302, 6286.874262514815, 6353.506925872324, 6420.775272865428, 6489.156409666713, 6511.967440162769, 6311.0, 6423.132877061536, 6426.967865160831, 6450.322716114741, 6453.677316134268, 6289.811305660837, 6325.462335701517, 6334.778282760081, 6341.0, 6383.521235907233, 6421.325760795236, 6439.0, 6459.6770161490795, 6476.481881449378, 6499.050284914412, 6252.781152659635, 6254.2800729799665, 6323.272823625158, 6338.968305158444, 6392.712327945346], "value": 4992.864737865032, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.9596368163433, 902.6840605787979, 921.8985911549725, 922.4188761080518, 925.3984909808626, 19918.302859399922, 20497.59004819903, 20559.794402055995, 20586.279480218196, 20608.89695551522, 18234.452966410994, 18472.16875240614, 18569.721454178165, 18617.348392806256, 18638.906805465987, 945.7541039329755, 950.8098380323928, 953.1802649721234, 958.7123862841155, 963.8072385522888, 949.2074118111351, 954.7326748510428, 954.7947191353858, 956.8612551180074, 990.1484723138095, 1005.8692369991927, 1021.9591216351374, 1024.359775140537, 1028.4189432970347, 1042.072555425668, 1025.2054657640315, 1028.0644613401769, 1028.3264461777474, 1030.464158637508, 1044.984325235122, 738.7488253993668, 739.6856336057208, 744.6351287868905, 745.9291367320096, 753.461275188243, 19197.80802191974, 19636.0, 19810.70283945742, 19860.70208946867, 19878.70181947272, 21267.46831329214, 21533.784662153335, 21598.35204943854, 21733.565328693494, 21930.342089737333, 17031.403900863534, 17133.657326853518, 17192.484225473258, 17199.054052027135, 17276.481705548853, 3679.300932822755, 3715.294094122108, 3719.1260053887586, 3721.14413684854, 3763.2473505298776, 128813.35593322066, 138634.0, 138705.306473468, 142916.71249862522, 143624.28187858994, 16948.23732932021, 17241.741373879402, 17320.133993300286, 17401.82598174002, 17579.64840703179, 30237.395252094833, 30251.848740756155, 30671.2332191697, 30873.228169295948, 30999.69000309968, 8836.513991730517, 8979.281657467518, 9005.549722513979, 9133.588988495534, 9177.128172823572, 4215.915681686411, 4291.699581029298, 4299.699021068495, 4331.328644060176, 4332.155229730235, 5390.97304513475, 5535.114381698909, 5543.334799824047, 5570.2201691762375, 5570.860728481739, 1068.4070340960686, 1093.4314156638504, 1096.6874440784338, 1099.999000909169, 1101.031092638473, 644.7195469970484, 657.6087228099274, 667.1493845347125, 671.9596824190564, 675.8073948924533, 11902.642920712393, 11949.402529873472, 11959.222650527689, 12764.872351276368, 12918.483260669467, 628.6291088257858, 636.9044643303541, 645.3159650770199, 645.56101850741, 648.1832890557931, 5839.357670656224, 5841.766329346779, 5861.6189947653265, 5888.263967004124, 5936.9406305937255, 124544.37727811302, 125200.37399812942, 125642.0, 126182.0, 127856.0, 108105.45947270213, 108216.0, 111948.0, 112281.0, 114000.0, 95274.5236273828, 95948.9999999986, 96195.0, 98723.50638246906, 99733.00266997382, 10902.291351062155, 10904.618338358438, 10966.670999870017, 11010.174236932422, 11182.161337899854, 43588.0, 44237.33643995407, 45399.09201816011, 45535.0, 46789.53210467852, 54969.725151375584, 57841.843163137346, 57897.71051144717, 58750.0, 60120.39879601148, 15855.0, 15930.681386371976, 15984.280707367963, 16144.919275403548, 16261.59346016359, 18006.549836253675, 18023.188956496728, 18065.2773889043, 18136.81863181404, 18467.630647387246, 16110.436134735228, 16144.757828632815, 16249.10629915366, 16253.268602912662, 16302.266398012354, 16474.341026358812, 16670.499885003468, 16784.24470898788, 16862.66274674524, 17010.829891700923, 15040.849591503946, 15330.080195188324, 15353.07881527112, 15486.303116360015, 15747.68504629878, 11563.0, 11746.647600571996, 11900.988415984739, 12030.27818330903, 12067.698307542381, 12120.393980300772, 12171.208871423329, 12182.512699491921, 12274.386280686109, 12400.441980110736], "value": 9023.382791428452, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1468.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 112.0, 114.0, 114.0, 108.0, 114.0, 108.0, 109.0, 121.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 129.0, 130.0, 118.0, 125.0, 142.0, 119.0, 144.0, 195.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 172.0, 162.0, 167.0, 175.0, 174.0, 166.0, 165.0, 162.0], "value": 167.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 77.0, 84.0, 73.0, 75.0, 75.0, 73.0, 75.0, 80.0], "value": 77.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 78.0, 81.0, 80.0, 78.0, 78.0, 83.0, 80.0], "value": 82.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 117.0, 115.0, 113.0, 116.0, 111.0, 116.0, 114.0, 118.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 153.0, 148.0, 149.0, 153.0, 151.0, 149.0, 148.0, 154.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 94.0, 96.0, 95.0, 94.0, 94.0, 94.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 56.0, 66.0, 53.0, 54.0, 55.0, 56.0, 53.0, 53.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 50.0, 38.0, 45.0, 43.0, 44.0, 38.0, 38.0, 37.0, 43.0], "value": 41.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 81.0, 80.0, 82.0, 79.0, 85.0, 76.0, 83.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 122.0, 122.0, 130.0, 119.0, 111.0, 114.0, 122.0, 122.0, 112.0], "value": 120.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 170.0, 170.0, 181.0, 179.0, 167.0, 168.0, 176.0, 166.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 67.0, 68.0, 65.0, 70.0, 66.0, 67.0, 65.0, 67.0], "value": 67.1, "unit": "score"}]}]} 16:19:08 INFO - Return code: 0 16:19:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:19:08 INFO - # TBPL SUCCESS # 16:19:08 INFO - Running post-action listener: _package_coverage_data 16:19:08 INFO - Running post-action listener: _resource_record_post_action 16:19:08 INFO - [mozharness: 2017-09-18 23:19:08.873118Z] Finished run-tests step (success) 16:19:08 INFO - Running post-run listener: _resource_record_post_run 16:19:08 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 14229504; Write bytes: 415182848; Read time: 5524; Write time: 267968 16:19:08 INFO - TinderboxPrint: CPU usage
13.3% 16:19:08 INFO - TinderboxPrint: I/O read bytes / time
14,229,504 / 5,524 16:19:08 INFO - TinderboxPrint: I/O write bytes / time
415,182,848 / 267,968 16:19:08 INFO - TinderboxPrint: CPU idle
8,257.6 (86.7%) 16:19:08 INFO - TinderboxPrint: CPU user
1,200.0 (12.6%) 16:19:08 INFO - TinderboxPrint: Swap in / out
0 / 0 16:19:08 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 142237696; Read time: 0; Write time: 116032 16:19:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:19:08 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 11866112; Write bytes: 272945152; Read time: 4956; Write time: 151936 16:19:09 INFO - Running post-run listener: _upload_blobber_files 16:19:09 INFO - Blob upload gear active. 16:19:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:19:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:19:09 INFO - (blobuploader) - INFO - Open directory for files ... 16:19:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:19:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:19:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:13 INFO - (blobuploader) - INFO - Done attempting. 16:19:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:19:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:19:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:14 INFO - (blobuploader) - INFO - Done attempting. 16:19:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:19:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:19:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:15 INFO - (blobuploader) - INFO - Done attempting. 16:19:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:19:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:19:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:16 INFO - (blobuploader) - INFO - Done attempting. 16:19:16 INFO - (blobuploader) - INFO - Iteration through files over. 16:19:16 INFO - Return code: 0 16:19:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:19:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:19:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d43b8ed336d9c5ce0a873ca13a57b242c596528134c8152cbfe736718aa6813e3dbba0d5ac8d4a00670640dd8807e0205e3a8ba26355a549fd63699f914315", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68b8b580000aa164557d9495d7859afa50878d5caf9f89321bb060be807a23d3faad2193ed1550a248fce26a55020b544e87164d84f7be4b9321825a14003224", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf0fb307abbc38c4cd3e18aa78d3e2d499e2b84394d75018b4719c6ecd9440f820d371bb45f46ad6eab19f495a21ca700ea0108092fa4c876e32baf00bba3d8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8035982845dc2414f06767e44bf5ec145da52acce160f82c755435de9d65697e886bc8b77b24a5c703e8eaa0d0e14342493920a9b4b12506da073047c02de982"} 16:19:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:19:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:19:16 INFO - Contents: 16:19:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d43b8ed336d9c5ce0a873ca13a57b242c596528134c8152cbfe736718aa6813e3dbba0d5ac8d4a00670640dd8807e0205e3a8ba26355a549fd63699f914315", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68b8b580000aa164557d9495d7859afa50878d5caf9f89321bb060be807a23d3faad2193ed1550a248fce26a55020b544e87164d84f7be4b9321825a14003224", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf0fb307abbc38c4cd3e18aa78d3e2d499e2b84394d75018b4719c6ecd9440f820d371bb45f46ad6eab19f495a21ca700ea0108092fa4c876e32baf00bba3d8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8035982845dc2414f06767e44bf5ec145da52acce160f82c755435de9d65697e886bc8b77b24a5c703e8eaa0d0e14342493920a9b4b12506da073047c02de982"} 16:19:16 INFO - Running post-run listener: copy_logs_to_upload_dir 16:19:16 INFO - Copying logs to upload dir... 16:19:16 INFO - mkdir: /builds/slave/test/build/upload/logs 16:19:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.356267 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-18 16:19:17.114234) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 16:19:17.121654) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d43b8ed336d9c5ce0a873ca13a57b242c596528134c8152cbfe736718aa6813e3dbba0d5ac8d4a00670640dd8807e0205e3a8ba26355a549fd63699f914315", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68b8b580000aa164557d9495d7859afa50878d5caf9f89321bb060be807a23d3faad2193ed1550a248fce26a55020b544e87164d84f7be4b9321825a14003224", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf0fb307abbc38c4cd3e18aa78d3e2d499e2b84394d75018b4719c6ecd9440f820d371bb45f46ad6eab19f495a21ca700ea0108092fa4c876e32baf00bba3d8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8035982845dc2414f06767e44bf5ec145da52acce160f82c755435de9d65697e886bc8b77b24a5c703e8eaa0d0e14342493920a9b4b12506da073047c02de982"} build_url:https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d43b8ed336d9c5ce0a873ca13a57b242c596528134c8152cbfe736718aa6813e3dbba0d5ac8d4a00670640dd8807e0205e3a8ba26355a549fd63699f914315", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68b8b580000aa164557d9495d7859afa50878d5caf9f89321bb060be807a23d3faad2193ed1550a248fce26a55020b544e87164d84f7be4b9321825a14003224", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf0fb307abbc38c4cd3e18aa78d3e2d499e2b84394d75018b4719c6ecd9440f820d371bb45f46ad6eab19f495a21ca700ea0108092fa4c876e32baf00bba3d8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8035982845dc2414f06767e44bf5ec145da52acce160f82c755435de9d65697e886bc8b77b24a5c703e8eaa0d0e14342493920a9b4b12506da073047c02de982"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 16:19:17.151853) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:19:17.152147) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1505775217.691236-149806668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:19:17.200930) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 16:19:17.201213) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 16:19:17.204502) ========= ========= Total master_lag: 0.32 =========