builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-085 starttime: 1506292465.65 results: success (0) revision: ca9795c9066e8a8ea06157428b7d3e07482e5338 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:25.646070) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:25.646499) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:25.646784) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:25.677864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:25.678172) ========= 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=5c37b704b588aaa989324530000001d0-1506289715.981900-657334355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-24 15:34: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% 98.9M=0s 2017-09-24 15:34:25 (98.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.212753 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:25.957339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:25.959927) ========= 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=5c37b704b588aaa989324530000001d0-1506289715.981900-657334355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019726 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:26.019003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:26.019322) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ca9795c9066e8a8ea06157428b7d3e07482e5338 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ca9795c9066e8a8ea06157428b7d3e07482e5338 --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=5c37b704b588aaa989324530000001d0-1506289715.981900-657334355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-24 15:34:25,993 truncating revision to first 12 chars 2017-09-24 15:34:25,993 Setting DEBUG logging. 2017-09-24 15:34:25,993 attempt 1/10 2017-09-24 15:34:25,993 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ca9795c9066e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-24 15:34:26,628 unpacking tar archive at: mozilla-beta-ca9795c9066e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.906944 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:26.946470) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:26.949824) ========= script_repo_revision: ca9795c9066e8a8ea06157428b7d3e07482e5338 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:26.950177) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:26.950494) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 15:34:26.978691) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-24 15:34:26.978947) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1506289715.981900-657334355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:34:27 INFO - MultiFileLogger online at 20170924 15:34:27 in /builds/slave/test 15:34:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 15:34:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:34:27 INFO - {'append_to_log': False, 15:34:27 INFO - 'base_work_dir': '/builds/slave/test', 15:34:27 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 15:34:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:34:27 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 15:34:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:34:27 INFO - 'code_coverage': False, 15:34:27 INFO - 'config_files': ('talos/linux_config.py',), 15:34:27 INFO - 'default_actions': ('clobber', 15:34:27 INFO - 'read-buildbot-config', 15:34:27 INFO - 'download-and-extract', 15:34:27 INFO - 'populate-webroot', 15:34:27 INFO - 'create-virtualenv', 15:34:27 INFO - 'install', 15:34:27 INFO - 'setup-mitmproxy', 15:34:27 INFO - 'run-tests'), 15:34:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:34:27 INFO - 'disable_ccov_upload': False, 15:34:27 INFO - 'disable_stylo': False, 15:34:27 INFO - 'download_minidump_stackwalk': True, 15:34:27 INFO - 'download_symbols': 'ondemand', 15:34:27 INFO - 'enable_stylo': False, 15:34:27 INFO - 'enable_webrender': False, 15:34:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:34:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:34:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:34:27 INFO - 'gecko_profile': False, 15:34:27 INFO - 'gecko_profile_interval': 0, 15:34:27 INFO - 'installer_path': 'installer.exe', 15:34:27 INFO - 'log_level': 'info', 15:34:27 INFO - 'log_name': 'talos', 15:34:27 INFO - 'log_to_console': True, 15:34:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:34:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:34:27 INFO - 'opt_config_files': (), 15:34:27 INFO - 'pip_index': False, 15:34:27 INFO - 'suite': 'dromaeojs-e10s', 15:34:27 INFO - 'system_bits': '32', 15:34:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:34:27 INFO - 'title': 'talos-linux64-ix-085', 15:34:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:34:27 INFO - 'use_talos_json': True, 15:34:27 INFO - 'verify': 'False', 15:34:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:34:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:34:27 INFO - 'work_dir': 'build'} 15:34:27 INFO - [mozharness: 2017-09-24 22:34:27.176535Z] Running clobber step. 15:34:27 INFO - Running pre-action listener: _resource_record_pre_action 15:34:27 INFO - Running main action method: clobber 15:34:27 INFO - rmtree: /builds/slave/test/build 15:34:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:34:28 INFO - Running post-action listener: _resource_record_post_action 15:34:28 INFO - [mozharness: 2017-09-24 22:34:28.147513Z] Finished clobber step (success) 15:34:28 INFO - [mozharness: 2017-09-24 22:34:28.147612Z] Running read-buildbot-config step. 15:34:28 INFO - Running pre-action listener: _resource_record_pre_action 15:34:28 INFO - Running main action method: read_buildbot_config 15:34:28 INFO - Using buildbot properties: 15:34:28 INFO - { 15:34:28 INFO - "project": "", 15:34:28 INFO - "product": "firefox", 15:34:28 INFO - "who": "ryanvm@gmail.com", 15:34:28 INFO - "installer_path": "public/build/target.tar.bz2", 15:34:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 15:34:28 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 15:34:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 15:34:28 INFO - "stage_platform": "linux64", 15:34:28 INFO - "basedir": "/builds/slave/test", 15:34:28 INFO - "buildnumber": 117, 15:34:28 INFO - "platform": "ubuntu64_hw", 15:34:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:34:28 INFO - "slavebuilddir": "test", 15:34:28 INFO - "taskId": "TOwhbkVmTVCWX655sN2KZQ", 15:34:28 INFO - "branch": "mozilla-beta", 15:34:28 INFO - "script_repo_revision": "production", 15:34:28 INFO - "revision": "ca9795c9066e8a8ea06157428b7d3e07482e5338", 15:34:28 INFO - "slavename": "talos-linux64-ix-085", 15:34:28 INFO - "repo_path": "releases/mozilla-beta" 15:34:28 INFO - } 15:34:28 INFO - Finding installer, test and symbols from parent task. 15:34:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TOwhbkVmTVCWX655sN2KZQ'}, attempt #1 15:34:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TOwhbkVmTVCWX655sN2KZQ'}, attempt #1 15:34:29 INFO - Task dependencies: JeC8jvYvSYCrCKD2IK2IQA 15:34:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA'}, attempt #1 15:34:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.tar.bz2 15:34:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.test_packages.json 15:34:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.crashreporter-symbols.zip 15:34:29 INFO - Running post-action listener: _resource_record_post_action 15:34:29 INFO - [mozharness: 2017-09-24 22:34:29.682686Z] Finished read-buildbot-config step (success) 15:34:29 INFO - [mozharness: 2017-09-24 22:34:29.682905Z] Running download-and-extract step. 15:34:29 INFO - Running pre-action listener: _resource_record_pre_action 15:34:29 INFO - Running main action method: download_and_extract 15:34:29 INFO - mkdir: /builds/slave/test/build/tests 15:34: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:34:29 INFO - trying https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.test_packages.json 15:34:29 INFO - Downloading https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:34:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:34:30 INFO - Downloaded 989 bytes. 15:34:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:34:30 INFO - Using the following test package requirements: 15:34:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:34:30 INFO - u'common': [u'target.common.tests.zip'], 15:34:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:34:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:34:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:34:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:34:30 INFO - u'mozbase': [u'target.common.tests.zip'], 15:34:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:34:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:34:30 INFO - u'web-platform': [u'target.common.tests.zip', 15:34:30 INFO - u'target.web-platform.tests.tar.gz'], 15:34:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:34:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:34:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.common.tests.zip 15:34:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:34:30 INFO - Fetch https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.common.tests.zip into memory 15:34:34 INFO - Content-Length response header: 55178281 15:34:34 INFO - Bytes received: 55178281 15:34:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.talos.tests.zip 15:34:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:34:45 INFO - Fetch https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.talos.tests.zip into memory 15:34:46 INFO - Content-Length response header: 14509184 15:34:46 INFO - Bytes received: 14509184 15:34: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:34:46 INFO - trying https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.tar.bz2 15:34:46 INFO - Downloading https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:34:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:34:47 INFO - Downloaded 53411415 bytes. 15:34:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.tar.bz2 15:34:48 INFO - mkdir: /builds/slave/test/properties 15:34:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:34:48 INFO - Writing to file /builds/slave/test/properties/build_url 15:34:48 INFO - Contents: 15:34:48 INFO - build_url:https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.tar.bz2 15:34:48 INFO - Running post-action listener: _resource_record_post_action 15:34:48 INFO - Running post-action listener: find_tests_for_verification 15:34:48 INFO - Running post-action listener: set_extra_try_arguments 15:34:48 INFO - [mozharness: 2017-09-24 22:34:48.738403Z] Finished download-and-extract step (success) 15:34:48 INFO - [mozharness: 2017-09-24 22:34:48.738633Z] Running populate-webroot step. 15:34:48 INFO - Running pre-action listener: _resource_record_pre_action 15:34:48 INFO - Running main action method: populate_webroot 15:34:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:34:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:34:48 INFO - 'tests': ['tresize', 15:34:48 INFO - 'tcanvasmark']}, 15:34:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:34:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:34:48 INFO - 'tests': ['dromaeo_css', 15:34:48 INFO - 'kraken']}, 15:34:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:34:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:34:48 INFO - 'talos_options': ['--disable-stylo'], 15:34:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:34:48 INFO - 'tests': ['damp', 'tps']}, 15:34:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:34:48 INFO - 'talos_options': ['--disable-stylo'], 15:34:48 INFO - 'tests': ['damp', 'tps']}, 15:34:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:34:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:34:48 INFO - 'tests': ['dromaeo_dom']}, 15:34:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:34:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:34:48 INFO - 'tests': ['basic_compositor_video', 15:34:48 INFO - 'glvideo']}, 15:34:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:34:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:34:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:34:48 INFO - 'talos_options': ['--disable-stylo'], 15:34:48 INFO - 'tests': ['ts_paint_webext', 15:34:48 INFO - 'tp5o_webext']}, 15:34:48 INFO - 'other-e10s': {'tests': ['a11yr', 15:34:48 INFO - 'ts_paint', 15:34:48 INFO - 'tpaint', 15:34:48 INFO - 'sessionrestore', 15:34:48 INFO - 'sessionrestore_many_windows', 15:34:48 INFO - 'sessionrestore_no_auto_restore', 15:34:48 INFO - 'tabpaint']}, 15:34:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:34:48 INFO - 'tests': ['a11yr', 15:34:48 INFO - 'ts_paint', 15:34:48 INFO - 'tpaint', 15:34:48 INFO - 'sessionrestore', 15:34:48 INFO - 'sessionrestore_many_windows', 15:34:48 INFO - 'sessionrestore_no_auto_restore', 15:34:48 INFO - 'tabpaint']}, 15:34:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:34:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:34:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:34:48 INFO - 'tests': ['perf_reftest_singletons']}, 15:34:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:34:48 INFO - 'tests': ['bloom_basic']}, 15:34:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:34:48 INFO - 'tsvgr_opacity', 15:34:48 INFO - 'tart', 15:34:48 INFO - 'tscrollx', 15:34:48 INFO - 'tsvg_static']}, 15:34:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:34:48 INFO - 'tests': ['tsvgx', 15:34:48 INFO - 'tsvgr_opacity', 15:34:48 INFO - 'tart', 15:34:48 INFO - 'tscrollx', 15:34:48 INFO - 'tsvg_static']}, 15:34:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:34:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:34:48 INFO - 'talos_options': ['--disable-stylo'], 15:34:48 INFO - 'tests': ['tp5o']}, 15:34:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:34:48 INFO - 'talos_options': ['--mitmproxy', 15:34:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:34:48 INFO - '--firstNonBlankPaint'], 15:34:48 INFO - 'tests': ['tp6_google', 15:34:48 INFO - 'tp6_youtube', 15:34:48 INFO - 'tp6_amazon', 15:34:48 INFO - 'tp6_facebook']}, 15:34:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:34:48 INFO - 'talos_options': ['--disable-stylo', 15:34:48 INFO - '--mitmproxy', 15:34:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:34:48 INFO - '--firstNonBlankPaint'], 15:34:48 INFO - 'tests': ['tp6_google', 15:34:48 INFO - 'tp6_youtube', 15:34:48 INFO - 'tp6_amazon', 15:34:48 INFO - 'tp6_facebook']}, 15:34:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:34:48 INFO - 'talos_options': ['--stylo-threads=1', 15:34:48 INFO - '--mitmproxy', 15:34:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:34:48 INFO - '--firstNonBlankPaint'], 15:34:48 INFO - 'tests': ['tp6_google', 15:34:48 INFO - 'tp6_youtube', 15:34:48 INFO - 'tp6_amazon', 15:34:48 INFO - 'tp6_facebook']}, 15:34:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:34:48 INFO - 'talos_options': ['--xperf_path', 15:34:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:48 INFO - 'tests': ['tp5n']}, 15:34:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:34:48 INFO - 'talos_options': ['--disable-stylo', 15:34:48 INFO - '--xperf_path', 15:34:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:48 INFO - 'tests': ['tp5n']}}} 15:34:48 INFO - Running post-action listener: _resource_record_post_action 15:34:48 INFO - [mozharness: 2017-09-24 22:34:48.758100Z] Finished populate-webroot step (success) 15:34:48 INFO - [mozharness: 2017-09-24 22:34:48.758190Z] Running create-virtualenv step. 15:34:48 INFO - Running pre-action listener: _resource_record_pre_action 15:34:48 INFO - Running main action method: create_virtualenv 15:34:48 INFO - Creating virtualenv /builds/slave/test/build/venv 15:34:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:34:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:34:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:34:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:34:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:34:50 INFO - Installing distribute.............................................................................................................................................................................................done. 15:34:50 INFO - Installing pip...............done. 15:34:50 INFO - Return code: 0 15:34:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:34:50 INFO - Reading from file tmpfile_stdout 15:34:50 INFO - Output received: 15:34:50 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:34:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930090>, '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 0x2930d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292af90>, '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': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', '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:34:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:34:50 INFO - Using env: {'DISPLAY': ':0', 15:34:50 INFO - 'HOME': '/home/cltbld', 15:34:50 INFO - 'LANG': 'en_US.UTF-8', 15:34:50 INFO - 'LANGUAGE': 'en_US:en', 15:34:50 INFO - 'LOGNAME': 'cltbld', 15:34:50 INFO - 'MAIL': '/var/mail/cltbld', 15:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:50 INFO - 'MOZ_NO_REMOTE': '1', 15:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:50 INFO - 'NO_EM_RESTART': '1', 15:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:50 INFO - 'PWD': '/builds/slave/test', 15:34:50 INFO - 'SHELL': '/bin/bash', 15:34:50 INFO - 'SHLVL': '1', 15:34:50 INFO - 'TERM': 'linux', 15:34:50 INFO - 'TMOUT': '86400', 15:34:50 INFO - 'USER': 'cltbld', 15:34:50 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', 15:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:50 INFO - '_': '/tools/buildbot/bin/python'} 15:34:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:34:53 INFO - Downloading/unpacking pip>=1.5 15:34:53 INFO - Running setup.py egg_info for package pip 15:34:53 INFO - warning: no files found matching 'pip/cacert.pem' 15:34:53 INFO - warning: no files found matching '*.html' under directory 'docs' 15:34:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:34:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:34:53 INFO - Installing collected packages: pip 15:34:53 INFO - Found existing installation: pip 1.1 15:34:53 INFO - Uninstalling pip: 15:34:53 INFO - Successfully uninstalled pip 15:34:53 INFO - Running setup.py install for pip 15:34:53 INFO - warning: no files found matching 'pip/cacert.pem' 15:34:53 INFO - warning: no files found matching '*.html' under directory 'docs' 15:34:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:34:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:34:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:34:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:34:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:34:53 INFO - Successfully installed pip 15:34:53 INFO - Cleaning up... 15:34:53 INFO - Return code: 0 15:34:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:53 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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930090>, '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 0x2930d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292af90>, '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': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', '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:34:53 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:34:53 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:34:53 INFO - Using env: {'DISPLAY': ':0', 15:34:53 INFO - 'HOME': '/home/cltbld', 15:34:53 INFO - 'LANG': 'en_US.UTF-8', 15:34:53 INFO - 'LANGUAGE': 'en_US:en', 15:34:53 INFO - 'LOGNAME': 'cltbld', 15:34:53 INFO - 'MAIL': '/var/mail/cltbld', 15:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:53 INFO - 'MOZ_NO_REMOTE': '1', 15:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:53 INFO - 'NO_EM_RESTART': '1', 15:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:53 INFO - 'PWD': '/builds/slave/test', 15:34:53 INFO - 'SHELL': '/bin/bash', 15:34:53 INFO - 'SHLVL': '1', 15:34:53 INFO - 'TERM': 'linux', 15:34:53 INFO - 'TMOUT': '86400', 15:34:53 INFO - 'USER': 'cltbld', 15:34:53 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', 15:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:53 INFO - '_': '/tools/buildbot/bin/python'} 15:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:55 INFO - Downloading/unpacking psutil>=3.1.1 15:34: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:34: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:34: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:34: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:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:34:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:56 INFO - Installing collected packages: psutil 15:34:56 INFO - Running setup.py install for psutil 15:34:56 INFO - building 'psutil._psutil_linux' extension 15:34: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:34: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:34:57 INFO - building 'psutil._psutil_posix' extension 15:34: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:34: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:34:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:57 INFO - Successfully installed psutil 15:34:57 INFO - Cleaning up... 15:34:57 INFO - Return code: 0 15:34:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:34:57 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:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:57 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:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:57 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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930090>, '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 0x2930d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292af90>, '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': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', '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:34:57 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:34:57 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:34:57 INFO - Using env: {'DISPLAY': ':0', 15:34:57 INFO - 'HOME': '/home/cltbld', 15:34:57 INFO - 'LANG': 'en_US.UTF-8', 15:34:57 INFO - 'LANGUAGE': 'en_US:en', 15:34:57 INFO - 'LOGNAME': 'cltbld', 15:34:57 INFO - 'MAIL': '/var/mail/cltbld', 15:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:57 INFO - 'MOZ_NO_REMOTE': '1', 15:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:57 INFO - 'NO_EM_RESTART': '1', 15:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:57 INFO - 'PWD': '/builds/slave/test', 15:34:57 INFO - 'SHELL': '/bin/bash', 15:34:57 INFO - 'SHLVL': '1', 15:34:57 INFO - 'TERM': 'linux', 15:34:57 INFO - 'TMOUT': '86400', 15:34:57 INFO - 'USER': 'cltbld', 15:34:57 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', 15:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:57 INFO - '_': '/tools/buildbot/bin/python'} 15:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:34: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:34: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:34: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:34: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:34:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:34: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:34:59 INFO - Installing collected packages: mozsystemmonitor 15:34:59 INFO - Running setup.py install for mozsystemmonitor 15:34:59 INFO - Successfully installed mozsystemmonitor 15:34:59 INFO - Cleaning up... 15:34:59 INFO - Return code: 0 15:34:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:34: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:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34: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:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34: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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930090>, '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 0x2930d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292af90>, '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': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', '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:34: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:34: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:34:59 INFO - Using env: {'DISPLAY': ':0', 15:34:59 INFO - 'HOME': '/home/cltbld', 15:34:59 INFO - 'LANG': 'en_US.UTF-8', 15:34:59 INFO - 'LANGUAGE': 'en_US:en', 15:34:59 INFO - 'LOGNAME': 'cltbld', 15:34:59 INFO - 'MAIL': '/var/mail/cltbld', 15:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:59 INFO - 'MOZ_NO_REMOTE': '1', 15:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:59 INFO - 'NO_EM_RESTART': '1', 15:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:59 INFO - 'PWD': '/builds/slave/test', 15:34:59 INFO - 'SHELL': '/bin/bash', 15:34:59 INFO - 'SHLVL': '1', 15:34:59 INFO - 'TERM': 'linux', 15:34:59 INFO - 'TMOUT': '86400', 15:34:59 INFO - 'USER': 'cltbld', 15:34:59 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', 15:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:59 INFO - '_': '/tools/buildbot/bin/python'} 15:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:59 INFO - Downloading/unpacking jsonschema==2.5.1 15:34: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:34: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:34: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:34: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:35:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:35:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:35: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:35: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:35: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:35: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:35:00 INFO - Downloading functools32-3.2.3-2.tar.gz 15:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:35:00 INFO - warning: no files found matching '*.txt' 15:35:00 INFO - no previously-included directories found matching 'build' 15:35:00 INFO - no previously-included directories found matching 'dist' 15:35:00 INFO - no previously-included directories found matching '.git*' 15:35:00 INFO - Installing collected packages: jsonschema, functools32 15:35:01 INFO - Running setup.py install for functools32 15:35:01 INFO - warning: no files found matching '*.txt' 15:35:01 INFO - no previously-included directories found matching 'build' 15:35:01 INFO - no previously-included directories found matching 'dist' 15:35:01 INFO - no previously-included directories found matching '.git*' 15:35:01 INFO - Successfully installed jsonschema functools32 15:35:01 INFO - Cleaning up... 15:35:01 INFO - Return code: 0 15:35:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:35: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:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35: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:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35: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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930090>, '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 0x2930d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292af90>, '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': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', '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:35: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:35: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:35:01 INFO - Using env: {'DISPLAY': ':0', 15:35:01 INFO - 'HOME': '/home/cltbld', 15:35:01 INFO - 'LANG': 'en_US.UTF-8', 15:35:01 INFO - 'LANGUAGE': 'en_US:en', 15:35:01 INFO - 'LOGNAME': 'cltbld', 15:35:01 INFO - 'MAIL': '/var/mail/cltbld', 15:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:01 INFO - 'MOZ_NO_REMOTE': '1', 15:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:01 INFO - 'NO_EM_RESTART': '1', 15:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:01 INFO - 'PWD': '/builds/slave/test', 15:35:01 INFO - 'SHELL': '/bin/bash', 15:35:01 INFO - 'SHLVL': '1', 15:35:01 INFO - 'TERM': 'linux', 15:35:01 INFO - 'TMOUT': '86400', 15:35:01 INFO - 'USER': 'cltbld', 15:35:01 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', 15:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:01 INFO - '_': '/tools/buildbot/bin/python'} 15:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:35:01 INFO - Cleaning up... 15:35:01 INFO - Return code: 0 15:35:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:35: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:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35: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:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35: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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930090>, '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 0x2930d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292af90>, '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': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', '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:35: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:35: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:35:01 INFO - Using env: {'DISPLAY': ':0', 15:35:01 INFO - 'HOME': '/home/cltbld', 15:35:01 INFO - 'LANG': 'en_US.UTF-8', 15:35:01 INFO - 'LANGUAGE': 'en_US:en', 15:35:01 INFO - 'LOGNAME': 'cltbld', 15:35:01 INFO - 'MAIL': '/var/mail/cltbld', 15:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:01 INFO - 'MOZ_NO_REMOTE': '1', 15:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:01 INFO - 'NO_EM_RESTART': '1', 15:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:01 INFO - 'PWD': '/builds/slave/test', 15:35:01 INFO - 'SHELL': '/bin/bash', 15:35:01 INFO - 'SHLVL': '1', 15:35:01 INFO - 'TERM': 'linux', 15:35:01 INFO - 'TMOUT': '86400', 15:35:01 INFO - 'USER': 'cltbld', 15:35:01 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', 15:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:01 INFO - '_': '/tools/buildbot/bin/python'} 15:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:01 INFO - Downloading/unpacking blobuploader==1.2.4 15:35: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:35: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:35: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:35: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:35:02 INFO - Downloading blobuploader-1.2.4.tar.gz 15:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:35:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:35: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:35: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:35: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:35: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:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:35:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:35: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:35: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:35: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:35: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:35:03 INFO - Downloading docopt-0.6.1.tar.gz 15:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:35:03 INFO - Installing collected packages: blobuploader, requests, docopt 15:35:03 INFO - Running setup.py install for blobuploader 15:35:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:35:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:35:03 INFO - Running setup.py install for requests 15:35:03 INFO - Running setup.py install for docopt 15:35:03 INFO - Successfully installed blobuploader requests docopt 15:35:03 INFO - Cleaning up... 15:35:03 INFO - Return code: 0 15:35:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35: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:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35: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:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35: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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930090>, '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 0x2930d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292af90>, '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': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', '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:35: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:35: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:35:03 INFO - Using env: {'DISPLAY': ':0', 15:35:03 INFO - 'HOME': '/home/cltbld', 15:35:03 INFO - 'LANG': 'en_US.UTF-8', 15:35:03 INFO - 'LANGUAGE': 'en_US:en', 15:35:03 INFO - 'LOGNAME': 'cltbld', 15:35:03 INFO - 'MAIL': '/var/mail/cltbld', 15:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:03 INFO - 'MOZ_NO_REMOTE': '1', 15:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:03 INFO - 'NO_EM_RESTART': '1', 15:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:03 INFO - 'PWD': '/builds/slave/test', 15:35:03 INFO - 'SHELL': '/bin/bash', 15:35:03 INFO - 'SHLVL': '1', 15:35:03 INFO - 'TERM': 'linux', 15:35:03 INFO - 'TMOUT': '86400', 15:35:03 INFO - 'USER': 'cltbld', 15:35:03 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', 15:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:03 INFO - '_': '/tools/buildbot/bin/python'} 15:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:35:04 INFO - Running setup.py (path:/tmp/pip-bJeTXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:35:04 INFO - Running setup.py (path:/tmp/pip-bX1aIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:35:04 INFO - Running setup.py (path:/tmp/pip-Do7Pni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:35:04 INFO - Running setup.py (path:/tmp/pip-86C97q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:35:04 INFO - Running setup.py (path:/tmp/pip-fjZJE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:35:04 INFO - Running setup.py (path:/tmp/pip-oMs8r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:35:04 INFO - Running setup.py (path:/tmp/pip-L4EkbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:35:04 INFO - Running setup.py (path:/tmp/pip-KQWMzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:35:04 INFO - Running setup.py (path:/tmp/pip-hOyt9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:35:04 INFO - Running setup.py (path:/tmp/pip-WeBWxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:35:04 INFO - Running setup.py (path:/tmp/pip-Si9rck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:35:04 INFO - Running setup.py (path:/tmp/pip-3JfrS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:35:04 INFO - Running setup.py (path:/tmp/pip-9SFLHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:35:05 INFO - Running setup.py (path:/tmp/pip-ovJKZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:05 INFO - Running setup.py (path:/tmp/pip-_5s5qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:35:05 INFO - Running setup.py (path:/tmp/pip-tlpCQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:35:05 INFO - Running setup.py (path:/tmp/pip-n4bKWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:35:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:35:05 INFO - Running setup.py install for manifestparser 15:35:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:35:05 INFO - Running setup.py install for mozcrash 15:35:05 INFO - Running setup.py install for mozdebug 15:35:05 INFO - Running setup.py install for mozdevice 15:35:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:35:05 INFO - Running setup.py install for mozfile 15:35:05 INFO - Running setup.py install for mozhttpd 15:35:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:35:05 INFO - Running setup.py install for mozinfo 15:35:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:35:05 INFO - Running setup.py install for mozInstall 15:35:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:35:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:35:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:35:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:35:06 INFO - Running setup.py install for mozleak 15:35:06 INFO - Running setup.py install for mozlog 15:35:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:35:06 INFO - Running setup.py install for moznetwork 15:35:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:35:06 INFO - Running setup.py install for mozprocess 15:35:06 INFO - Running setup.py install for mozprofile 15:35:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:35:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:35:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:35:06 INFO - Running setup.py install for mozrunner 15:35:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:35:06 INFO - Running setup.py install for mozscreenshot 15:35:06 INFO - Running setup.py install for moztest 15:35:06 INFO - Running setup.py install for mozversion 15:35:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:35:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:35:07 INFO - Cleaning up... 15:35:07 INFO - Return code: 0 15:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35: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:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35: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:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35: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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930090>, '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 0x2930d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292af90>, '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': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', '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:35: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:35: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:35:07 INFO - Using env: {'DISPLAY': ':0', 15:35:07 INFO - 'HOME': '/home/cltbld', 15:35:07 INFO - 'LANG': 'en_US.UTF-8', 15:35:07 INFO - 'LANGUAGE': 'en_US:en', 15:35:07 INFO - 'LOGNAME': 'cltbld', 15:35:07 INFO - 'MAIL': '/var/mail/cltbld', 15:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:07 INFO - 'MOZ_NO_REMOTE': '1', 15:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:07 INFO - 'NO_EM_RESTART': '1', 15:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:07 INFO - 'PWD': '/builds/slave/test', 15:35:07 INFO - 'SHELL': '/bin/bash', 15:35:07 INFO - 'SHLVL': '1', 15:35:07 INFO - 'TERM': 'linux', 15:35:07 INFO - 'TMOUT': '86400', 15:35:07 INFO - 'USER': 'cltbld', 15:35:07 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', 15:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:07 INFO - '_': '/tools/buildbot/bin/python'} 15:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:35:07 INFO - Running setup.py (path:/tmp/pip-cr1rGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:35: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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:35:07 INFO - Running setup.py (path:/tmp/pip-Awvqp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:35: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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:35:07 INFO - Running setup.py (path:/tmp/pip-ANwLut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:35: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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:35:07 INFO - Running setup.py (path:/tmp/pip-zijSVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:35: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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:35:07 INFO - Running setup.py (path:/tmp/pip-sIplhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:35: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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:35:07 INFO - Running setup.py (path:/tmp/pip-ayIKuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:35: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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:35:07 INFO - Running setup.py (path:/tmp/pip-E1CmCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:35: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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:35:07 INFO - Running setup.py (path:/tmp/pip-EEhoQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:35: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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:35:07 INFO - Running setup.py (path:/tmp/pip-4lnI5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:35:07 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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:35:07 INFO - Running setup.py (path:/tmp/pip-3R2wy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:35: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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:35:08 INFO - Running setup.py (path:/tmp/pip-xPtg31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:35: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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:35:08 INFO - Running setup.py (path:/tmp/pip-7Bo0Nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:35: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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:35:08 INFO - Running setup.py (path:/tmp/pip-P4oIHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:35: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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:35:08 INFO - Running setup.py (path:/tmp/pip-wfNyGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:35: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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:08 INFO - Running setup.py (path:/tmp/pip-sMs6bT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:35: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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:35:08 INFO - Running setup.py (path:/tmp/pip-nxApHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:35: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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:35:08 INFO - Running setup.py (path:/tmp/pip-4Yla7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:35: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:35: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:35: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:35: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:35: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:35: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:35: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:35:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:35: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:35: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:35: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:35: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:35:09 INFO - Downloading blessings-1.6.tar.gz 15:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:35:09 INFO - Installing collected packages: blessings 15:35:09 INFO - Running setup.py install for blessings 15:35:09 INFO - Successfully installed blessings 15:35:09 INFO - Cleaning up... 15:35:09 INFO - Return code: 0 15:35:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:35:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:35:10 INFO - Reading from file tmpfile_stdout 15:35:10 INFO - Current package versions: 15:35:10 INFO - argparse == 1.2.1 15:35:10 INFO - blessings == 1.6 15:35:10 INFO - blobuploader == 1.2.4 15:35:10 INFO - docopt == 0.6.1 15:35:10 INFO - functools32 == 3.2.3-2 15:35:10 INFO - jsonschema == 2.5.1 15:35:10 INFO - manifestparser == 1.1 15:35:10 INFO - mozInstall == 1.13 15:35:10 INFO - mozcrash == 1.0 15:35:10 INFO - mozdebug == 0.1 15:35:10 INFO - mozdevice == 0.51 15:35:10 INFO - mozfile == 1.2 15:35:10 INFO - mozhttpd == 0.7 15:35:10 INFO - mozinfo == 0.10 15:35:10 INFO - mozleak == 0.1 15:35:10 INFO - mozlog == 3.5 15:35:10 INFO - moznetwork == 0.27 15:35:10 INFO - mozprocess == 0.25 15:35:10 INFO - mozprofile == 0.28 15:35:10 INFO - mozrunner == 6.13 15:35:10 INFO - mozscreenshot == 0.1 15:35:10 INFO - mozsystemmonitor == 0.3 15:35:10 INFO - moztest == 0.8 15:35:10 INFO - mozversion == 1.4 15:35:10 INFO - psutil == 3.1.1 15:35:10 INFO - requests == 1.2.3 15:35:10 INFO - wsgiref == 0.1.2 15:35:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35: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:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35: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:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35: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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930090>, '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 0x2930d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292af90>, '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': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', '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:35: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:35: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:35:10 INFO - Using env: {'DISPLAY': ':0', 15:35:10 INFO - 'HOME': '/home/cltbld', 15:35:10 INFO - 'LANG': 'en_US.UTF-8', 15:35:10 INFO - 'LANGUAGE': 'en_US:en', 15:35:10 INFO - 'LOGNAME': 'cltbld', 15:35:10 INFO - 'MAIL': '/var/mail/cltbld', 15:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:10 INFO - 'MOZ_NO_REMOTE': '1', 15:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:10 INFO - 'NO_EM_RESTART': '1', 15:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:10 INFO - 'PWD': '/builds/slave/test', 15:35:10 INFO - 'SHELL': '/bin/bash', 15:35:10 INFO - 'SHLVL': '1', 15:35:10 INFO - 'TERM': 'linux', 15:35:10 INFO - 'TMOUT': '86400', 15:35:10 INFO - 'USER': 'cltbld', 15:35:10 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', 15:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:10 INFO - '_': '/tools/buildbot/bin/python'} 15:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35: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:35: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:35: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:35: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:35: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:35: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:35: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:35: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:35: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:35:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:35: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:35: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:35: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:35: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:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:35: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:35: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:35:11 INFO - Installing collected packages: simplejson 15:35:11 INFO - Running setup.py install for simplejson 15:35:11 INFO - building 'simplejson._speedups' extension 15:35: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:35: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:35:12 INFO - Successfully installed simplejson 15:35:12 INFO - Cleaning up... 15:35:12 INFO - Return code: 0 15:35:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:35: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:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35: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:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35: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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930090>, '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 0x2930d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292af90>, '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': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', '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:35: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:35: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:35:12 INFO - Using env: {'DISPLAY': ':0', 15:35:12 INFO - 'HOME': '/home/cltbld', 15:35:12 INFO - 'LANG': 'en_US.UTF-8', 15:35:12 INFO - 'LANGUAGE': 'en_US:en', 15:35:12 INFO - 'LOGNAME': 'cltbld', 15:35:12 INFO - 'MAIL': '/var/mail/cltbld', 15:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:12 INFO - 'MOZ_NO_REMOTE': '1', 15:35:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:12 INFO - 'NO_EM_RESTART': '1', 15:35:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:12 INFO - 'PWD': '/builds/slave/test', 15:35:12 INFO - 'SHELL': '/bin/bash', 15:35:12 INFO - 'SHLVL': '1', 15:35:12 INFO - 'TERM': 'linux', 15:35:12 INFO - 'TMOUT': '86400', 15:35:12 INFO - 'USER': 'cltbld', 15:35:12 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', 15:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:12 INFO - '_': '/tools/buildbot/bin/python'} 15:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:35:12 INFO - Cleaning up... 15:35:12 INFO - Return code: 0 15:35:12 INFO - Running post-action listener: _resource_record_post_action 15:35:12 INFO - Running post-action listener: _start_resource_monitoring 15:35:12 INFO - Starting resource monitoring. 15:35:12 INFO - [mozharness: 2017-09-24 22:35:12.833284Z] Finished create-virtualenv step (success) 15:35:12 INFO - [mozharness: 2017-09-24 22:35:12.834244Z] Running install step. 15:35:12 INFO - Running pre-action listener: _resource_record_pre_action 15:35:12 INFO - Running main action method: install 15:35:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:35:13 INFO - Reading from file tmpfile_stdout 15:35:13 INFO - Detecting whether we're running mozinstall >=1.0... 15:35:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:35:13 INFO - Reading from file tmpfile_stdout 15:35:13 INFO - Output received: 15:35:13 INFO - Usage: mozinstall [options] installer 15:35:13 INFO - Options: 15:35:13 INFO - -h, --help show this help message and exit 15:35:13 INFO - -d DEST, --destination=DEST 15:35:13 INFO - Directory to install application into. [default: 15:35:13 INFO - "/builds/slave/test"] 15:35:13 INFO - --app=APP Application being installed. [default: firefox] 15:35:13 INFO - mkdir: /builds/slave/test/build/application 15:35: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:35: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:35:27 INFO - Reading from file tmpfile_stdout 15:35:27 INFO - Output received: 15:35:27 INFO - /builds/slave/test/build/application/firefox/firefox 15:35:27 INFO - Running post-action listener: _resource_record_post_action 15:35:27 INFO - [mozharness: 2017-09-24 22:35:27.732484Z] Finished install step (success) 15:35:27 INFO - [mozharness: 2017-09-24 22:35:27.732732Z] Running setup-mitmproxy step. 15:35:27 INFO - Running pre-action listener: _resource_record_pre_action 15:35:27 INFO - Running main action method: setup_mitmproxy 15:35:27 INFO - Skipping: mitmproxy is not required 15:35:27 INFO - Running post-action listener: _resource_record_post_action 15:35:27 INFO - [mozharness: 2017-09-24 22:35:27.733926Z] Finished setup-mitmproxy step (success) 15:35:27 INFO - [mozharness: 2017-09-24 22:35:27.734144Z] Running run-tests step. 15:35:27 INFO - Running pre-action listener: _resource_record_pre_action 15:35:27 INFO - Running pre-action listener: _set_gcov_prefix 15:35:27 INFO - Running main action method: run_tests 15:35:27 WARNING - Try message not found. 15:35:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:35:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:35:27 INFO - Python 2.7.3 15:35:27 INFO - Return code: 0 15:35:27 INFO - grabbing minidump binary from tooltool 15:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:27 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 0x2930090>, '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 0x2930d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:35:27 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:35:27 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:35:27 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:35:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:35:27 INFO - Return code: 0 15:35:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:35:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:35:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:35:27 INFO - ENV: RUST_BACKTRACE is now full 15:35:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:35:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:35:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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:35:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-085 --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:35:27 INFO - Using env: {'DISPLAY': ':0', 15:35:27 INFO - 'HOME': '/home/cltbld', 15:35:27 INFO - 'LANG': 'en_US.UTF-8', 15:35:27 INFO - 'LANGUAGE': 'en_US:en', 15:35:27 INFO - 'LOGNAME': 'cltbld', 15:35:27 INFO - 'MAIL': '/var/mail/cltbld', 15:35:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:35:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:27 INFO - 'MOZ_NO_REMOTE': '1', 15:35:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:27 INFO - 'NO_EM_RESTART': '1', 15:35:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:27 INFO - 'PWD': '/builds/slave/test', 15:35:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:35:27 INFO - 'RUST_BACKTRACE': 'full', 15:35:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:35:27 INFO - 'SHELL': '/bin/bash', 15:35:27 INFO - 'SHLVL': '1', 15:35:27 INFO - 'TERM': 'linux', 15:35:27 INFO - 'TMOUT': '86400', 15:35:27 INFO - 'USER': 'cltbld', 15:35:27 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', 15:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:27 INFO - '_': '/tools/buildbot/bin/python'} 15:35:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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:35:28 INFO - mozversion application_buildid: 20170924211618 15:35:28 INFO - mozversion application_changeset: ca9795c9066e8a8ea06157428b7d3e07482e5338 15:35:28 INFO - mozversion application_display_name: Firefox 15:35:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:35:28 INFO - mozversion application_name: Firefox 15:35:28 INFO - mozversion application_remotingname: firefox 15:35:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:35:28 INFO - mozversion application_vendor: Mozilla 15:35:28 INFO - mozversion application_version: 57.0 15:35:28 INFO - mozversion platform_buildid: 20170924211618 15:35:28 INFO - mozversion platform_changeset: ca9795c9066e8a8ea06157428b7d3e07482e5338 15:35:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:35:28 INFO - mozversion platform_version: 57.0 15:35:28 INFO - using testdate: 1506292528 15:35:28 INFO - actual date: 1506292528 15:35:28 INFO - starting webserver on 'localhost:34770' 15:35:28 INFO - SUITE-START | Running 2 tests 15:35:28 INFO - TEST-START | dromaeo_css 15:35:28 INFO - Initialising browser for dromaeo_css test... 15:35:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34770/getInfo.html -profile /tmp/tmp1q7M0p/profile 15:35:28 INFO - TEST-INFO | started process 3556 (/builds/slave/test/build/application/firefox/firefox http://localhost:34770/getInfo.html) 15:35:37 INFO - TEST-INFO | 3556: exit 0 15:35:37 INFO - Browser initialized. 15:35:37 INFO - Running cycle 1/1 for dromaeo_css test... 15:35:37 INFO - Using env: {'DISPLAY': ':0', 15:35:37 INFO - 'HOME': '/home/cltbld', 15:35:37 INFO - 'JSGC_DISABLE_POISONING': '1', 15:35:37 INFO - 'LANG': 'en_US.UTF-8', 15:35:37 INFO - 'LANGUAGE': 'en_US:en', 15:35:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:35:37 INFO - 'LOGNAME': 'cltbld', 15:35:37 INFO - 'MAIL': '/var/mail/cltbld', 15:35:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:35:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:35:37 INFO - 'MOZ_CRASHREPORTER': '1', 15:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:35:37 INFO - 'MOZ_NO_REMOTE': '1', 15:35:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:37 INFO - 'NO_EM_RESTART': '1', 15:35:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:37 INFO - 'PWD': '/builds/slave/test', 15:35:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:35:37 INFO - 'RUST_BACKTRACE': 'full', 15:35:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:35:37 INFO - 'SHELL': '/bin/bash', 15:35:37 INFO - 'SHLVL': '1', 15:35:37 INFO - 'TERM': 'linux', 15:35:37 INFO - 'TMOUT': '86400', 15:35:37 INFO - 'USER': 'cltbld', 15:35:37 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', 15:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:37 INFO - '_': '/tools/buildbot/bin/python'} 15:35:37 INFO - TEST-INFO | started process 3747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1q7M0p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:48 INFO - PID 3747 | RSS: Main: 141422592 15:35:48 INFO - PID 3747 | 15:38:46 INFO - PID 3747 | Cycle 1(1): loaded http://localhost:34770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34770/tests/dromaeo/cssquery-ext.html) 15:38:47 INFO - PID 3747 | RSS: Main: 144842752 15:38:47 INFO - PID 3747 | 15:41:49 INFO - PID 3747 | Cycle 1(1): loaded http://localhost:34770/tests/dromaeo/cssquery-ext.html (next: http://localhost:34770/tests/dromaeo/cssquery-jquery.html) 15:41:49 INFO - PID 3747 | RSS: Main: 143454208 15:41:49 INFO - PID 3747 | 15:44:51 INFO - PID 3747 | Cycle 1(1): loaded http://localhost:34770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34770/tests/dromaeo/cssquery-mootools.html) 15:44:51 INFO - PID 3747 | RSS: Main: 144306176 15:44:51 INFO - PID 3747 | 15:47:53 INFO - PID 3747 | Cycle 1(1): loaded http://localhost:34770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34770/tests/dromaeo/cssquery-prototype.html) 15:47:53 INFO - PID 3747 | RSS: Main: 144216064 15:47:53 INFO - PID 3747 | 15:50:56 INFO - PID 3747 | Cycle 1(1): loaded http://localhost:34770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34770/tests/dromaeo/cssquery-yui.html) 15:50:57 INFO - PID 3747 | RSS: Main: 145465344 15:50:57 INFO - PID 3747 | 15:53:58 INFO - PID 3747 | Cycle 1(1): loaded http://localhost:34770/tests/dromaeo/cssquery-yui.html (next: http://localhost:34770/tests/dromaeo/cssquery-dojo.html) 15:53:59 INFO - PID 3747 | RSS: Main: 148733952 15:53:59 INFO - PID 3747 | 15:53:59 INFO - PID 3747 | __start_tp_report 15:53:59 INFO - PID 3747 | _x_x_mozilla_page_load 15:53:59 INFO - PID 3747 | _x_x_mozilla_page_load_details 15:53:59 INFO - PID 3747 | |i|pagename|runs| 15:53:59 INFO - PID 3747 | |0;dojo.html;3984.2629113613966;3984.3824207247876;3992.061865461618;3999.3800960851077;4059.3707975263846;6514.925037368835;6598.274189839114;6664.533482656216;6664.633445160514;6666.333366663337;6585.736570537185;6587.275399706028;6588.835279118024;6658.467322614191;6679.699413526391;5916.3787802280785;5934.258217722785;5964.79123230687;5981.760729570812;5994.160817485545;5932.080527518242;5958.940410595904;6019.879602407949;6048.425399587032;6065.454109130177;5954.9404505955035;5982.79060232892;5994.43052909975;5996.310424301196;6065.575409721321;5930.55520835939;6054.061620448838;6085.969570152165;6095.207623008981;6096.4817990470865;5860.120981852713;5940.37626049263;5963.642181469082;6020.217371741689;6045.12345709874;6446.452051575622;6495.512836537278;6495.642739649317;6593.175853018372;6602.339766023408;7148.964255178743;7207.207207207203;7227.7831665050135;7232.276772322778;7240.782776516713;7165.176004759467;7170;7226.710931562731;7280.745173918887;7295.781126566211;6654.434373078294;6735.797926062226;6747.662616869137;6758.966205168943;6761.830954226134;7300.501709807075;7383.556986580822;7420.146683131509;7426.220246874109;7509.7371591994015;7147.1780745214965;7151.89272160918;7202.675879585431;7226.313500217471;7236.638168091575;7293.708251669874;7307.561546307133;7346.742863999734;7368.263173682696;7372.894065890159;7096.077509923677;7126.893096603555;7140.178879428829;7166.820829479305;7174.246704096099;7132.322429369202;7190.712371505186;7225.5664660120565;7226.710931562784;7230.276972302728;5389.137737961907;5450.427705090988;5466.562674985991;5473.972630136824;5477.260569823103;4912.336834527365;4919.7540122993705;4952.529509696573;4959.479254678279;4969.527894849984;6711.328867113347;6792.830179245559;6800.65996700163;6852.074969879102;6867.450603951672;7220.638968051577;7273.199948005715;7282.781516554512;7283.126024877049;7289.343959043712;6783.423409010191;6805.455563554904;6825.283345248777;6883.931160688429;6888.173419189629;6206.348333425016;6215.098810672427;6286.779962701284;6291.496680265568;6295.559310848196;7485.1017877855;7499.737509187153;7551.848963020709;7565.773026809205;7597.5821329826285;7046.1192350956135;7139.321764432267;7209.819754506179;7231.891521627074;7239.529430586995;7416.814579635552;7418.332350088518;7423.406127509678;7506.9249307506225;7509.699612015458;6954.513184077066;7068.964655176691;7073.787786366417;7088.822779430349;7157.606331651809;7252.311030452099;7254.492185546961;7260.854782904418;7272.96363518179;7293.270672932665;6885.827854303682;6900.137482814648;6968.547044442298;6990.61551614666;7012.789616311519;6957.443404527727;7018.403435707818;7037.225905150327;7104.467164962545;7127.287271272831;6919.515633905578;6946.826329341807;7009.193942696451;7014.2635023323855;7018.122734658168;7017.859642807013;7073.610951397517;7101.147862256562;7155.499115061895;7184;6783.660816959034;6849.794506164823;6859.314068593101;6865.897011544931;6878.55289406187 15:53:59 INFO - PID 3747 | |1;ext.html;930.2325581395348;978.6379039755287;995.7411073120988;1038.8441733739933;1039.199816141571;44180;46066.769666151704;46187.307190392174;46216.53783462168;46340.304895426554;43386.7830660847;43517.56482435175;43559.78220108903;43583.128337433314;43870;8084.353251739862;8224.794380140485;8227.629756660936;8229.547374894379;8265;8155.632996515171;8273.958630206871;8276.958615206915;8290.336773058141;8301.335893128535;8747.693830715927;8886.822263554724;8911.242544383735;8915.375923685344;8921.33090018248;8764.03595604483;8823.647054117828;8824.294056475466;8839.469631822047;8851.07063758309;8813;8838.204561589488;8841.778955526099;8895.421797583202;8905.465672059698;42522;42694.78652606748;42957.35563966543;42968.57031429708;43207.35188972168;3847.4228865670093;3888.183481468895;3892.591277915835;3901.08324543732;3924.1759230561615;34678.306433871185;34985.300293993976;35044;35072.29855402878;35149.824250878584;5528.695921724304;5573.191887176377;5653.491185793298;5691.203231547545;5698.487136157724;229947.99999999834;235961;236452;238953;244212;55121;55804.44195558074;55898.72050639721;55983;56081.43918560844;58605;58973;59030.70484647549;59170;59583.40416595865;17576.472705818847;17608.207630656652;17721.7341739874;17767.911160444117;17911.373101941368;14599.270036498132;14618.634534136732;14728.189949552663;14757.335919883417;14850.108993460426;16013.839861601467;16108.275127619285;16156.27296771648;16174.353025879069;16232.837671623369;6277.296395126897;6332.778352757631;6382.106505089291;6462.289148193695;6568.737250510022;1107.241539545398;1111.5664890692635;1112.404863398078;1116.558959211107;1126.752114534801;26138.477230455286;26506;26515.337116571853;26546.734532654813;26625.600615990777;1219.5792451604182;1235.1600911380167;1241.6833707404553;1258.3456602566798;1259.118616968126;13984.580462586138;14050.718985620231;14065.859341406454;14077.577672669837;14147.151170929777;292483;292747;297414;298375;298981;61597.69201154055;62700;62741.68629156825;62898.685506572176;63301.36698633047;1611.0253296755295;1611.4762702121857;1617.4500669772099;1639.049351376199;1640.0897501886568;26090.86954565215;26100.8694956524;26119.216423507325;26233;26407.735922640528;43158.56841431546;43209.7839510813;43251.78374108109;43286.48497302579;43345.56654433415;248480;249690;250176;250936;252139;38944.80527597344;45396.546034539235;45444.31833522566;45658.315125272486;45860.54139458696;55381.16928245999;55766.72116639391;56490;56734.71632641975;57162;40865.79567102146;41040.58959410368;41268;41459;41786.1642767149;40115.79942100271;40980.79509602552;41211.587884120774;41555;41861.95345116275;49168;49219;49586.75206623944;49722.75138624284;49793.75103124461;38862;38916.41625375678;39064.60935390723;39436.802815985735;40254;28364.858175709815;28829.423411531232;29188.70811291945;29662.406751865274;29676.406471870872 15:53:59 INFO - PID 3747 | |2;jquery.html;615.132662945247;623.5635055461175;638.4157184363187;645.8256270806879;652.3769799841151;23688;24007.519849603;24218.63672044916;24509.999999999978;24597.26208213752;28047.439051218964;28355.291117722067;28364.574531382044;28427.85786071067;28480.145595632162;6802.96598517008;6981;6985.79042628722;6988.61562614056;6998.3001699829865;6803.421709154728;6975.476839237052;7024.262452442496;7051.823704407379;7071.1868135164605;6986.056882320898;6993.89509157363;7005.964970175142;7018.087648605674;7020.894686579705;6971.372576468142;6996.965015174917;7016.614086225256;7031.683574239146;7035.050268213802;6484.93515064848;6513.837154071139;6536.477081833442;6543.705533251015;6579.703913323912;31711.365772684418;32132.83933580317;32441.837790811132;32782.50826237608;32783.18042048944;2353.0352555452355;2386.069432921162;2388.593939030369;2389.629607410854;2398;20534.5893082139;21167.15331386758;21196.788032119788;21211.575768484698;21221.68167477489;2600.8699565021675;2650.761431471177;2652.1778248742953;2673.1980405878157;2674.251209661298;143446.2827685855;148349.25825370912;155107;161685.19157404255;161808;16534.917325413535;17465.7380139298;17656.470305890845;17716.379926702502;17846.821531784775;28317.858410707813;28431;28480.430391392056;28498.430031399257;28588;11312.717182070513;11365;11612.361320127475;11616.767664646659;11665.475053622607;10397.532111055021;10482.47587620616;10507.159427245802;10525.473726313654;10653.147748180281;10248.282620216662;10292.279540432248;10313.535890884777;10548.314359566604;10560.102391296672;2922.8100173488656;2935.6036935013926;2944.926376840553;3012.743926722439;3075.8923437679573;1052.899974502421;1072.463768115942;1081.7241603391085;1088.8965548272902;1095.7972775036644;22209.666854997187;22441.21455749041;22565.09739610397;22806.65790013151;22822;1133.777795520772;1142.714321419645;1151.268944220426;1153.3656488931053;1160.5241850841114;12293.93853030747;12345.135840491079;12468.937655311665;12483.812742808865;12505.499780008699;645792;649363;649679;660023;664688;128573.35713321561;131303.34348328196;135414;138357.3082134603;141043;1179.6520026592175;1258.9496420143091;1298.1367390685277;1317.2162563274835;1329.9601011969658;23624.645630315903;23747.40631484227;23953.281401557982;24054.759452405953;24289.51420971606;64800.0279995791;64829.35170648233;64908.35091649212;65244.673776630814;66880.33119668742;79844.60077699574;81174.59412703135;81689;81693.59153204196;81929.59035204786;16196.595085122495;16243.51269461918;16373.83626163723;16501.09243991592;16564.751528726836;24588.385290367885;24729.62905556454;25120.37199069965;25149.87425062936;25231.243062707414;18375.356862509747;18469.630607388044;18564.257429702662;20198.29305974284;20556.897215513825;16011.19944002772;16781;16871.325146993982;18011.72982405239;18675.346362877233;19982.30061947825;20534.486637834172;20575.38273851787;20726.792732072485;20765.792342076387;15836.445724399591;16102.03387796736;16220.026798392135;16222.26999784989;16233.59416014609;20101.899490502456;20201.494962625464;20324.491887702334;20413.38759837207;20551.897240513703 15:53:59 INFO - PID 3747 | |3;mootools.html;1392.2133994293224;1452.3754785442263;1453;1455.374189098687;1467.4423718986784;17550.73673894891;18226.362077327278;18247.361342352986;18259.817401825978;18293.359732409368;17733.91133044333;17822.46532604021;17927.193276302565;17935;17942.19260133294;2850.2589326775083;2985.2686091907512;2996.370762139953;3008.6840881707435;3009.86455609497;2806.4387122575463;3001.5197568389062;3059.219898925771;3066.7546596272355;3070.4319700855303;3036.195408216813;3055.1903745507457;3069.002574163406;3073.9846300768577;3075.584796052538;2902.042326032404;2911.708829117082;2913.388188480422;2913.8106023108535;2923.5468502382164;2828.349479619699;2951.970480295191;2989.491786396296;2994.550817377389;2996.6553846307734;17181.140942952803;17185.656286874317;17246;17372.56568585783;17458.91270543652;8604;8818.559072046437;8869.73390798277;8877.866831997526;8879.822403551958;6021.458068773788;6080.209572755558;6210.937890621081;6236.220472440945;6302.653354065525;2126.1176611706123;2188.84678072535;2207.381933058746;2211.7677643847487;2247.6965609642652;31211;31236.531452028237;31332.21669458259;31348.843255783802;31364.529532057037;7259.564426134449;7335.523190992569;7402.925970740332;7477.214892436325;7525.397968162534;19911.502212444804;19987.100580473914;19998.50003749918;20002.19991200365;20009.899950500156;8027.277545020859;8602.61288242018;8658.610362533702;8665.35009874262;8672.392932494664;7720.652570634335;7786.104597971193;7897.578435881596;7975.5613441261285;7997.600119994094;5652.802151924663;5836.678982655994;5875;5913.319968203626;5915;1547.582152818755;1586.912719800422;1630.8858379913293;1707.7353010283177;1721.4921598128583;882.289756745813;887.1306120002305;890.4523717913437;892.5626443042992;913.8537833946536;10200.4389758564;10266;10324.587016519405;10335.638252661121;10539.314944528582;1107.1032463704264;1110.7945030169444;1113.905318047975;1124.5276983666715;1137.732632831284;5347.786088556492;5509.889802203934;5545.445455454423;6370.980643097082;6478.967605162038;24900.875495622407;25453.74546254514;25483;25738;25801.22596322113;23809.642855356837;25305.873470632898;25384.11155609545;26004.869975650377;26140.215793526226;13005;13065.216087034809;13079.934600326937;13157.210567365988;13172.14381065247;9344.906550934404;9951.751206219902;10092.697219083439;10163.94918025405;10244.436555989492;21586.244481443075;21977;22143.0035648393;22385.888070559544;22726.659100113182;22715.31854044381;22811;23043.88478057599;23116.653250201598;23300.3009909703;12671.113022088366;12797.168184068007;12800.807987880004;12845.871541284841;12863.485460581845;15582.610434739223;15886.205689715236;16019.35922563131;16060.518184454486;16090.758638620664;11405.429728513707;12392.690182745142;12538.686532836751;12566;12575.182613130117;11885.108616853599;12060.216085954386;12134.575289864812;12177.573784917486;12349.629511114681;11422.48598813072;11620.477078531318;11677.357745323749;11679.474423650787;11690.76618467643;8728.036191856781;8844.867326989972;8876.156765107304;8878.600462979051;8898.55507224649;8852.778680533038;9053.049429809775;9152.450852948577;9176.35765496409;9194.724158275263 15:53:59 INFO - PID 3747 | |4;prototype.html;550.975206115725;559.7313289620981;576.7001159397113;582.8426324892276;593.5518683394037;6407.860148527223;6456.96771516143;6485.610863348196;6523.543351965364;6552.410283074522;6373.298937116925;6424.293327733945;6425.293217746044;6431.26040505342;6539.934600653992;5278.709670968095;5290.597991532247;5292.947070529284;5304.655197412156;5324.094903866333;5058.620603454738;5157.329547158864;5198.45416231296;5199.766010529516;5220.373555173384;5126.5898728101665;5128;5132.871678208056;5150.33045704058;5176;5080.187170052811;5122.462141475129;5158.884857208545;5162.690238585678;5171.120909445403;4655.4878963314;4664.766761661904;4690.5778479936625;4702.31816386622;4722.5513576210205;6344.6827658616885;6414.839629009265;6431.967840160769;6450.6452145132;6455.580387274859;6029.969850150721;6037.698115094272;6067.635941843503;6105.419985101408;6122.326544080148;6886.8622627547165;6893.27715552359;6912.516123871281;6921.204061532938;6978.197507286676;5014.699118052892;5205.531502164786;5259.579233661298;5262.158054711228;5274.472552744694;6941.271166527493;7026.683799228996;7055.15338159419;7067.752628657972;7148.892766608505;5323.893522129536;5341.370881881064;5399.541039011649;5433.8369848904595;5438.782448702087;5395.21769343443;5433.782648694087;5453.291072160594;5472.753726082336;5509.449055094458;6047.879042419127;6078.878422431527;6083.6349819011;6104.236970378703;6107.083937409336;6862.794116176523;6889.793306200822;6907.620080895599;6909.516333856582;6931.930680693229;1853.4810253129147;1853.6746226448154;1886.830185283331;1891.725699773525;1898.784777742246;1305.9608211753662;1332.1474256475863;1333.626364844212;1340.5844188301658;1351.7837146056584;6351;6387.712552935129;6427.550071495044;6440.581362211441;6468.5472016958365;6968.163820341591;7029.402500787491;7038.92961070393;7050.4007159391;7050.753223637148;6395.96191808887;6413.166288382574;6484.351564843478;6484.643344615997;6492.935070649233;3622.3117607654463;3657.9817100914856;3661.9450708239397;3678.1540245743095;3703.9814800925824;7236.34872861445;7265.273472652798;7293.416526677853;7295.89056164158;7322.267773222635;6935.445164386837;6970.372666459942;7001.264867188974;7008.439324853999;7080.716771329089;7105.928940710527;7154.851865179305;7162.247963963813;7223.27767223284;7244.927550724531;6837.555558888656;6839.760608378683;6844.0152355818245;6891.518323560458;7044.823879402851;6865.931340686529;6868.381845633917;6930.341617546325;6957.095577574883;6980.650967451708;7174;7228.602426866572;7242.971967849011;7259.891101633585;7321.816954576178;5385.27298814655;5386.245925570502;5387.434319396407;5389.299391079135;5395.487428694268;6711.697973591297;6924;7011.368976792113;7038.683259253244;7068.893966590608;6544.770933017321;6682.231543372574;6761.594304341756;6766.627835469097;6771.762988295386;6583.736650534117;6661;6707;6794.456443484411;6821.590704557742;6555.508336874658;6647.135872336566;6700.83247918806;6726.966365168143;6752.426043786333;6842.247352791289;6871.518993670595;6874.896876546956;6881.277465866012;6924.446044316342;6704.094947182263;6706.295838936841;6761.594304341756;6766.15423072116;6769 15:53:59 INFO - PID 3747 | |5;yui.html;1011.7268337548862;1034.5241189053036;1044.1698849414715;1045.414567842008;1064.9148068154548;19505.609887802235;19895;20636.896815515902;20732.48168795781;20798.376048718543;19973.800261997374;20375.28686495973;20392.694109588367;20396.59206815863;20398.388048358574;1051.9211059170573;1087.1520214232871;1087.179179719311;1087.48344536345;1088.0588291128156;1067.2849191042021;1079.3200283821182;1104.5857803323754;1104.6133853151373;1104.8232282834747;1175.8588969323694;1185.8221266809962;1188.1148544334483;1188.934608596527;1193.7314104326501;1172.7009612548832;1185.9703507412298;1187.726822830745;1191.970200744984;1192.326335620376;872.3718922375879;873.1007062725403;873.8077622922947;876.6668665906979;877.6006916852881;19651.508712282164;19939;20009.29967451147;20040.298589549297;21857.890710546344;23769.405764855845;23948.16181433659;24328.1485148019;24362.756372436226;24559.631605525752;18303.908480457514;18455.261789528402;18550.536236594056;18775.906120469448;18852.15165317564;4120.96975756061;4155.854545090907;4173.24881521326;4174.394712766662;4175.68682348825;154074.22962885114;157529;160304;161977.1901140487;163334;18241.45275641733;18774.530636733918;18802.153903074395;18802.52993675169;18809.34167304165;34548.309033819685;35735.28529429397;35903.102422439646;36054.278914421564;36114.27771444556;9420.811583768285;9455.479948602755;9477.431354118775;9559.90440095604;9570.377925434963;5021.472745361684;5112.514311140436;5121.641485096007;5126.333576635014;5133.409657889316;6336.556441049174;6351.587146835441;6397.776077837253;6440.452561532228;6470.676466176672;1160.878107798686;1170.30951738473;1173.1318824070297;1174.1898090317825;1177.0759953436511;763.3130182835381;774.3069952392577;781.9687212511436;783.3889566138421;795.677750511044;13292.534761283308;13302.800457993138;13390.531331403354;14085.014049016676;14264.358103885143;770.2836362183224;776.968921243144;778.6534991928537;779.6764342797676;787.8424315136881;6011.669358185254;6044.667543285073;6122.0510820821955;6239;6270.874582508324;144668;148985;149707.251463742;150022;151890;126839;138830;140983;142822;143546;117796.41101794437;119245;123250;125622;126233;14084.859151408764;14636.121832690073;14812.777808332668;14944.626384340478;15171.165585892883;57008.42991570031;57066.7146664264;57642;57909.13136303043;58325;72359.63820180866;72541;73214.63392683002;74792.25207747852;75485.6225718868;21937.232196873032;21949.122035118417;22159.335219943427;22164.77835221627;22259.77740222577;23974.40063998414;24589.877050614632;24919.626205607292;24970.750292496843;25164;22474.101035959033;22731.545369092855;22864.77135228693;22925.88537057304;22965.196218132285;19791.505212369804;19825.30611428593;19906.60186796227;19993.500162496053;20322.59354812925;21339.7866021344;21446.24938127158;21539.030743616888;21550.568988619827;21599.244026458997;14772.409103635735;15342;15409.614759630651;15505.224738763241;15812.288447019682;15165.545033649008;15545.533633990999;15622.765658515358;15646.530604081896;15774.447894323643 15:53:59 INFO - PID 3747 | __end_tp_report 15:53:59 INFO - PID 3747 | __start_cc_report 15:53:59 INFO - PID 3747 | _x_x_mozilla_cycle_collect,267 15:53:59 INFO - PID 3747 | __end_cc_report 15:53:59 INFO - PID 3747 | __startTimestamp1506293639139__endTimestamp 15:53:59 INFO - PID 3747 | 15:53:59 INFO - PID 3747 | ------- Summary: start ------- 15:53:59 INFO - PID 3747 | Number of tests: 6 15:53:59 INFO - PID 3747 | 15:53:59 INFO - PID 3747 | [#0] dojo.html Cycles:165 Average:6673.01 Median:6919.52 stddev:772.71 (11.2%) stddev-sans-first:745.73 15:53:59 INFO - PID 3747 | Values: 3984.3 3984.4 3992.1 3999.4 4059.4 6514.9 6598.3 6664.5 6664.6 6666.3 6585.7 6587.3 6588.8 6658.5 6679.7 5916.4 5934.3 5964.8 5981.8 5994.2 5932.1 5958.9 6019.9 6048.4 6065.5 5954.9 5982.8 5994.4 5996.3 6065.6 5930.6 6054.1 6086.0 6095.2 6096.5 5860.1 5940.4 5963.6 6020.2 6045.1 6446.5 6495.5 6495.6 6593.2 6602.3 7149.0 7207.2 7227.8 7232.3 7240.8 7165.2 7170.0 7226.7 7280.7 7295.8 6654.4 6735.8 6747.7 6759.0 6761.8 7300.5 7383.6 7420.1 7426.2 7509.7 7147.2 7151.9 7202.7 7226.3 7236.6 7293.7 7307.6 7346.7 7368.3 7372.9 7096.1 7126.9 7140.2 7166.8 7174.2 7132.3 7190.7 7225.6 7226.7 7230.3 5389.1 5450.4 5466.6 5474.0 5477.3 4912.3 4919.8 4952.5 4959.5 4969.5 6711.3 6792.8 6800.7 6852.1 6867.5 7220.6 7273.2 7282.8 7283.1 7289.3 6783.4 6805.5 6825.3 6883.9 6888.2 6206.3 6215.1 6286.8 6291.5 6295.6 7485.1 7499.7 7551.8 7565.8 7597.6 7046.1 7139.3 7209.8 7231.9 7239.5 7416.8 7418.3 7423.4 7506.9 7509.7 6954.5 7069.0 7073.8 7088.8 7157.6 7252.3 7254.5 7260.9 7273.0 7293.3 6885.8 6900.1 6968.5 6990.6 7012.8 6957.4 7018.4 7037.2 7104.5 7127.3 6919.5 6946.8 7009.2 7014.3 7018.1 7017.9 7073.6 7101.1 7155.5 7184.0 6783.7 6849.8 6859.3 6865.9 6878.6 15:53:59 INFO - PID 3747 | 15:53:59 INFO - PID 3747 | [#1] ext.html Cycles:180 Average:45875.90 Median:41670.58 stddev:68180.31 (163.6%) stddev-sans-first:68288.05 15:53:59 INFO - PID 3747 | Values: 930.2 978.6 995.7 1038.8 1039.2 44180.0 46066.8 46187.3 46216.5 46340.3 43386.8 43517.6 43559.8 43583.1 43870.0 8084.4 8224.8 8227.6 8229.5 8265.0 8155.6 8274.0 8277.0 8290.3 8301.3 8747.7 8886.8 8911.2 8915.4 8921.3 8764.0 8823.6 8824.3 8839.5 8851.1 8813.0 8838.2 8841.8 8895.4 8905.5 42522.0 42694.8 42957.4 42968.6 43207.4 3847.4 3888.2 3892.6 3901.1 3924.2 34678.3 34985.3 35044.0 35072.3 35149.8 5528.7 5573.2 5653.5 5691.2 5698.5 229948.0 235961.0 236452.0 238953.0 244212.0 55121.0 55804.4 55898.7 55983.0 56081.4 58605.0 58973.0 59030.7 59170.0 59583.4 17576.5 17608.2 17721.7 17767.9 17911.4 14599.3 14618.6 14728.2 14757.3 14850.1 16013.8 16108.3 16156.3 16174.4 16232.8 6277.3 6332.8 6382.1 6462.3 6568.7 1107.2 1111.6 1112.4 1116.6 1126.8 26138.5 26506.0 26515.3 26546.7 26625.6 1219.6 1235.2 1241.7 1258.3 1259.1 13984.6 14050.7 14065.9 14077.6 14147.2 292483.0 292747.0 297414.0 298375.0 298981.0 61597.7 62700.0 62741.7 62898.7 63301.4 1611.0 1611.5 1617.5 1639.0 1640.1 26090.9 26100.9 26119.2 26233.0 26407.7 43158.6 43209.8 43251.8 43286.5 43345.6 248480.0 249690.0 250176.0 250936.0 252139.0 38944.8 45396.5 45444.3 45658.3 45860.5 55381.2 55766.7 56490.0 56734.7 57162.0 40865.8 41040.6 41268.0 41459.0 41786.2 40115.8 40980.8 41211.6 41555.0 41862.0 49168.0 49219.0 49586.8 49722.8 49793.8 38862.0 38916.4 39064.6 39436.8 40254.0 28364.9 28829.4 29188.7 29662.4 29676.4 15:53:59 INFO - PID 3747 | 15:53:59 INFO - PID 3747 | [#2] jquery.html Cycles:180 Average:42060.72 Median:12988.84 stddev:109002.49 (839.2%) stddev-sans-first:109263.85 15:53:59 INFO - PID 3747 | Values: 615.1 623.6 638.4 645.8 652.4 23688.0 24007.5 24218.6 24510.0 24597.3 28047.4 28355.3 28364.6 28427.9 28480.1 6803.0 6981.0 6985.8 6988.6 6998.3 6803.4 6975.5 7024.3 7051.8 7071.2 6986.1 6993.9 7006.0 7018.1 7020.9 6971.4 6997.0 7016.6 7031.7 7035.1 6484.9 6513.8 6536.5 6543.7 6579.7 31711.4 32132.8 32441.8 32782.5 32783.2 2353.0 2386.1 2388.6 2389.6 2398.0 20534.6 21167.2 21196.8 21211.6 21221.7 2600.9 2650.8 2652.2 2673.2 2674.3 143446.3 148349.3 155107.0 161685.2 161808.0 16534.9 17465.7 17656.5 17716.4 17846.8 28317.9 28431.0 28480.4 28498.4 28588.0 11312.7 11365.0 11612.4 11616.8 11665.5 10397.5 10482.5 10507.2 10525.5 10653.1 10248.3 10292.3 10313.5 10548.3 10560.1 2922.8 2935.6 2944.9 3012.7 3075.9 1052.9 1072.5 1081.7 1088.9 1095.8 22209.7 22441.2 22565.1 22806.7 22822.0 1133.8 1142.7 1151.3 1153.4 1160.5 12293.9 12345.1 12468.9 12483.8 12505.5 645792.0 649363.0 649679.0 660023.0 664688.0 128573.4 131303.3 135414.0 138357.3 141043.0 1179.7 1258.9 1298.1 1317.2 1330.0 23624.6 23747.4 23953.3 24054.8 24289.5 64800.0 64829.4 64908.4 65244.7 66880.3 79844.6 81174.6 81689.0 81693.6 81929.6 16196.6 16243.5 16373.8 16501.1 16564.8 24588.4 24729.6 25120.4 25149.9 25231.2 18375.4 18469.6 18564.3 20198.3 20556.9 16011.2 16781.0 16871.3 18011.7 18675.3 19982.3 20534.5 20575.4 20726.8 20765.8 15836.4 16102.0 16220.0 16222.3 16233.6 20101.9 20201.5 20324.5 20413.4 20551.9 15:53:59 INFO - PID 3747 | 15:53:59 INFO - PID 3747 | [#3] mootools.html Cycles:180 Average:10812.80 Median:25344.99 stddev:7922.80 (31.3%) stddev-sans-first:7913.41 15:53:59 INFO - PID 3747 | Values: 1392.2 1452.4 1453.0 1455.4 1467.4 17550.7 18226.4 18247.4 18259.8 18293.4 17733.9 17822.5 17927.2 17935.0 17942.2 2850.3 2985.3 2996.4 3008.7 3009.9 2806.4 3001.5 3059.2 3066.8 3070.4 3036.2 3055.2 3069.0 3074.0 3075.6 2902.0 2911.7 2913.4 2913.8 2923.5 2828.3 2952.0 2989.5 2994.6 2996.7 17181.1 17185.7 17246.0 17372.6 17458.9 8604.0 8818.6 8869.7 8877.9 8879.8 6021.5 6080.2 6210.9 6236.2 6302.7 2126.1 2188.8 2207.4 2211.8 2247.7 31211.0 31236.5 31332.2 31348.8 31364.5 7259.6 7335.5 7402.9 7477.2 7525.4 19911.5 19987.1 19998.5 20002.2 20009.9 8027.3 8602.6 8658.6 8665.4 8672.4 7720.7 7786.1 7897.6 7975.6 7997.6 5652.8 5836.7 5875.0 5913.3 5915.0 1547.6 1586.9 1630.9 1707.7 1721.5 882.3 887.1 890.5 892.6 913.9 10200.4 10266.0 10324.6 10335.6 10539.3 1107.1 1110.8 1113.9 1124.5 1137.7 5347.8 5509.9 5545.4 6371.0 6479.0 24900.9 25453.7 25483.0 25738.0 25801.2 23809.6 25305.9 25384.1 26004.9 26140.2 13005.0 13065.2 13079.9 13157.2 13172.1 9344.9 9951.8 10092.7 10163.9 10244.4 21586.2 21977.0 22143.0 22385.9 22726.7 22715.3 22811.0 23043.9 23116.7 23300.3 12671.1 12797.2 12800.8 12845.9 12863.5 15582.6 15886.2 16019.4 16060.5 16090.8 11405.4 12392.7 12538.7 12566.0 12575.2 11885.1 12060.2 12134.6 12177.6 12349.6 11422.5 11620.5 11677.4 11679.5 11690.8 8728.0 8844.9 8876.2 8878.6 8898.6 8852.8 9053.0 9152.5 9176.4 9194.7 15:53:59 INFO - PID 3747 | 15:53:59 INFO - PID 3747 | [#4] prototype.html Cycles:180 Average:5826.73 Median:6456.27 stddev:1624.64 (25.2%) stddev-sans-first:1580.20 15:53:59 INFO - PID 3747 | Values: 551.0 559.7 576.7 582.8 593.6 6407.9 6457.0 6485.6 6523.5 6552.4 6373.3 6424.3 6425.3 6431.3 6539.9 5278.7 5290.6 5292.9 5304.7 5324.1 5058.6 5157.3 5198.5 5199.8 5220.4 5126.6 5128.0 5132.9 5150.3 5176.0 5080.2 5122.5 5158.9 5162.7 5171.1 4655.5 4664.8 4690.6 4702.3 4722.6 6344.7 6414.8 6432.0 6450.6 6455.6 6030.0 6037.7 6067.6 6105.4 6122.3 6886.9 6893.3 6912.5 6921.2 6978.2 5014.7 5205.5 5259.6 5262.2 5274.5 6941.3 7026.7 7055.2 7067.8 7148.9 5323.9 5341.4 5399.5 5433.8 5438.8 5395.2 5433.8 5453.3 5472.8 5509.4 6047.9 6078.9 6083.6 6104.2 6107.1 6862.8 6889.8 6907.6 6909.5 6931.9 1853.5 1853.7 1886.8 1891.7 1898.8 1306.0 1332.1 1333.6 1340.6 1351.8 6351.0 6387.7 6427.6 6440.6 6468.5 6968.2 7029.4 7038.9 7050.4 7050.8 6396.0 6413.2 6484.4 6484.6 6492.9 3622.3 3658.0 3661.9 3678.2 3704.0 7236.3 7265.3 7293.4 7295.9 7322.3 6935.4 6970.4 7001.3 7008.4 7080.7 7105.9 7154.9 7162.2 7223.3 7244.9 6837.6 6839.8 6844.0 6891.5 7044.8 6865.9 6868.4 6930.3 6957.1 6980.7 7174.0 7228.6 7243.0 7259.9 7321.8 5385.3 5386.2 5387.4 5389.3 5395.5 6711.7 6924.0 7011.4 7038.7 7068.9 6544.8 6682.2 6761.6 6766.6 6771.8 6583.7 6661.0 6707.0 6794.5 6821.6 6555.5 6647.1 6700.8 6727.0 6752.4 6842.2 6871.5 6874.9 6881.3 6924.4 6704.1 6706.3 6761.6 6766.2 6769.0 15:53:59 INFO - PID 3747 | 15:53:59 INFO - PID 3747 | [#5] yui.html Cycles:180 Average:29714.86 Median:20181.45 stddev:43014.78 (213.1%) stddev-sans-first:43081.46 15:53:59 INFO - PID 3747 | Values: 1011.7 1034.5 1044.2 1045.4 1064.9 19505.6 19895.0 20636.9 20732.5 20798.4 19973.8 20375.3 20392.7 20396.6 20398.4 1051.9 1087.2 1087.2 1087.5 1088.1 1067.3 1079.3 1104.6 1104.6 1104.8 1175.9 1185.8 1188.1 1188.9 1193.7 1172.7 1186.0 1187.7 1192.0 1192.3 872.4 873.1 873.8 876.7 877.6 19651.5 19939.0 20009.3 20040.3 21857.9 23769.4 23948.2 24328.1 24362.8 24559.6 18303.9 18455.3 18550.5 18775.9 18852.2 4121.0 4155.9 4173.2 4174.4 4175.7 154074.2 157529.0 160304.0 161977.2 163334.0 18241.5 18774.5 18802.2 18802.5 18809.3 34548.3 35735.3 35903.1 36054.3 36114.3 9420.8 9455.5 9477.4 9559.9 9570.4 5021.5 5112.5 5121.6 5126.3 5133.4 6336.6 6351.6 6397.8 6440.5 6470.7 1160.9 1170.3 1173.1 1174.2 1177.1 763.3 774.3 782.0 783.4 795.7 13292.5 13302.8 13390.5 14085.0 14264.4 770.3 777.0 778.7 779.7 787.8 6011.7 6044.7 6122.1 6239.0 6270.9 144668.0 148985.0 149707.3 150022.0 151890.0 126839.0 138830.0 140983.0 142822.0 143546.0 117796.4 119245.0 123250.0 125622.0 126233.0 14084.9 14636.1 14812.8 14944.6 15171.2 57008.4 57066.7 57642.0 57909.1 58325.0 72359.6 72541.0 73214.6 74792.3 75485.6 21937.2 21949.1 22159.3 22164.8 22259.8 23974.4 24589.9 24919.6 24970.8 25164.0 22474.1 22731.5 22864.8 22925.9 22965.2 19791.5 19825.3 19906.6 19993.5 20322.6 21339.8 21446.2 21539.0 21550.6 21599.2 14772.4 15342.0 15409.6 15505.2 15812.3 15165.5 15545.5 15622.8 15646.5 15774.4 15:53:59 INFO - PID 3747 | -------- Summary: end -------- 15:53:59 INFO - PID 3747 | 15:53:59 INFO - TEST-INFO | 3747: exit 0 15:53:59 INFO - TEST-OK | dromaeo_css | took 1111640ms 15:53:59 INFO - TEST-START | kraken 15:53:59 INFO - Initialising browser for kraken test... 15:53:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34770/getInfo.html -profile /tmp/tmpQ5uhV3/profile 15:53:59 INFO - TEST-INFO | started process 4111 (/builds/slave/test/build/application/firefox/firefox http://localhost:34770/getInfo.html) 15:54:05 INFO - TEST-INFO | 4111: exit 0 15:54:05 INFO - Browser initialized. 15:54:05 INFO - Running cycle 1/1 for kraken test... 15:54:05 INFO - Using env: {'DISPLAY': ':0', 15:54:05 INFO - 'HOME': '/home/cltbld', 15:54:05 INFO - 'JSGC_DISABLE_POISONING': '1', 15:54:05 INFO - 'LANG': 'en_US.UTF-8', 15:54:05 INFO - 'LANGUAGE': 'en_US:en', 15:54:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:54:05 INFO - 'LOGNAME': 'cltbld', 15:54:05 INFO - 'MAIL': '/var/mail/cltbld', 15:54:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:54:05 INFO - 'MOZ_CRASHREPORTER': '1', 15:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:54:05 INFO - 'MOZ_NO_REMOTE': '1', 15:54:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:05 INFO - 'NO_EM_RESTART': '1', 15:54:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:05 INFO - 'PWD': '/builds/slave/test', 15:54:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:05 INFO - 'RUST_BACKTRACE': 'full', 15:54:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:54:05 INFO - 'SHELL': '/bin/bash', 15:54:05 INFO - 'SHLVL': '1', 15:54:05 INFO - 'TERM': 'linux', 15:54:05 INFO - 'TMOUT': '86400', 15:54:05 INFO - 'USER': 'cltbld', 15:54:05 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506289715.981900-657334355', 15:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:05 INFO - '_': '/tools/buildbot/bin/python'} 15:54:05 INFO - TEST-INFO | started process 4305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ5uhV3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:16 INFO - PID 4305 | RSS: Main: 140922880 15:54:16 INFO - PID 4305 | 15:54:19 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34770/tests/kraken/driver.html?testName=audio-beat-detection) 15:54:20 INFO - PID 4305 | RSS: Main: 147251200 15:54:20 INFO - PID 4305 | 15:54:22 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34770/tests/kraken/driver.html?testName=audio-dft) 15:54:23 INFO - PID 4305 | RSS: Main: 147423232 15:54:23 INFO - PID 4305 | 15:54:26 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34770/tests/kraken/driver.html?testName=audio-fft) 15:54:26 INFO - PID 4305 | RSS: Main: 149143552 15:54:26 INFO - PID 4305 | 15:54:28 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34770/tests/kraken/driver.html?testName=audio-oscillator) 15:54:29 INFO - PID 4305 | RSS: Main: 148955136 15:54:29 INFO - PID 4305 | 15:54:31 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:54:32 INFO - PID 4305 | RSS: Main: 148553728 15:54:32 INFO - PID 4305 | 15:54:35 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34770/tests/kraken/driver.html?testName=imaging-darkroom) 15:54:35 INFO - PID 4305 | RSS: Main: 148647936 15:54:35 INFO - PID 4305 | 15:54:39 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34770/tests/kraken/driver.html?testName=imaging-desaturate) 15:54:39 INFO - PID 4305 | RSS: Main: 149934080 15:54:39 INFO - PID 4305 | 15:54:42 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34770/tests/kraken/driver.html?testName=json-parse-financial) 15:54:43 INFO - PID 4305 | RSS: Main: 151756800 15:54:43 INFO - PID 4305 | 15:54:44 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:54:45 INFO - PID 4305 | RSS: Main: 151678976 15:54:45 INFO - PID 4305 | 15:54:46 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34770/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:54:47 INFO - PID 4305 | RSS: Main: 151568384 15:54:47 INFO - PID 4305 | 15:54:49 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:54:50 INFO - PID 4305 | RSS: Main: 148910080 15:54:50 INFO - PID 4305 | 15:54:52 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:54:53 INFO - PID 4305 | RSS: Main: 148529152 15:54:53 INFO - PID 4305 | 15:54:55 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:54:56 INFO - PID 4305 | RSS: Main: 148529152 15:54:56 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | Cycle 1(1): loaded http://localhost:34770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34770/tests/kraken/driver.html?testName=ai-astar) 15:54:58 INFO - PID 4305 | RSS: Main: 149770240 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | __start_tp_report 15:54:58 INFO - PID 4305 | _x_x_mozilla_page_load 15:54:58 INFO - PID 4305 | _x_x_mozilla_page_load_details 15:54:58 INFO - PID 4305 | |i|pagename|runs| 15:54:58 INFO - PID 4305 | |0;ai-astar;105;105;105;105;105;106;106;104;107;105 15:54:58 INFO - PID 4305 | |1;audio-beat-detection;111;111;111;112;111;113;112;114;114;111 15:54:58 INFO - PID 4305 | |2;audio-dft;166;162;161;166;161;164;163;162;163;164 15:54:58 INFO - PID 4305 | |3;audio-fft;75;76;73;74;73;76;74;74;73;73 15:54:58 INFO - PID 4305 | |4;audio-oscillator;79;76;77;76;76;80;76;77;76;76 15:54:58 INFO - PID 4305 | |5;imaging-gaussian-blur;111;113;116;117;114;114;115;115;114;114 15:54:58 INFO - PID 4305 | |6;imaging-darkroom;148;148;148;149;150;149;149;151;149;148 15:54:58 INFO - PID 4305 | |7;imaging-desaturate;95;94;100;98;94;94;94;94;94;94 15:54:58 INFO - PID 4305 | |8;json-parse-financial;55;42;41;44;45;45;43;44;45;42 15:54:58 INFO - PID 4305 | |9;json-stringify-tinderbox;38;38;39;38;38;38;38;37;38;38 15:54:58 INFO - PID 4305 | |10;stanford-crypto-aes;69;69;70;72;69;69;72;69;70;70 15:54:58 INFO - PID 4305 | |11;stanford-crypto-ccm;107;107;105;109;103;106;113;110;106;105 15:54:58 INFO - PID 4305 | |12;stanford-crypto-pbkdf2;150;148;147;152;143;144;147;152;152;143 15:54:58 INFO - PID 4305 | |13;stanford-crypto-sha256-iterative;62;60;68;64;62;61;59;62;60;59 15:54:58 INFO - PID 4305 | __end_tp_report 15:54:58 INFO - PID 4305 | __start_cc_report 15:54:58 INFO - PID 4305 | _x_x_mozilla_cycle_collect,672 15:54:58 INFO - PID 4305 | __end_cc_report 15:54:58 INFO - PID 4305 | __startTimestamp1506293698352__endTimestamp 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | ------- Summary: start ------- 15:54:58 INFO - PID 4305 | Number of tests: 14 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#0] ai-astar Cycles:10 Average:105.30 Median:105.00 stddev:0.82 (0.8%) stddev-sans-first:0.87 15:54:58 INFO - PID 4305 | Values: 105.0 105.0 105.0 105.0 105.0 106.0 106.0 104.0 107.0 105.0 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#1] audio-beat-detection Cycles:10 Average:112.00 Median:112.00 stddev:1.25 (1.1%) stddev-sans-first:1.27 15:54:58 INFO - PID 4305 | Values: 111.0 111.0 111.0 112.0 111.0 113.0 112.0 114.0 114.0 111.0 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.81 (1.1%) stddev-sans-first:1.62 15:54:58 INFO - PID 4305 | Values: 166.0 162.0 161.0 166.0 161.0 164.0 163.0 162.0 163.0 164.0 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.00 stddev:1.20 (1.6%) stddev-sans-first:1.22 15:54:58 INFO - PID 4305 | Values: 75.0 76.0 73.0 74.0 73.0 76.0 74.0 74.0 73.0 73.0 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:76.50 stddev:1.45 (1.9%) stddev-sans-first:1.32 15:54:58 INFO - PID 4305 | Values: 79.0 76.0 77.0 76.0 76.0 80.0 76.0 77.0 76.0 76.0 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.50 stddev:1.64 (1.4%) stddev-sans-first:1.22 15:54:58 INFO - PID 4305 | Values: 111.0 113.0 116.0 117.0 114.0 114.0 115.0 115.0 114.0 114.0 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 15:54:58 INFO - PID 4305 | Values: 148.0 148.0 148.0 149.0 150.0 149.0 149.0 151.0 149.0 148.0 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.00 stddev:2.13 (2.3%) stddev-sans-first:2.26 15:54:58 INFO - PID 4305 | Values: 95.0 94.0 100.0 98.0 94.0 94.0 94.0 94.0 94.0 94.0 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#8] json-parse-financial Cycles:10 Average:44.60 Median:44.50 stddev:3.92 (8.8%) stddev-sans-first:1.51 15:54:58 INFO - PID 4305 | Values: 55.0 42.0 41.0 44.0 45.0 45.0 43.0 44.0 45.0 42.0 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.47 (1.2%) stddev-sans-first:0.50 15:54:58 INFO - PID 4305 | Values: 38.0 38.0 39.0 38.0 38.0 38.0 38.0 37.0 38.0 38.0 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#10] stanford-crypto-aes Cycles:10 Average:69.90 Median:70.00 stddev:1.20 (1.7%) stddev-sans-first:1.22 15:54:58 INFO - PID 4305 | Values: 69.0 69.0 70.0 72.0 69.0 69.0 72.0 69.0 70.0 70.0 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#11] stanford-crypto-ccm Cycles:10 Average:107.10 Median:107.00 stddev:2.88 (2.7%) stddev-sans-first:3.06 15:54:58 INFO - PID 4305 | Values: 107.0 107.0 105.0 109.0 103.0 106.0 113.0 110.0 106.0 105.0 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:149.00 stddev:3.65 (2.4%) stddev-sans-first:3.78 15:54:58 INFO - PID 4305 | Values: 150.0 148.0 147.0 152.0 143.0 144.0 147.0 152.0 152.0 143.0 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:2.71 (4.4%) stddev-sans-first:2.87 15:54:58 INFO - PID 4305 | Values: 62.0 60.0 68.0 64.0 62.0 61.0 59.0 62.0 60.0 59.0 15:54:58 INFO - PID 4305 | -------- Summary: end -------- 15:54:58 INFO - PID 4305 | 15:54:58 INFO - PID 4305 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:54:58 INFO - TEST-INFO | 4305: exit 0 15:54:59 INFO - TEST-OK | kraken | took 59189ms 15:54:59 INFO - SUITE-END | took 1170s 15:54:59 INFO - Completed test suite (00:19:30) 15:54:59 INFO - javascript benchmark 15:54:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9570.89118554094, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3984.2629113613966, 3984.3824207247876, 3992.061865461618, 3999.3800960851077, 4059.3707975263846, 6514.925037368835, 6598.274189839114, 6664.533482656216, 6664.633445160514, 6666.333366663337, 6585.736570537185, 6587.275399706028, 6588.835279118024, 6658.467322614191, 6679.699413526391, 5916.3787802280785, 5934.258217722785, 5964.79123230687, 5981.760729570812, 5994.160817485545, 5932.080527518242, 5958.940410595904, 6019.879602407949, 6048.425399587032, 6065.454109130177, 5954.9404505955035, 5982.79060232892, 5994.43052909975, 5996.310424301196, 6065.575409721321, 5930.55520835939, 6054.061620448838, 6085.969570152165, 6095.207623008981, 6096.4817990470865, 5860.120981852713, 5940.37626049263, 5963.642181469082, 6020.217371741689, 6045.12345709874, 6446.452051575622, 6495.512836537278, 6495.642739649317, 6593.175853018372, 6602.339766023408, 7148.964255178743, 7207.207207207203, 7227.7831665050135, 7232.276772322778, 7240.782776516713, 7165.176004759467, 7170.0, 7226.710931562731, 7280.745173918887, 7295.781126566211, 6654.434373078294, 6735.797926062226, 6747.662616869137, 6758.966205168943, 6761.830954226134, 7300.501709807075, 7383.556986580822, 7420.146683131509, 7426.220246874109, 7509.7371591994015, 7147.1780745214965, 7151.89272160918, 7202.675879585431, 7226.313500217471, 7236.638168091575, 7293.708251669874, 7307.561546307133, 7346.742863999734, 7368.263173682696, 7372.894065890159, 7096.077509923677, 7126.893096603555, 7140.178879428829, 7166.820829479305, 7174.246704096099, 7132.322429369202, 7190.712371505186, 7225.5664660120565, 7226.710931562784, 7230.276972302728, 5389.137737961907, 5450.427705090988, 5466.562674985991, 5473.972630136824, 5477.260569823103, 4912.336834527365, 4919.7540122993705, 4952.529509696573, 4959.479254678279, 4969.527894849984, 6711.328867113347, 6792.830179245559, 6800.65996700163, 6852.074969879102, 6867.450603951672, 7220.638968051577, 7273.199948005715, 7282.781516554512, 7283.126024877049, 7289.343959043712, 6783.423409010191, 6805.455563554904, 6825.283345248777, 6883.931160688429, 6888.173419189629, 6206.348333425016, 6215.098810672427, 6286.779962701284, 6291.496680265568, 6295.559310848196, 7485.1017877855, 7499.737509187153, 7551.848963020709, 7565.773026809205, 7597.5821329826285, 7046.1192350956135, 7139.321764432267, 7209.819754506179, 7231.891521627074, 7239.529430586995, 7416.814579635552, 7418.332350088518, 7423.406127509678, 7506.9249307506225, 7509.699612015458, 6954.513184077066, 7068.964655176691, 7073.787786366417, 7088.822779430349, 7157.606331651809, 7252.311030452099, 7254.492185546961, 7260.854782904418, 7272.96363518179, 7293.270672932665, 6885.827854303682, 6900.137482814648, 6968.547044442298, 6990.61551614666, 7012.789616311519, 6957.443404527727, 7018.403435707818, 7037.225905150327, 7104.467164962545, 7127.287271272831, 6919.515633905578, 6946.826329341807, 7009.193942696451, 7014.2635023323855, 7018.122734658168, 7017.859642807013, 7073.610951397517, 7101.147862256562, 7155.499115061895, 7184.0, 6783.660816959034, 6849.794506164823, 6859.314068593101, 6865.897011544931, 6878.55289406187], "value": 6621.046969048831, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [930.2325581395348, 978.6379039755287, 995.7411073120988, 1038.8441733739933, 1039.199816141571, 44180.0, 46066.769666151704, 46187.307190392174, 46216.53783462168, 46340.304895426554, 43386.7830660847, 43517.56482435175, 43559.78220108903, 43583.128337433314, 43870.0, 8084.353251739862, 8224.794380140485, 8227.629756660936, 8229.547374894379, 8265.0, 8155.632996515171, 8273.958630206871, 8276.958615206915, 8290.336773058141, 8301.335893128535, 8747.693830715927, 8886.822263554724, 8911.242544383735, 8915.375923685344, 8921.33090018248, 8764.03595604483, 8823.647054117828, 8824.294056475466, 8839.469631822047, 8851.07063758309, 8813.0, 8838.204561589488, 8841.778955526099, 8895.421797583202, 8905.465672059698, 42522.0, 42694.78652606748, 42957.35563966543, 42968.57031429708, 43207.35188972168, 3847.4228865670093, 3888.183481468895, 3892.591277915835, 3901.08324543732, 3924.1759230561615, 34678.306433871185, 34985.300293993976, 35044.0, 35072.29855402878, 35149.824250878584, 5528.695921724304, 5573.191887176377, 5653.491185793298, 5691.203231547545, 5698.487136157724, 229947.99999999834, 235961.0, 236452.0, 238953.0, 244212.0, 55121.0, 55804.44195558074, 55898.72050639721, 55983.0, 56081.43918560844, 58605.0, 58973.0, 59030.70484647549, 59170.0, 59583.40416595865, 17576.472705818847, 17608.207630656652, 17721.7341739874, 17767.911160444117, 17911.373101941368, 14599.270036498132, 14618.634534136732, 14728.189949552663, 14757.335919883417, 14850.108993460426, 16013.839861601467, 16108.275127619285, 16156.27296771648, 16174.353025879069, 16232.837671623369, 6277.296395126897, 6332.778352757631, 6382.106505089291, 6462.289148193695, 6568.737250510022, 1107.241539545398, 1111.5664890692635, 1112.404863398078, 1116.558959211107, 1126.752114534801, 26138.477230455286, 26506.0, 26515.337116571853, 26546.734532654813, 26625.600615990777, 1219.5792451604182, 1235.1600911380167, 1241.6833707404553, 1258.3456602566798, 1259.118616968126, 13984.580462586138, 14050.718985620231, 14065.859341406454, 14077.577672669837, 14147.151170929777, 292483.0, 292747.0, 297414.0, 298375.0, 298981.0, 61597.69201154055, 62700.0, 62741.68629156825, 62898.685506572176, 63301.36698633047, 1611.0253296755295, 1611.4762702121857, 1617.4500669772099, 1639.049351376199, 1640.0897501886568, 26090.86954565215, 26100.8694956524, 26119.216423507325, 26233.0, 26407.735922640528, 43158.56841431546, 43209.7839510813, 43251.78374108109, 43286.48497302579, 43345.56654433415, 248480.0, 249690.0, 250176.0, 250936.0, 252139.0, 38944.80527597344, 45396.546034539235, 45444.31833522566, 45658.315125272486, 45860.54139458696, 55381.16928245999, 55766.72116639391, 56490.0, 56734.71632641975, 57162.0, 40865.79567102146, 41040.58959410368, 41268.0, 41459.0, 41786.1642767149, 40115.79942100271, 40980.79509602552, 41211.587884120774, 41555.0, 41861.95345116275, 49168.0, 49219.0, 49586.75206623944, 49722.75138624284, 49793.75103124461, 38862.0, 38916.41625375678, 39064.60935390723, 39436.802815985735, 40254.0, 28364.858175709815, 28829.423411531232, 29188.70811291945, 29662.406751865274, 29676.406471870872], "value": 19998.67725810013, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.132662945247, 623.5635055461175, 638.4157184363187, 645.8256270806879, 652.3769799841151, 23688.0, 24007.519849603, 24218.63672044916, 24509.999999999978, 24597.26208213752, 28047.439051218964, 28355.291117722067, 28364.574531382044, 28427.85786071067, 28480.145595632162, 6802.96598517008, 6981.0, 6985.79042628722, 6988.61562614056, 6998.3001699829865, 6803.421709154728, 6975.476839237052, 7024.262452442496, 7051.823704407379, 7071.1868135164605, 6986.056882320898, 6993.89509157363, 7005.964970175142, 7018.087648605674, 7020.894686579705, 6971.372576468142, 6996.965015174917, 7016.614086225256, 7031.683574239146, 7035.050268213802, 6484.93515064848, 6513.837154071139, 6536.477081833442, 6543.705533251015, 6579.703913323912, 31711.365772684418, 32132.83933580317, 32441.837790811132, 32782.50826237608, 32783.18042048944, 2353.0352555452355, 2386.069432921162, 2388.593939030369, 2389.629607410854, 2398.0, 20534.5893082139, 21167.15331386758, 21196.788032119788, 21211.575768484698, 21221.68167477489, 2600.8699565021675, 2650.761431471177, 2652.1778248742953, 2673.1980405878157, 2674.251209661298, 143446.2827685855, 148349.25825370912, 155107.0, 161685.19157404255, 161808.0, 16534.917325413535, 17465.7380139298, 17656.470305890845, 17716.379926702502, 17846.821531784775, 28317.858410707813, 28431.0, 28480.430391392056, 28498.430031399257, 28588.0, 11312.717182070513, 11365.0, 11612.361320127475, 11616.767664646659, 11665.475053622607, 10397.532111055021, 10482.47587620616, 10507.159427245802, 10525.473726313654, 10653.147748180281, 10248.282620216662, 10292.279540432248, 10313.535890884777, 10548.314359566604, 10560.102391296672, 2922.8100173488656, 2935.6036935013926, 2944.926376840553, 3012.743926722439, 3075.8923437679573, 1052.899974502421, 1072.463768115942, 1081.7241603391085, 1088.8965548272902, 1095.7972775036644, 22209.666854997187, 22441.21455749041, 22565.09739610397, 22806.65790013151, 22822.0, 1133.777795520772, 1142.714321419645, 1151.268944220426, 1153.3656488931053, 1160.5241850841114, 12293.93853030747, 12345.135840491079, 12468.937655311665, 12483.812742808865, 12505.499780008699, 645792.0, 649363.0, 649679.0, 660023.0, 664688.0, 128573.35713321561, 131303.34348328196, 135414.0, 138357.3082134603, 141043.0, 1179.6520026592175, 1258.9496420143091, 1298.1367390685277, 1317.2162563274835, 1329.9601011969658, 23624.645630315903, 23747.40631484227, 23953.281401557982, 24054.759452405953, 24289.51420971606, 64800.0279995791, 64829.35170648233, 64908.35091649212, 65244.673776630814, 66880.33119668742, 79844.60077699574, 81174.59412703135, 81689.0, 81693.59153204196, 81929.59035204786, 16196.595085122495, 16243.51269461918, 16373.83626163723, 16501.09243991592, 16564.751528726836, 24588.385290367885, 24729.62905556454, 25120.37199069965, 25149.87425062936, 25231.243062707414, 18375.356862509747, 18469.630607388044, 18564.257429702662, 20198.29305974284, 20556.897215513825, 16011.19944002772, 16781.0, 16871.325146993982, 18011.72982405239, 18675.346362877233, 19982.30061947825, 20534.486637834172, 20575.38273851787, 20726.792732072485, 20765.792342076387, 15836.445724399591, 16102.03387796736, 16220.026798392135, 16222.26999784989, 16233.59416014609, 20101.899490502456, 20201.494962625464, 20324.491887702334, 20413.38759837207, 20551.897240513703], "value": 13404.883810978994, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.2133994293224, 1452.3754785442263, 1453.0, 1455.374189098687, 1467.4423718986784, 17550.73673894891, 18226.362077327278, 18247.361342352986, 18259.817401825978, 18293.359732409368, 17733.91133044333, 17822.46532604021, 17927.193276302565, 17935.0, 17942.19260133294, 2850.2589326775083, 2985.2686091907512, 2996.370762139953, 3008.6840881707435, 3009.86455609497, 2806.4387122575463, 3001.5197568389062, 3059.219898925771, 3066.7546596272355, 3070.4319700855303, 3036.195408216813, 3055.1903745507457, 3069.002574163406, 3073.9846300768577, 3075.584796052538, 2902.042326032404, 2911.708829117082, 2913.388188480422, 2913.8106023108535, 2923.5468502382164, 2828.349479619699, 2951.970480295191, 2989.491786396296, 2994.550817377389, 2996.6553846307734, 17181.140942952803, 17185.656286874317, 17246.0, 17372.56568585783, 17458.91270543652, 8604.0, 8818.559072046437, 8869.73390798277, 8877.866831997526, 8879.822403551958, 6021.458068773788, 6080.209572755558, 6210.937890621081, 6236.220472440945, 6302.653354065525, 2126.1176611706123, 2188.84678072535, 2207.381933058746, 2211.7677643847487, 2247.6965609642652, 31211.0, 31236.531452028237, 31332.21669458259, 31348.843255783802, 31364.529532057037, 7259.564426134449, 7335.523190992569, 7402.925970740332, 7477.214892436325, 7525.397968162534, 19911.502212444804, 19987.100580473914, 19998.50003749918, 20002.19991200365, 20009.899950500156, 8027.277545020859, 8602.61288242018, 8658.610362533702, 8665.35009874262, 8672.392932494664, 7720.652570634335, 7786.104597971193, 7897.578435881596, 7975.5613441261285, 7997.600119994094, 5652.802151924663, 5836.678982655994, 5875.0, 5913.319968203626, 5915.0, 1547.582152818755, 1586.912719800422, 1630.8858379913293, 1707.7353010283177, 1721.4921598128583, 882.289756745813, 887.1306120002305, 890.4523717913437, 892.5626443042992, 913.8537833946536, 10200.4389758564, 10266.0, 10324.587016519405, 10335.638252661121, 10539.314944528582, 1107.1032463704264, 1110.7945030169444, 1113.905318047975, 1124.5276983666715, 1137.732632831284, 5347.786088556492, 5509.889802203934, 5545.445455454423, 6370.980643097082, 6478.967605162038, 24900.875495622407, 25453.74546254514, 25483.0, 25738.0, 25801.22596322113, 23809.642855356837, 25305.873470632898, 25384.11155609545, 26004.869975650377, 26140.215793526226, 13005.0, 13065.216087034809, 13079.934600326937, 13157.210567365988, 13172.14381065247, 9344.906550934404, 9951.751206219902, 10092.697219083439, 10163.94918025405, 10244.436555989492, 21586.244481443075, 21977.0, 22143.0035648393, 22385.888070559544, 22726.659100113182, 22715.31854044381, 22811.0, 23043.88478057599, 23116.653250201598, 23300.3009909703, 12671.113022088366, 12797.168184068007, 12800.807987880004, 12845.871541284841, 12863.485460581845, 15582.610434739223, 15886.205689715236, 16019.35922563131, 16060.518184454486, 16090.758638620664, 11405.429728513707, 12392.690182745142, 12538.686532836751, 12566.0, 12575.182613130117, 11885.108616853599, 12060.216085954386, 12134.575289864812, 12177.573784917486, 12349.629511114681, 11422.48598813072, 11620.477078531318, 11677.357745323749, 11679.474423650787, 11690.76618467643, 8728.036191856781, 8844.867326989972, 8876.156765107304, 8878.600462979051, 8898.55507224649, 8852.778680533038, 9053.049429809775, 9152.450852948577, 9176.35765496409, 9194.724158275263], "value": 7593.524926220452, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.975206115725, 559.7313289620981, 576.7001159397113, 582.8426324892276, 593.5518683394037, 6407.860148527223, 6456.96771516143, 6485.610863348196, 6523.543351965364, 6552.410283074522, 6373.298937116925, 6424.293327733945, 6425.293217746044, 6431.26040505342, 6539.934600653992, 5278.709670968095, 5290.597991532247, 5292.947070529284, 5304.655197412156, 5324.094903866333, 5058.620603454738, 5157.329547158864, 5198.45416231296, 5199.766010529516, 5220.373555173384, 5126.5898728101665, 5128.0, 5132.871678208056, 5150.33045704058, 5176.0, 5080.187170052811, 5122.462141475129, 5158.884857208545, 5162.690238585678, 5171.120909445403, 4655.4878963314, 4664.766761661904, 4690.5778479936625, 4702.31816386622, 4722.5513576210205, 6344.6827658616885, 6414.839629009265, 6431.967840160769, 6450.6452145132, 6455.580387274859, 6029.969850150721, 6037.698115094272, 6067.635941843503, 6105.419985101408, 6122.326544080148, 6886.8622627547165, 6893.27715552359, 6912.516123871281, 6921.204061532938, 6978.197507286676, 5014.699118052892, 5205.531502164786, 5259.579233661298, 5262.158054711228, 5274.472552744694, 6941.271166527493, 7026.683799228996, 7055.15338159419, 7067.752628657972, 7148.892766608505, 5323.893522129536, 5341.370881881064, 5399.541039011649, 5433.8369848904595, 5438.782448702087, 5395.21769343443, 5433.782648694087, 5453.291072160594, 5472.753726082336, 5509.449055094458, 6047.879042419127, 6078.878422431527, 6083.6349819011, 6104.236970378703, 6107.083937409336, 6862.794116176523, 6889.793306200822, 6907.620080895599, 6909.516333856582, 6931.930680693229, 1853.4810253129147, 1853.6746226448154, 1886.830185283331, 1891.725699773525, 1898.784777742246, 1305.9608211753662, 1332.1474256475863, 1333.626364844212, 1340.5844188301658, 1351.7837146056584, 6351.0, 6387.712552935129, 6427.550071495044, 6440.581362211441, 6468.5472016958365, 6968.163820341591, 7029.402500787491, 7038.92961070393, 7050.4007159391, 7050.753223637148, 6395.96191808887, 6413.166288382574, 6484.351564843478, 6484.643344615997, 6492.935070649233, 3622.3117607654463, 3657.9817100914856, 3661.9450708239397, 3678.1540245743095, 3703.9814800925824, 7236.34872861445, 7265.273472652798, 7293.416526677853, 7295.89056164158, 7322.267773222635, 6935.445164386837, 6970.372666459942, 7001.264867188974, 7008.439324853999, 7080.716771329089, 7105.928940710527, 7154.851865179305, 7162.247963963813, 7223.27767223284, 7244.927550724531, 6837.555558888656, 6839.760608378683, 6844.0152355818245, 6891.518323560458, 7044.823879402851, 6865.931340686529, 6868.381845633917, 6930.341617546325, 6957.095577574883, 6980.650967451708, 7174.0, 7228.602426866572, 7242.971967849011, 7259.891101633585, 7321.816954576178, 5385.27298814655, 5386.245925570502, 5387.434319396407, 5389.299391079135, 5395.487428694268, 6711.697973591297, 6924.0, 7011.368976792113, 7038.683259253244, 7068.893966590608, 6544.770933017321, 6682.231543372574, 6761.594304341756, 6766.627835469097, 6771.762988295386, 6583.736650534117, 6661.0, 6707.0, 6794.456443484411, 6821.590704557742, 6555.508336874658, 6647.135872336566, 6700.83247918806, 6726.966365168143, 6752.426043786333, 6842.247352791289, 6871.518993670595, 6874.896876546956, 6881.277465866012, 6924.446044316342, 6704.094947182263, 6706.295838936841, 6761.594304341756, 6766.15423072116, 6769.0], "value": 5357.231347388791, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1011.7268337548862, 1034.5241189053036, 1044.1698849414715, 1045.414567842008, 1064.9148068154548, 19505.609887802235, 19895.0, 20636.896815515902, 20732.48168795781, 20798.376048718543, 19973.800261997374, 20375.28686495973, 20392.694109588367, 20396.59206815863, 20398.388048358574, 1051.9211059170573, 1087.1520214232871, 1087.179179719311, 1087.48344536345, 1088.0588291128156, 1067.2849191042021, 1079.3200283821182, 1104.5857803323754, 1104.6133853151373, 1104.8232282834747, 1175.8588969323694, 1185.8221266809962, 1188.1148544334483, 1188.934608596527, 1193.7314104326501, 1172.7009612548832, 1185.9703507412298, 1187.726822830745, 1191.970200744984, 1192.326335620376, 872.3718922375879, 873.1007062725403, 873.8077622922947, 876.6668665906979, 877.6006916852881, 19651.508712282164, 19939.0, 20009.29967451147, 20040.298589549297, 21857.890710546344, 23769.405764855845, 23948.16181433659, 24328.1485148019, 24362.756372436226, 24559.631605525752, 18303.908480457514, 18455.261789528402, 18550.536236594056, 18775.906120469448, 18852.15165317564, 4120.96975756061, 4155.854545090907, 4173.24881521326, 4174.394712766662, 4175.68682348825, 154074.22962885114, 157529.0, 160304.0, 161977.1901140487, 163334.0, 18241.45275641733, 18774.530636733918, 18802.153903074395, 18802.52993675169, 18809.34167304165, 34548.309033819685, 35735.28529429397, 35903.102422439646, 36054.278914421564, 36114.27771444556, 9420.811583768285, 9455.479948602755, 9477.431354118775, 9559.90440095604, 9570.377925434963, 5021.472745361684, 5112.514311140436, 5121.641485096007, 5126.333576635014, 5133.409657889316, 6336.556441049174, 6351.587146835441, 6397.776077837253, 6440.452561532228, 6470.676466176672, 1160.878107798686, 1170.30951738473, 1173.1318824070297, 1174.1898090317825, 1177.0759953436511, 763.3130182835381, 774.3069952392577, 781.9687212511436, 783.3889566138421, 795.677750511044, 13292.534761283308, 13302.800457993138, 13390.531331403354, 14085.014049016676, 14264.358103885143, 770.2836362183224, 776.968921243144, 778.6534991928537, 779.6764342797676, 787.8424315136881, 6011.669358185254, 6044.667543285073, 6122.0510820821955, 6239.0, 6270.874582508324, 144668.0, 148985.0, 149707.251463742, 150022.0, 151890.0, 126839.0, 138830.0, 140983.0, 142822.0, 143546.0, 117796.41101794437, 119245.0, 123250.0, 125622.0, 126233.0, 14084.859151408764, 14636.121832690073, 14812.777808332668, 14944.626384340478, 15171.165585892883, 57008.42991570031, 57066.7146664264, 57642.0, 57909.13136303043, 58325.0, 72359.63820180866, 72541.0, 73214.63392683002, 74792.25207747852, 75485.6225718868, 21937.232196873032, 21949.122035118417, 22159.335219943427, 22164.77835221627, 22259.77740222577, 23974.40063998414, 24589.877050614632, 24919.626205607292, 24970.750292496843, 25164.0, 22474.101035959033, 22731.545369092855, 22864.77135228693, 22925.88537057304, 22965.196218132285, 19791.505212369804, 19825.30611428593, 19906.60186796227, 19993.500162496053, 20322.59354812925, 21339.7866021344, 21446.24938127158, 21539.030743616888, 21550.568988619827, 21599.244026458997, 14772.409103635735, 15342.0, 15409.614759630651, 15505.224738763241, 15812.288447019682, 15165.545033649008, 15545.533633990999, 15622.765658515358, 15646.530604081896, 15774.447894323643], "value": 10644.19813661859, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1358.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 105.0, 105.0, 106.0, 106.0, 104.0, 107.0, 105.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 112.0, 111.0, 113.0, 112.0, 114.0, 114.0, 111.0], "value": 112.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 161.0, 166.0, 161.0, 164.0, 163.0, 162.0, 163.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 73.0, 74.0, 73.0, 76.0, 74.0, 74.0, 73.0, 73.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 77.0, 76.0, 76.0, 80.0, 76.0, 77.0, 76.0, 76.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 116.0, 117.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 150.0, 149.0, 149.0, 151.0, 149.0, 148.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 100.0, 98.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 42.0, 41.0, 44.0, 45.0, 45.0, 43.0, 44.0, 45.0, 42.0], "value": 44.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 72.0, 69.0, 69.0, 72.0, 69.0, 70.0, 70.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 105.0, 109.0, 103.0, 106.0, 113.0, 110.0, 106.0, 105.0], "value": 107.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 147.0, 152.0, 143.0, 144.0, 147.0, 152.0, 152.0, 143.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 68.0, 64.0, 62.0, 61.0, 59.0, 62.0, 60.0, 59.0], "value": 61.7, "unit": "score"}]}]} 15:54:59 INFO - Return code: 0 15:54:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:54:59 INFO - # TBPL SUCCESS # 15:54:59 INFO - Running post-action listener: _package_coverage_data 15:54:59 INFO - Running post-action listener: _resource_record_post_action 15:54:59 INFO - [mozharness: 2017-09-24 22:54:59.144257Z] Finished run-tests step (success) 15:54:59 INFO - Running post-run listener: _resource_record_post_run 15:54:59 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 9367552; Write bytes: 408535040; Read time: 3248; Write time: 461432 15:54:59 INFO - TinderboxPrint: CPU usage
13.1% 15:54:59 INFO - TinderboxPrint: I/O read bytes / time
9,367,552 / 3,248 15:54:59 INFO - TinderboxPrint: I/O write bytes / time
408,535,040 / 461,432 15:54:59 INFO - TinderboxPrint: CPU idle
8,217.7 (86.9%) 15:54:59 INFO - TinderboxPrint: CPU user
1,180.0 (12.5%) 15:54:59 INFO - TinderboxPrint: Swap in / out
0 / 0 15:54:59 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 577536; Read time: 0; Write time: 68 15:54:59 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:54:59 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 7622656; Write bytes: 407957504; Read time: 3208; Write time: 461364 15:54:59 INFO - Running post-run listener: _upload_blobber_files 15:54:59 INFO - Blob upload gear active. 15:54:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:54:59 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 15:54:59 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:54:59 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:55:00 INFO - (blobuploader) - INFO - Open directory for files ... 15:55:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:55:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:55:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:01 INFO - (blobuploader) - INFO - Done attempting. 15:55:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:55:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:04 INFO - (blobuploader) - INFO - Done attempting. 15:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:55:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:05 INFO - (blobuploader) - INFO - Done attempting. 15:55:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:55:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:55:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:06 INFO - (blobuploader) - INFO - Done attempting. 15:55:06 INFO - (blobuploader) - INFO - Iteration through files over. 15:55:06 INFO - Return code: 0 15:55:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:55:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:55:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c6042df4c70cec925cbe037ac23044f4ac8fc61fa777259fdd47c423969ebd33ce9bc2caf3d54f08dc2cd1364d85e3e3fadc25c2dad4b9d0d3b850baa400663e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/828ad09ef7e895b0874a77e2da55f3290464280232697fc14a47eb23eef2f63e850cbf7b6167d1a8aa8c63bd8d75dce37a154ea3ac382a64bc2c550f7eb7404f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e78ee37312726b54817df38d3ef899d399d711fcbadf77135660d0532c15c511f70bd99c3d1df14b1a454bf6b0bd24b58c3b00d4250a4654aa7b2e448d7a2f63", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/22abd410e499d32be70b22c5afa566a5aa9523ad5aaf3cbd7c32eeb775f893db8b806db80d4998b6981c8a490840101365053501d2a04b2b2cdb9896e30a212f"} 15:55:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:55:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:55:06 INFO - Contents: 15:55:06 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c6042df4c70cec925cbe037ac23044f4ac8fc61fa777259fdd47c423969ebd33ce9bc2caf3d54f08dc2cd1364d85e3e3fadc25c2dad4b9d0d3b850baa400663e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/828ad09ef7e895b0874a77e2da55f3290464280232697fc14a47eb23eef2f63e850cbf7b6167d1a8aa8c63bd8d75dce37a154ea3ac382a64bc2c550f7eb7404f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e78ee37312726b54817df38d3ef899d399d711fcbadf77135660d0532c15c511f70bd99c3d1df14b1a454bf6b0bd24b58c3b00d4250a4654aa7b2e448d7a2f63", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/22abd410e499d32be70b22c5afa566a5aa9523ad5aaf3cbd7c32eeb775f893db8b806db80d4998b6981c8a490840101365053501d2a04b2b2cdb9896e30a212f"} 15:55:06 INFO - Running post-run listener: copy_logs_to_upload_dir 15:55:06 INFO - Copying logs to upload dir... 15:55:06 INFO - mkdir: /builds/slave/test/build/upload/logs 15:55:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.501713 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-24 15:55:06.572149) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 15:55:06.581047) ========= 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=5c37b704b588aaa989324530000001d0-1506289715.981900-657334355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c6042df4c70cec925cbe037ac23044f4ac8fc61fa777259fdd47c423969ebd33ce9bc2caf3d54f08dc2cd1364d85e3e3fadc25c2dad4b9d0d3b850baa400663e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/828ad09ef7e895b0874a77e2da55f3290464280232697fc14a47eb23eef2f63e850cbf7b6167d1a8aa8c63bd8d75dce37a154ea3ac382a64bc2c550f7eb7404f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e78ee37312726b54817df38d3ef899d399d711fcbadf77135660d0532c15c511f70bd99c3d1df14b1a454bf6b0bd24b58c3b00d4250a4654aa7b2e448d7a2f63", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/22abd410e499d32be70b22c5afa566a5aa9523ad5aaf3cbd7c32eeb775f893db8b806db80d4998b6981c8a490840101365053501d2a04b2b2cdb9896e30a212f"} build_url:https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/JeC8jvYvSYCrCKD2IK2IQA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c6042df4c70cec925cbe037ac23044f4ac8fc61fa777259fdd47c423969ebd33ce9bc2caf3d54f08dc2cd1364d85e3e3fadc25c2dad4b9d0d3b850baa400663e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/828ad09ef7e895b0874a77e2da55f3290464280232697fc14a47eb23eef2f63e850cbf7b6167d1a8aa8c63bd8d75dce37a154ea3ac382a64bc2c550f7eb7404f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e78ee37312726b54817df38d3ef899d399d711fcbadf77135660d0532c15c511f70bd99c3d1df14b1a454bf6b0bd24b58c3b00d4250a4654aa7b2e448d7a2f63", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/22abd410e499d32be70b22c5afa566a5aa9523ad5aaf3cbd7c32eeb775f893db8b806db80d4998b6981c8a490840101365053501d2a04b2b2cdb9896e30a212f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 15:55:06.615163) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:55:06.615477) ========= 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=5c37b704b588aaa989324530000001d0-1506289715.981900-657334355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:55:06.697478) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 15:55:06.699110) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 15:55:06.699424) ========= ========= Total master_lag: 0.32 =========