builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-048 starttime: 1505504425.04 results: success (0) revision: 7aceaf8bcb9f582db0f93488b48ef7019e348dba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:25.036694) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:25.037166) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:25.037439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:25.099801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:25.100074) ========= 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=fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-15 12:40: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% 49.9M=0s 2017-09-15 12:40:25 (49.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.179651 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:25.338423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:25.338787) ========= 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=fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014112 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:25.388703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:25.392101) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7aceaf8bcb9f582db0f93488b48ef7019e348dba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 7aceaf8bcb9f582db0f93488b48ef7019e348dba --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=fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-15 12:40:25,365 truncating revision to first 12 chars 2017-09-15 12:40:25,365 Setting DEBUG logging. 2017-09-15 12:40:25,365 attempt 1/10 2017-09-15 12:40:25,365 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7aceaf8bcb9f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-15 12:40:25,727 unpacking tar archive at: mozilla-central-7aceaf8bcb9f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672823 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:26.085041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:26.089009) ========= script_repo_revision: 7aceaf8bcb9f582db0f93488b48ef7019e348dba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:26.089510) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:26.089801) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 12:40:26.103876) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-15 12:40:26.104294) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:40:26 INFO - MultiFileLogger online at 20170915 12:40:26 in /builds/slave/test 12:40:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:40:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:40:26 INFO - {'append_to_log': False, 12:40:26 INFO - 'base_work_dir': '/builds/slave/test', 12:40:26 INFO - 'blob_upload_branch': 'Firefox', 12:40:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:40:26 INFO - 'branch': 'Firefox', 12:40:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:40:26 INFO - 'code_coverage': False, 12:40:26 INFO - 'config_files': ('talos/linux_config.py',), 12:40:26 INFO - 'default_actions': ('clobber', 12:40:26 INFO - 'read-buildbot-config', 12:40:26 INFO - 'download-and-extract', 12:40:26 INFO - 'populate-webroot', 12:40:26 INFO - 'create-virtualenv', 12:40:26 INFO - 'install', 12:40:26 INFO - 'setup-mitmproxy', 12:40:26 INFO - 'run-tests'), 12:40:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:40:26 INFO - 'disable_ccov_upload': False, 12:40:26 INFO - 'disable_stylo': False, 12:40:26 INFO - 'download_minidump_stackwalk': True, 12:40:26 INFO - 'download_symbols': 'ondemand', 12:40:26 INFO - 'enable_stylo': False, 12:40:26 INFO - 'enable_webrender': False, 12:40:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:40:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:40:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:40:26 INFO - 'gecko_profile': False, 12:40:26 INFO - 'gecko_profile_interval': 0, 12:40:26 INFO - 'installer_path': 'installer.exe', 12:40:26 INFO - 'log_level': 'info', 12:40:26 INFO - 'log_name': 'talos', 12:40:26 INFO - 'log_to_console': True, 12:40:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:40:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:40:26 INFO - 'opt_config_files': (), 12:40:26 INFO - 'pip_index': False, 12:40:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 12:40:26 INFO - 'system_bits': '32', 12:40:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:40:26 INFO - 'title': 'talos-linux64-ix-048', 12:40:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:40:26 INFO - 'use_talos_json': True, 12:40:26 INFO - 'verify': 'False', 12:40:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:40:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:40:26 INFO - 'work_dir': 'build'} 12:40:26 INFO - [mozharness: 2017-09-15 19:40:26.295828Z] Running clobber step. 12:40:26 INFO - Running pre-action listener: _resource_record_pre_action 12:40:26 INFO - Running main action method: clobber 12:40:26 INFO - rmtree: /builds/slave/test/build 12:40:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:40:27 INFO - Running post-action listener: _resource_record_post_action 12:40:27 INFO - [mozharness: 2017-09-15 19:40:27.356334Z] Finished clobber step (success) 12:40:27 INFO - [mozharness: 2017-09-15 19:40:27.356431Z] Running read-buildbot-config step. 12:40:27 INFO - Running pre-action listener: _resource_record_pre_action 12:40:27 INFO - Running main action method: read_buildbot_config 12:40:27 INFO - Using buildbot properties: 12:40:27 INFO - { 12:40:27 INFO - "project": "", 12:40:27 INFO - "product": "firefox", 12:40:27 INFO - "who": "ryanvm@gmail.com", 12:40:27 INFO - "installer_path": "public/build/target.tar.bz2", 12:40:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 12:40:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:40:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 12:40:27 INFO - "stage_platform": "linux64-pgo", 12:40:27 INFO - "basedir": "/builds/slave/test", 12:40:27 INFO - "buildnumber": 21, 12:40:27 INFO - "platform": "ubuntu64_hw", 12:40:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:40:27 INFO - "slavebuilddir": "test", 12:40:27 INFO - "taskId": "KnPx6MgyRP-KEgDxCPLCVQ", 12:40:27 INFO - "branch": "mozilla-central", 12:40:27 INFO - "script_repo_revision": "production", 12:40:27 INFO - "revision": "7aceaf8bcb9f582db0f93488b48ef7019e348dba", 12:40:27 INFO - "slavename": "talos-linux64-ix-048", 12:40:27 INFO - "repo_path": "mozilla-central" 12:40:27 INFO - } 12:40:27 INFO - Finding installer, test and symbols from parent task. 12:40:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KnPx6MgyRP-KEgDxCPLCVQ'}, attempt #1 12:40:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KnPx6MgyRP-KEgDxCPLCVQ'}, attempt #1 12:40:29 INFO - Task dependencies: Yrrp_8EOT5an_C13Djd2RA 12:40:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA'}, attempt #1 12:40:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.tar.bz2 12:40:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.test_packages.json 12:40:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.crashreporter-symbols.zip 12:40:29 INFO - Running post-action listener: _resource_record_post_action 12:40:29 INFO - [mozharness: 2017-09-15 19:40:29.514600Z] Finished read-buildbot-config step (success) 12:40:29 INFO - [mozharness: 2017-09-15 19:40:29.514818Z] Running download-and-extract step. 12:40:29 INFO - Running pre-action listener: _resource_record_pre_action 12:40:29 INFO - Running main action method: download_and_extract 12:40:29 INFO - mkdir: /builds/slave/test/build/tests 12:40: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')]} 12:40:29 INFO - trying https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.test_packages.json 12:40:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:40:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:40:30 INFO - Downloaded 989 bytes. 12:40:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:40:30 INFO - Using the following test package requirements: 12:40:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:40:30 INFO - u'common': [u'target.common.tests.zip'], 12:40:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:40:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:40:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:40:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:40:30 INFO - u'mozbase': [u'target.common.tests.zip'], 12:40:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:40:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:40:30 INFO - u'web-platform': [u'target.common.tests.zip', 12:40:30 INFO - u'target.web-platform.tests.tar.gz'], 12:40:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:40:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:40:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.common.tests.zip 12:40:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:40:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.common.tests.zip into memory 12:40:31 INFO - Content-Length response header: 55328870 12:40:31 INFO - Bytes received: 55328870 12:40:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.talos.tests.zip 12:40:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:40:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.talos.tests.zip into memory 12:40:44 INFO - Content-Length response header: 14508749 12:40:44 INFO - Bytes received: 14508749 12:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:44 INFO - trying https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.tar.bz2 12:40:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:40:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:40:48 INFO - Downloaded 62238139 bytes. 12:40:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.tar.bz2 12:40:48 INFO - mkdir: /builds/slave/test/properties 12:40:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:40:48 INFO - Writing to file /builds/slave/test/properties/build_url 12:40:48 INFO - Contents: 12:40:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.tar.bz2 12:40:48 INFO - Running post-action listener: _resource_record_post_action 12:40:48 INFO - Running post-action listener: find_tests_for_verification 12:40:48 INFO - Running post-action listener: set_extra_try_arguments 12:40:48 INFO - [mozharness: 2017-09-15 19:40:48.247419Z] Finished download-and-extract step (success) 12:40:48 INFO - [mozharness: 2017-09-15 19:40:48.247573Z] Running populate-webroot step. 12:40:48 INFO - Running pre-action listener: _resource_record_pre_action 12:40:48 INFO - Running main action method: populate_webroot 12:40:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:40:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:40:48 INFO - 'tests': ['tresize', 12:40:48 INFO - 'tcanvasmark']}, 12:40:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:40:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:40:48 INFO - 'tests': ['dromaeo_css', 12:40:48 INFO - 'kraken']}, 12:40:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:40:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:40:48 INFO - 'talos_options': ['--disable-stylo'], 12:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:40:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:40:48 INFO - 'tests': ['damp', 'tps']}, 12:40:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:40:48 INFO - 'talos_options': ['--disable-stylo'], 12:40:48 INFO - 'tests': ['damp', 'tps']}, 12:40:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:40:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:40:48 INFO - 'tests': ['dromaeo_dom']}, 12:40:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:40:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:40:48 INFO - 'tests': ['basic_compositor_video', 12:40:48 INFO - 'glvideo']}, 12:40:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:40:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:40:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:40:48 INFO - 'talos_options': ['--disable-stylo'], 12:40:48 INFO - 'tests': ['ts_paint_webext', 12:40:48 INFO - 'tp5o_webext']}, 12:40:48 INFO - 'other-e10s': {'tests': ['a11yr', 12:40:48 INFO - 'ts_paint', 12:40:48 INFO - 'tpaint', 12:40:48 INFO - 'sessionrestore', 12:40:48 INFO - 'sessionrestore_many_windows', 12:40:48 INFO - 'sessionrestore_no_auto_restore', 12:40:48 INFO - 'tabpaint']}, 12:40:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:40:48 INFO - 'tests': ['a11yr', 12:40:48 INFO - 'ts_paint', 12:40:48 INFO - 'tpaint', 12:40:48 INFO - 'sessionrestore', 12:40:48 INFO - 'sessionrestore_many_windows', 12:40:48 INFO - 'sessionrestore_no_auto_restore', 12:40:48 INFO - 'tabpaint']}, 12:40:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 12:40:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:40:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:40:48 INFO - 'tests': ['perf_reftest_singletons']}, 12:40:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:40:48 INFO - 'tests': ['bloom_basic']}, 12:40:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:40:48 INFO - 'tsvgr_opacity', 12:40:48 INFO - 'tart', 12:40:48 INFO - 'tscrollx', 12:40:48 INFO - 'tsvg_static']}, 12:40:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:40:48 INFO - 'tests': ['tsvgx', 12:40:48 INFO - 'tsvgr_opacity', 12:40:48 INFO - 'tart', 12:40:48 INFO - 'tscrollx', 12:40:48 INFO - 'tsvg_static']}, 12:40:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:40:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:40:48 INFO - 'talos_options': ['--disable-stylo'], 12:40:48 INFO - 'tests': ['tp5o']}, 12:40:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:40:48 INFO - 'talos_options': ['--mitmproxy', 12:40:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:40:48 INFO - '--firstNonBlankPaint'], 12:40:48 INFO - 'tests': ['tp6_google', 12:40:48 INFO - 'tp6_youtube', 12:40:48 INFO - 'tp6_amazon', 12:40:48 INFO - 'tp6_facebook']}, 12:40:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:40:48 INFO - 'talos_options': ['--disable-stylo', 12:40:48 INFO - '--mitmproxy', 12:40:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:40:48 INFO - '--firstNonBlankPaint'], 12:40:48 INFO - 'tests': ['tp6_google', 12:40:48 INFO - 'tp6_youtube', 12:40:48 INFO - 'tp6_amazon', 12:40:48 INFO - 'tp6_facebook']}, 12:40:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:40:48 INFO - 'talos_options': ['--stylo-threads=1', 12:40:48 INFO - '--mitmproxy', 12:40:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:40:48 INFO - '--firstNonBlankPaint'], 12:40:48 INFO - 'tests': ['tp6_google', 12:40:48 INFO - 'tp6_youtube', 12:40:48 INFO - 'tp6_amazon', 12:40:48 INFO - 'tp6_facebook']}, 12:40:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:40:48 INFO - 'talos_options': ['--xperf_path', 12:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:40:48 INFO - 'tests': ['tp5n']}, 12:40:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:40:48 INFO - 'talos_options': ['--disable-stylo', 12:40:48 INFO - '--xperf_path', 12:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:40:48 INFO - 'tests': ['tp5n']}}} 12:40:48 INFO - Running post-action listener: _resource_record_post_action 12:40:48 INFO - [mozharness: 2017-09-15 19:40:48.269354Z] Finished populate-webroot step (success) 12:40:48 INFO - [mozharness: 2017-09-15 19:40:48.269456Z] Running create-virtualenv step. 12:40:48 INFO - Running pre-action listener: _resource_record_pre_action 12:40:48 INFO - Running main action method: create_virtualenv 12:40:48 INFO - Creating virtualenv /builds/slave/test/build/venv 12:40:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:40:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:40:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:40:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:40:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:40:49 INFO - Installing distribute.............................................................................................................................................................................................done. 12:40:49 INFO - Installing pip...............done. 12:40:49 INFO - Return code: 0 12:40:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:40:50 INFO - Reading from file tmpfile_stdout 12:40:50 INFO - Output received: 12:40: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) 12:40:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40: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')]} 12:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40: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 0x20861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6090>, '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 0x23f6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', '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 12:40: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 12:40: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 12:40:50 INFO - Using env: {'DISPLAY': ':0', 12:40:50 INFO - 'HOME': '/home/cltbld', 12:40:50 INFO - 'LANG': 'en_US.UTF-8', 12:40:50 INFO - 'LANGUAGE': 'en_US:en', 12:40:50 INFO - 'LOGNAME': 'cltbld', 12:40:50 INFO - 'MAIL': '/var/mail/cltbld', 12:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:50 INFO - 'MOZ_NO_REMOTE': '1', 12:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:50 INFO - 'NO_EM_RESTART': '1', 12:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:50 INFO - 'PWD': '/builds/slave/test', 12:40:50 INFO - 'SHELL': '/bin/bash', 12:40:50 INFO - 'SHLVL': '1', 12:40:50 INFO - 'TERM': 'linux', 12:40:50 INFO - 'TMOUT': '86400', 12:40:50 INFO - 'USER': 'cltbld', 12:40:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', 12:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:50 INFO - '_': '/tools/buildbot/bin/python'} 12:40:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:40:51 INFO - Downloading/unpacking pip>=1.5 12:40:51 INFO - Running setup.py egg_info for package pip 12:40:51 INFO - warning: no files found matching 'pip/cacert.pem' 12:40:51 INFO - warning: no files found matching '*.html' under directory 'docs' 12:40:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:40:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:40:51 INFO - Installing collected packages: pip 12:40:51 INFO - Found existing installation: pip 1.1 12:40:51 INFO - Uninstalling pip: 12:40:51 INFO - Successfully uninstalled pip 12:40:51 INFO - Running setup.py install for pip 12:40:51 INFO - warning: no files found matching 'pip/cacert.pem' 12:40:51 INFO - warning: no files found matching '*.html' under directory 'docs' 12:40:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:40:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:40:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:40:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:40:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:40:51 INFO - Successfully installed pip 12:40:51 INFO - Cleaning up... 12:40:51 INFO - Return code: 0 12:40:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:40:51 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')]} 12:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:51 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')]} 12:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:51 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 0x20861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6090>, '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 0x23f6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', '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 12:40:51 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 12:40:51 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 12:40:51 INFO - Using env: {'DISPLAY': ':0', 12:40:51 INFO - 'HOME': '/home/cltbld', 12:40:51 INFO - 'LANG': 'en_US.UTF-8', 12:40:51 INFO - 'LANGUAGE': 'en_US:en', 12:40:51 INFO - 'LOGNAME': 'cltbld', 12:40:51 INFO - 'MAIL': '/var/mail/cltbld', 12:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:51 INFO - 'MOZ_NO_REMOTE': '1', 12:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:51 INFO - 'NO_EM_RESTART': '1', 12:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:51 INFO - 'PWD': '/builds/slave/test', 12:40:51 INFO - 'SHELL': '/bin/bash', 12:40:51 INFO - 'SHLVL': '1', 12:40:51 INFO - 'TERM': 'linux', 12:40:51 INFO - 'TMOUT': '86400', 12:40:51 INFO - 'USER': 'cltbld', 12:40:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', 12:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:51 INFO - '_': '/tools/buildbot/bin/python'} 12:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:51 INFO - Downloading/unpacking psutil>=3.1.1 12:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:40:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:40:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:40:52 INFO - Installing collected packages: psutil 12:40:52 INFO - Running setup.py install for psutil 12:40:52 INFO - building 'psutil._psutil_linux' extension 12:40:52 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 12:40:54 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 12:40:54 INFO - building 'psutil._psutil_posix' extension 12:40:54 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 12:40:54 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 12:40:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:40:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:40:55 INFO - Successfully installed psutil 12:40:55 INFO - Cleaning up... 12:40:55 INFO - Return code: 0 12:40:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:55 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 0x20861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6090>, '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 0x23f6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', '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 12:40:55 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 12:40:55 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 12:40:55 INFO - Using env: {'DISPLAY': ':0', 12:40:55 INFO - 'HOME': '/home/cltbld', 12:40:55 INFO - 'LANG': 'en_US.UTF-8', 12:40:55 INFO - 'LANGUAGE': 'en_US:en', 12:40:55 INFO - 'LOGNAME': 'cltbld', 12:40:55 INFO - 'MAIL': '/var/mail/cltbld', 12:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:55 INFO - 'MOZ_NO_REMOTE': '1', 12:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:55 INFO - 'NO_EM_RESTART': '1', 12:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:55 INFO - 'PWD': '/builds/slave/test', 12:40:55 INFO - 'SHELL': '/bin/bash', 12:40:55 INFO - 'SHLVL': '1', 12:40:55 INFO - 'TERM': 'linux', 12:40:55 INFO - 'TMOUT': '86400', 12:40:55 INFO - 'USER': 'cltbld', 12:40:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', 12:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:55 INFO - '_': '/tools/buildbot/bin/python'} 12:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:40: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 12:40: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 12:40: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 12:40: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 12:40:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:40:57 INFO - Installing collected packages: mozsystemmonitor 12:40:57 INFO - Running setup.py install for mozsystemmonitor 12:40:57 INFO - Successfully installed mozsystemmonitor 12:40:57 INFO - Cleaning up... 12:40:57 INFO - Return code: 0 12:40:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40: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')]} 12:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40: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', '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 0x20861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6090>, '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 0x23f6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', '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 12:40: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:40: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 jsonschema==2.5.1 12:40:57 INFO - Using env: {'DISPLAY': ':0', 12:40:57 INFO - 'HOME': '/home/cltbld', 12:40:57 INFO - 'LANG': 'en_US.UTF-8', 12:40:57 INFO - 'LANGUAGE': 'en_US:en', 12:40:57 INFO - 'LOGNAME': 'cltbld', 12:40:57 INFO - 'MAIL': '/var/mail/cltbld', 12:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:57 INFO - 'MOZ_NO_REMOTE': '1', 12:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:57 INFO - 'NO_EM_RESTART': '1', 12:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:57 INFO - 'PWD': '/builds/slave/test', 12:40:57 INFO - 'SHELL': '/bin/bash', 12:40:57 INFO - 'SHLVL': '1', 12:40:57 INFO - 'TERM': 'linux', 12:40:57 INFO - 'TMOUT': '86400', 12:40:57 INFO - 'USER': 'cltbld', 12:40:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', 12:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:57 INFO - '_': '/tools/buildbot/bin/python'} 12:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:57 INFO - Downloading/unpacking jsonschema==2.5.1 12:40:57 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 12:40:57 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 12:40:57 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 12:40:57 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 12:40:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:40:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:40: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 12:40: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 12:40: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 12:40: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 12:40:58 INFO - Downloading functools32-3.2.3-2.tar.gz 12:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:40:58 INFO - warning: no files found matching '*.txt' 12:40:58 INFO - no previously-included directories found matching 'build' 12:40:58 INFO - no previously-included directories found matching 'dist' 12:40:58 INFO - no previously-included directories found matching '.git*' 12:40:58 INFO - Installing collected packages: jsonschema, functools32 12:40:58 INFO - Running setup.py install for functools32 12:40:58 INFO - warning: no files found matching '*.txt' 12:40:58 INFO - no previously-included directories found matching 'build' 12:40:58 INFO - no previously-included directories found matching 'dist' 12:40:58 INFO - no previously-included directories found matching '.git*' 12:40:58 INFO - Successfully installed jsonschema functools32 12:40:58 INFO - Cleaning up... 12:40:58 INFO - Return code: 0 12:40:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6090>, '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 0x23f6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', '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 12:40:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:40:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:40:58 INFO - Using env: {'DISPLAY': ':0', 12:40:58 INFO - 'HOME': '/home/cltbld', 12:40:58 INFO - 'LANG': 'en_US.UTF-8', 12:40:58 INFO - 'LANGUAGE': 'en_US:en', 12:40:58 INFO - 'LOGNAME': 'cltbld', 12:40:58 INFO - 'MAIL': '/var/mail/cltbld', 12:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:58 INFO - 'MOZ_NO_REMOTE': '1', 12:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:58 INFO - 'NO_EM_RESTART': '1', 12:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:58 INFO - 'PWD': '/builds/slave/test', 12:40:58 INFO - 'SHELL': '/bin/bash', 12:40:58 INFO - 'SHLVL': '1', 12:40:58 INFO - 'TERM': 'linux', 12:40:58 INFO - 'TMOUT': '86400', 12:40:58 INFO - 'USER': 'cltbld', 12:40:58 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', 12:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:58 INFO - '_': '/tools/buildbot/bin/python'} 12:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:40:59 INFO - Cleaning up... 12:40:59 INFO - Return code: 0 12:40:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40: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')]} 12:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40: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', '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 0x20861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6090>, '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 0x23f6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', '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 12:40: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:40: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 blobuploader==1.2.4 12:40:59 INFO - Using env: {'DISPLAY': ':0', 12:40:59 INFO - 'HOME': '/home/cltbld', 12:40:59 INFO - 'LANG': 'en_US.UTF-8', 12:40:59 INFO - 'LANGUAGE': 'en_US:en', 12:40:59 INFO - 'LOGNAME': 'cltbld', 12:40:59 INFO - 'MAIL': '/var/mail/cltbld', 12:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:59 INFO - 'MOZ_NO_REMOTE': '1', 12:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:59 INFO - 'NO_EM_RESTART': '1', 12:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:59 INFO - 'PWD': '/builds/slave/test', 12:40:59 INFO - 'SHELL': '/bin/bash', 12:40:59 INFO - 'SHLVL': '1', 12:40:59 INFO - 'TERM': 'linux', 12:40:59 INFO - 'TMOUT': '86400', 12:40:59 INFO - 'USER': 'cltbld', 12:40:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', 12:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:59 INFO - '_': '/tools/buildbot/bin/python'} 12:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:59 INFO - Downloading/unpacking blobuploader==1.2.4 12:40: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 12:40: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 12:40: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 12:40: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 12:41:00 INFO - Downloading blobuploader-1.2.4.tar.gz 12:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:41:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:41: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 12:41: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 12:41: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 12:41: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 12:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:41:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:41: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 12:41: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 12:41: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 12:41: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 12:41:00 INFO - Downloading docopt-0.6.1.tar.gz 12:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:41:01 INFO - Installing collected packages: blobuploader, requests, docopt 12:41:01 INFO - Running setup.py install for blobuploader 12:41:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:41:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:41:01 INFO - Running setup.py install for requests 12:41:01 INFO - Running setup.py install for docopt 12:41:01 INFO - Successfully installed blobuploader requests docopt 12:41:01 INFO - Cleaning up... 12:41:01 INFO - Return code: 0 12:41:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:41: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')]} 12:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41: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')]} 12:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:01 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 0x20861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6090>, '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 0x23f6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', '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 12:41:01 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 12:41:01 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 12:41:01 INFO - Using env: {'DISPLAY': ':0', 12:41:01 INFO - 'HOME': '/home/cltbld', 12:41:01 INFO - 'LANG': 'en_US.UTF-8', 12:41:01 INFO - 'LANGUAGE': 'en_US:en', 12:41:01 INFO - 'LOGNAME': 'cltbld', 12:41:01 INFO - 'MAIL': '/var/mail/cltbld', 12:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:01 INFO - 'MOZ_NO_REMOTE': '1', 12:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:01 INFO - 'NO_EM_RESTART': '1', 12:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:01 INFO - 'PWD': '/builds/slave/test', 12:41:01 INFO - 'SHELL': '/bin/bash', 12:41:01 INFO - 'SHLVL': '1', 12:41:01 INFO - 'TERM': 'linux', 12:41:01 INFO - 'TMOUT': '86400', 12:41:01 INFO - 'USER': 'cltbld', 12:41:01 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', 12:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:01 INFO - '_': '/tools/buildbot/bin/python'} 12:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:41:01 INFO - Running setup.py (path:/tmp/pip-JSuK2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:41:01 INFO - Running setup.py (path:/tmp/pip-jtZ0OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:41:02 INFO - Running setup.py (path:/tmp/pip-dOSuRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:41:02 INFO - Running setup.py (path:/tmp/pip-4EcETo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:41:02 INFO - Running setup.py (path:/tmp/pip-0sNlCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:41:02 INFO - Running setup.py (path:/tmp/pip-bQemVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:41:02 INFO - Running setup.py (path:/tmp/pip-OLPBZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:41:02 INFO - Running setup.py (path:/tmp/pip-GmgA0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:41:02 INFO - Running setup.py (path:/tmp/pip-12o1n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:41:02 INFO - Running setup.py (path:/tmp/pip-fQILTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:41:02 INFO - Running setup.py (path:/tmp/pip-xAMzAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:41:02 INFO - Running setup.py (path:/tmp/pip-TTvoEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:41:02 INFO - Running setup.py (path:/tmp/pip-oTKEy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:41:02 INFO - Running setup.py (path:/tmp/pip-GbUYX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:02 INFO - Running setup.py (path:/tmp/pip-v7FA5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:41:02 INFO - Running setup.py (path:/tmp/pip-nZwTZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:41:03 INFO - Running setup.py (path:/tmp/pip-4HR3LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:41:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:41:03 INFO - Running setup.py install for manifestparser 12:41:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:41:03 INFO - Running setup.py install for mozcrash 12:41:03 INFO - Running setup.py install for mozdebug 12:41:03 INFO - Running setup.py install for mozdevice 12:41:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:41:03 INFO - Running setup.py install for mozfile 12:41:03 INFO - Running setup.py install for mozhttpd 12:41:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:41:03 INFO - Running setup.py install for mozinfo 12:41:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:41:03 INFO - Running setup.py install for mozInstall 12:41:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:41:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:41:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:41:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:41:03 INFO - Running setup.py install for mozleak 12:41:03 INFO - Running setup.py install for mozlog 12:41:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:41:04 INFO - Running setup.py install for moznetwork 12:41:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:41:04 INFO - Running setup.py install for mozprocess 12:41:04 INFO - Running setup.py install for mozprofile 12:41:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:41:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:41:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:41:04 INFO - Running setup.py install for mozrunner 12:41:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:41:04 INFO - Running setup.py install for mozscreenshot 12:41:04 INFO - Running setup.py install for moztest 12:41:04 INFO - Running setup.py install for mozversion 12:41:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:41:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:41:04 INFO - Cleaning up... 12:41:04 INFO - Return code: 0 12:41:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:41:04 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')]} 12:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:04 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')]} 12:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:04 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 0x20861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6090>, '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 0x23f6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', '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 12:41:04 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 12:41:04 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 12:41:04 INFO - Using env: {'DISPLAY': ':0', 12:41:04 INFO - 'HOME': '/home/cltbld', 12:41:04 INFO - 'LANG': 'en_US.UTF-8', 12:41:04 INFO - 'LANGUAGE': 'en_US:en', 12:41:04 INFO - 'LOGNAME': 'cltbld', 12:41:04 INFO - 'MAIL': '/var/mail/cltbld', 12:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:04 INFO - 'MOZ_NO_REMOTE': '1', 12:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:04 INFO - 'NO_EM_RESTART': '1', 12:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:04 INFO - 'PWD': '/builds/slave/test', 12:41:04 INFO - 'SHELL': '/bin/bash', 12:41:04 INFO - 'SHLVL': '1', 12:41:04 INFO - 'TERM': 'linux', 12:41:04 INFO - 'TMOUT': '86400', 12:41:04 INFO - 'USER': 'cltbld', 12:41:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', 12:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:04 INFO - '_': '/tools/buildbot/bin/python'} 12:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:41:05 INFO - Running setup.py (path:/tmp/pip-4TYTyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:41:05 INFO - Running setup.py (path:/tmp/pip-EMViul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:41:05 INFO - Running setup.py (path:/tmp/pip-K3f65W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:41:05 INFO - Running setup.py (path:/tmp/pip-HBIwKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:41:05 INFO - Running setup.py (path:/tmp/pip-gKXEfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:41:05 INFO - Running setup.py (path:/tmp/pip-P9NJGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:41:05 INFO - Running setup.py (path:/tmp/pip-g85iaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:41:05 INFO - Running setup.py (path:/tmp/pip-UzxX5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:41:05 INFO - Running setup.py (path:/tmp/pip-4hsonS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:41:05 INFO - Running setup.py (path:/tmp/pip-H51CT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:41:05 INFO - Running setup.py (path:/tmp/pip-tA2SMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:41:05 INFO - Running setup.py (path:/tmp/pip-UVVoO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:41:05 INFO - Running setup.py (path:/tmp/pip-VpxQF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:41:05 INFO - Running setup.py (path:/tmp/pip-ZYE0I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:41:06 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)) 12:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:06 INFO - Running setup.py (path:/tmp/pip-apSWo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:06 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)) 12:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:41:06 INFO - Running setup.py (path:/tmp/pip-BMal_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:41:06 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)) 12:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:41:06 INFO - Running setup.py (path:/tmp/pip-BcV3H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:41:06 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)) 12:41:06 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)) 12:41:06 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)) 12:41:06 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)) 12:41:06 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)) 12:41:06 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)) 12:41:06 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)) 12:41:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:41:07 INFO - Downloading blessings-1.6.tar.gz 12:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:41:07 INFO - Installing collected packages: blessings 12:41:07 INFO - Running setup.py install for blessings 12:41:07 INFO - Successfully installed blessings 12:41:07 INFO - Cleaning up... 12:41:07 INFO - Return code: 0 12:41:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:41:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:41:07 INFO - Reading from file tmpfile_stdout 12:41:07 INFO - Current package versions: 12:41:07 INFO - argparse == 1.2.1 12:41:07 INFO - blessings == 1.6 12:41:07 INFO - blobuploader == 1.2.4 12:41:07 INFO - docopt == 0.6.1 12:41:07 INFO - functools32 == 3.2.3-2 12:41:07 INFO - jsonschema == 2.5.1 12:41:07 INFO - manifestparser == 1.1 12:41:07 INFO - mozInstall == 1.13 12:41:07 INFO - mozcrash == 1.0 12:41:07 INFO - mozdebug == 0.1 12:41:07 INFO - mozdevice == 0.51 12:41:07 INFO - mozfile == 1.2 12:41:07 INFO - mozhttpd == 0.7 12:41:07 INFO - mozinfo == 0.10 12:41:07 INFO - mozleak == 0.1 12:41:07 INFO - mozlog == 3.5 12:41:07 INFO - moznetwork == 0.27 12:41:07 INFO - mozprocess == 0.25 12:41:07 INFO - mozprofile == 0.28 12:41:07 INFO - mozrunner == 6.13 12:41:07 INFO - mozscreenshot == 0.1 12:41:07 INFO - mozsystemmonitor == 0.3 12:41:07 INFO - moztest == 0.8 12:41:07 INFO - mozversion == 1.4 12:41:07 INFO - psutil == 3.1.1 12:41:07 INFO - requests == 1.2.3 12:41:07 INFO - wsgiref == 0.1.2 12:41:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:41: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')]} 12:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41: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')]} 12:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:07 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 0x20861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6090>, '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 0x23f6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', '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 12:41:07 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 12:41:07 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 12:41:07 INFO - Using env: {'DISPLAY': ':0', 12:41:07 INFO - 'HOME': '/home/cltbld', 12:41:07 INFO - 'LANG': 'en_US.UTF-8', 12:41:07 INFO - 'LANGUAGE': 'en_US:en', 12:41:07 INFO - 'LOGNAME': 'cltbld', 12:41:07 INFO - 'MAIL': '/var/mail/cltbld', 12:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:07 INFO - 'MOZ_NO_REMOTE': '1', 12:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:07 INFO - 'NO_EM_RESTART': '1', 12:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:07 INFO - 'PWD': '/builds/slave/test', 12:41:07 INFO - 'SHELL': '/bin/bash', 12:41:07 INFO - 'SHLVL': '1', 12:41:07 INFO - 'TERM': 'linux', 12:41:07 INFO - 'TMOUT': '86400', 12:41:07 INFO - 'USER': 'cltbld', 12:41:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', 12:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:07 INFO - '_': '/tools/buildbot/bin/python'} 12:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:08 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)) 12:41:08 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)) 12:41:08 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)) 12:41:08 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)) 12:41:08 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)) 12:41:08 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)) 12:41:08 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)) 12:41:08 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)) 12:41:08 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)) 12:41:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:41: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 12:41: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 12:41: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 12:41: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 12:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:41:09 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)) 12:41:09 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)) 12:41:09 INFO - Installing collected packages: simplejson 12:41:09 INFO - Running setup.py install for simplejson 12:41:09 INFO - building 'simplejson._speedups' extension 12:41:09 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 12:41:10 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 12:41:10 INFO - Successfully installed simplejson 12:41:10 INFO - Cleaning up... 12:41:10 INFO - Return code: 0 12:41:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:41: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')]} 12:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41: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')]} 12:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6090>, '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 0x23f6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', '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 12:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:41:10 INFO - Using env: {'DISPLAY': ':0', 12:41:10 INFO - 'HOME': '/home/cltbld', 12:41:10 INFO - 'LANG': 'en_US.UTF-8', 12:41:10 INFO - 'LANGUAGE': 'en_US:en', 12:41:10 INFO - 'LOGNAME': 'cltbld', 12:41:10 INFO - 'MAIL': '/var/mail/cltbld', 12:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:10 INFO - 'MOZ_NO_REMOTE': '1', 12:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:10 INFO - 'NO_EM_RESTART': '1', 12:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:10 INFO - 'PWD': '/builds/slave/test', 12:41:10 INFO - 'SHELL': '/bin/bash', 12:41:10 INFO - 'SHLVL': '1', 12:41:10 INFO - 'TERM': 'linux', 12:41:10 INFO - 'TMOUT': '86400', 12:41:10 INFO - 'USER': 'cltbld', 12:41:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', 12:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:10 INFO - '_': '/tools/buildbot/bin/python'} 12:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:41:10 INFO - Cleaning up... 12:41:10 INFO - Return code: 0 12:41:10 INFO - Running post-action listener: _resource_record_post_action 12:41:10 INFO - Running post-action listener: _start_resource_monitoring 12:41:10 INFO - Starting resource monitoring. 12:41:10 INFO - [mozharness: 2017-09-15 19:41:10.562538Z] Finished create-virtualenv step (success) 12:41:10 INFO - [mozharness: 2017-09-15 19:41:10.563493Z] Running install step. 12:41:10 INFO - Running pre-action listener: _resource_record_pre_action 12:41:10 INFO - Running main action method: install 12:41:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:41:10 INFO - Reading from file tmpfile_stdout 12:41:10 INFO - Detecting whether we're running mozinstall >=1.0... 12:41:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:41:10 INFO - Reading from file tmpfile_stdout 12:41:10 INFO - Output received: 12:41:10 INFO - Usage: mozinstall [options] installer 12:41:10 INFO - Options: 12:41:10 INFO - -h, --help show this help message and exit 12:41:10 INFO - -d DEST, --destination=DEST 12:41:10 INFO - Directory to install application into. [default: 12:41:10 INFO - "/builds/slave/test"] 12:41:10 INFO - --app=APP Application being installed. [default: firefox] 12:41:10 INFO - mkdir: /builds/slave/test/build/application 12:41:10 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'] 12:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:41:28 INFO - Reading from file tmpfile_stdout 12:41:28 INFO - Output received: 12:41:28 INFO - /builds/slave/test/build/application/firefox/firefox 12:41:28 INFO - Running post-action listener: _resource_record_post_action 12:41:28 INFO - [mozharness: 2017-09-15 19:41:28.499450Z] Finished install step (success) 12:41:28 INFO - [mozharness: 2017-09-15 19:41:28.499703Z] Running setup-mitmproxy step. 12:41:28 INFO - Running pre-action listener: _resource_record_pre_action 12:41:28 INFO - Running main action method: setup_mitmproxy 12:41:28 INFO - Skipping: mitmproxy is not required 12:41:28 INFO - Running post-action listener: _resource_record_post_action 12:41:28 INFO - [mozharness: 2017-09-15 19:41:28.500831Z] Finished setup-mitmproxy step (success) 12:41:28 INFO - [mozharness: 2017-09-15 19:41:28.501053Z] Running run-tests step. 12:41:28 INFO - Running pre-action listener: _resource_record_pre_action 12:41:28 INFO - Running pre-action listener: _set_gcov_prefix 12:41:28 INFO - Running main action method: run_tests 12:41:28 WARNING - Try message not found. 12:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:41:28 INFO - Python 2.7.3 12:41:28 INFO - Return code: 0 12:41:28 INFO - grabbing minidump binary from tooltool 12:41:28 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')]} 12:41:28 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 0x23f6090>, '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 0x23f6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:41:28 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 12:41:28 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 12:41:28 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 12:41:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:41:28 INFO - Return code: 0 12:41:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:41:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:41:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:41:28 INFO - ENV: RUST_BACKTRACE is now full 12:41:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:41:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 12:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 12:41:28 INFO - Using env: {'DISPLAY': ':0', 12:41:28 INFO - 'HOME': '/home/cltbld', 12:41:28 INFO - 'LANG': 'en_US.UTF-8', 12:41:28 INFO - 'LANGUAGE': 'en_US:en', 12:41:28 INFO - 'LOGNAME': 'cltbld', 12:41:28 INFO - 'MAIL': '/var/mail/cltbld', 12:41:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:41:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:28 INFO - 'MOZ_NO_REMOTE': '1', 12:41:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:41:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:28 INFO - 'NO_EM_RESTART': '1', 12:41:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:28 INFO - 'PWD': '/builds/slave/test', 12:41:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:41:28 INFO - 'RUST_BACKTRACE': 'full', 12:41:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:41:28 INFO - 'SHELL': '/bin/bash', 12:41:28 INFO - 'SHLVL': '1', 12:41:28 INFO - 'TERM': 'linux', 12:41:28 INFO - 'TMOUT': '86400', 12:41:28 INFO - 'USER': 'cltbld', 12:41:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', 12:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:28 INFO - '_': '/tools/buildbot/bin/python'} 12:41:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 12:41:28 INFO - mozversion application_buildid: 20170915182012 12:41:28 INFO - mozversion application_changeset: 7aceaf8bcb9f582db0f93488b48ef7019e348dba 12:41:28 INFO - mozversion application_display_name: Nightly 12:41:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:41:28 INFO - mozversion application_name: Firefox 12:41:28 INFO - mozversion application_remotingname: firefox 12:41:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:41:28 INFO - mozversion application_vendor: Mozilla 12:41:28 INFO - mozversion application_version: 57.0a1 12:41:28 INFO - mozversion platform_buildid: 20170915182012 12:41:28 INFO - mozversion platform_changeset: 7aceaf8bcb9f582db0f93488b48ef7019e348dba 12:41:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:41:28 INFO - mozversion platform_version: 57.0a1 12:41:28 INFO - using testdate: 1505504488 12:41:28 INFO - actual date: 1505504488 12:41:28 INFO - starting webserver on 'localhost:55902' 12:41:28 INFO - SUITE-START | Running 2 tests 12:41:28 INFO - TEST-START | dromaeo_css 12:41:28 INFO - Initialising browser for dromaeo_css test... 12:41:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55902/getInfo.html -profile /tmp/tmpwUAGod/profile 12:41:28 INFO - TEST-INFO | started process 3596 (/builds/slave/test/build/application/firefox/firefox http://localhost:55902/getInfo.html) 12:41:39 INFO - TEST-INFO | 3596: exit 0 12:41:40 INFO - Browser initialized. 12:41:40 INFO - Running cycle 1/1 for dromaeo_css test... 12:41:40 INFO - Using env: {'DISPLAY': ':0', 12:41:40 INFO - 'HOME': '/home/cltbld', 12:41:40 INFO - 'JSGC_DISABLE_POISONING': '1', 12:41:40 INFO - 'LANG': 'en_US.UTF-8', 12:41:40 INFO - 'LANGUAGE': 'en_US:en', 12:41:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:41:40 INFO - 'LOGNAME': 'cltbld', 12:41:40 INFO - 'MAIL': '/var/mail/cltbld', 12:41:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:41:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:41:40 INFO - 'MOZ_CRASHREPORTER': '1', 12:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:41:40 INFO - 'MOZ_NO_REMOTE': '1', 12:41:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:41:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:40 INFO - 'NO_EM_RESTART': '1', 12:41:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:40 INFO - 'PWD': '/builds/slave/test', 12:41:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:41:40 INFO - 'RUST_BACKTRACE': 'full', 12:41:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:41:40 INFO - 'SHELL': '/bin/bash', 12:41:40 INFO - 'SHLVL': '1', 12:41:40 INFO - 'STYLO_FORCE_DISABLED': '1', 12:41:40 INFO - 'TERM': 'linux', 12:41:40 INFO - 'TMOUT': '86400', 12:41:40 INFO - 'USER': 'cltbld', 12:41:40 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', 12:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:40 INFO - '_': '/tools/buildbot/bin/python'} 12:41:40 INFO - TEST-INFO | started process 3837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwUAGod/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:41:40 INFO - PID 3837 | 12:41:40 INFO - PID 3837 | (/builds/slave/test/build/application/firefox/firefox:3887): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:41:40 INFO - PID 3837 | 12:41:51 INFO - PID 3837 | RSS: Main: 165703680 12:41:51 INFO - PID 3837 | 12:44:48 INFO - PID 3837 | Cycle 1(1): loaded http://localhost:55902/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55902/tests/dromaeo/cssquery-ext.html) 12:44:50 INFO - PID 3837 | RSS: Main: 168091648 12:44:50 INFO - PID 3837 | 12:47:51 INFO - PID 3837 | Cycle 1(1): loaded http://localhost:55902/tests/dromaeo/cssquery-ext.html (next: http://localhost:55902/tests/dromaeo/cssquery-jquery.html) 12:47:52 INFO - PID 3837 | RSS: Main: 165761024 12:47:52 INFO - PID 3837 | 12:50:54 INFO - PID 3837 | Cycle 1(1): loaded http://localhost:55902/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55902/tests/dromaeo/cssquery-mootools.html) 12:50:54 INFO - PID 3837 | RSS: Main: 168775680 12:50:54 INFO - PID 3837 | 12:53:56 INFO - PID 3837 | Cycle 1(1): loaded http://localhost:55902/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55902/tests/dromaeo/cssquery-prototype.html) 12:53:56 INFO - PID 3837 | RSS: Main: 166633472 12:53:56 INFO - PID 3837 | 12:56:59 INFO - PID 3837 | Cycle 1(1): loaded http://localhost:55902/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55902/tests/dromaeo/cssquery-yui.html) 12:57:00 INFO - PID 3837 | RSS: Main: 168398848 12:57:00 INFO - PID 3837 | 13:00:01 INFO - PID 3837 | Cycle 1(1): loaded http://localhost:55902/tests/dromaeo/cssquery-yui.html (next: http://localhost:55902/tests/dromaeo/cssquery-dojo.html) 13:00:02 INFO - PID 3837 | RSS: Main: 170565632 13:00:02 INFO - PID 3837 | 13:00:02 INFO - PID 3837 | __start_tp_report 13:00:02 INFO - PID 3837 | _x_x_mozilla_page_load 13:00:02 INFO - PID 3837 | _x_x_mozilla_page_load_details 13:00:02 INFO - PID 3837 | |i|pagename|runs| 13:00:02 INFO - PID 3837 | |0;dojo.html;3895.8246878890445;3897.0841852164717;3898.3567711327632;3915.862944796932;3924.744891582045;6198.411150940665;6233.096201050845;6269.059641053838;6282.968585157074;6353.459955903742;6312.431881130698;6322.968385158079;6343.524235682331;6346.048092786084;6359.650219237951;5598.048331783586;5627.184058311543;5627.831165065044;5655.519280861132;5658.490735833774;5569.220309156722;5602.187682785993;5652.5195358394585;5658.349289831681;5683.573731970098;5387.595930305223;5658.179563963223;5662.8301150965535;5674.2339784129235;5733.942660573382;5503.6147469677135;5593.74828132735;5662.546996240332;5692.9146062809095;5745.052066409058;5507.03626865297;5517.420670829585;5524.088525393306;5529.060059789846;5534.4742249486235;6196.87606247877;6205.100260462253;6226.159468471744;6238.812835614939;6318.4313411793155;6816.318368163144;6884.65576721167;6889.827754306182;6900.6204658743745;6904.447644188504;6846.212685541177;6861.245263021114;6873.759418420382;6938;6957.16514018316;6213.130161777355;6282.151909492206;6282.623042617458;6284.591501552431;6301.0233413820015;6867.965660171667;6955.339242771928;6967.477439192081;6968.651567421609;6979;6798.76204332846;6839.555428897106;6844.555103918229;6847.623380714109;6849.006894000442;6864.039034535169;6875.209350924608;6907.861842763217;6964.268751781091;6974.163100427981;6505.967470162714;6671.566348187353;6678.4991125665765;6727.663616819237;6882.105326307548;6711.094002309724;6742.39318461331;6766.357196066366;6780.457563394916;6815.977603359535;4951.8514444566;4951.851444456672;4952.430470495867;4955.8017679292425;4969.279454479152;4549.249373853278;4559.316102584573;4570.702904311209;4590.724556526619;4591.540845915381;6154.876902461926;6173.290071641729;6185.536084793658;6272.40412160844;6287.1826662534495;6641.501887358468;6752.932470675329;6790.083338749305;6862.3137686230975;6863.2793556676825;6174.135621013062;6241.875162496815;6252.374762523802;6252.874942501216;6264.624122552661;5450.727463626803;5519.172124181325;5525.70146015686;5527.778888844482;5533.584981126432;7061.858762824715;7077.469189810785;7137.89293160603;7139.178994415604;7185.209626941032;6710.698018589273;6746.898796518154;6748.325167483213;6779.084823548757;6846.281140480178;7137.785866424016;7151.928480715334;7152.713891444284;7172.784816455514;7206.171290301473;6757.054012438361;6779.559328643622;6784.96607516979;6861.519693621399;6866.656667166521;6830.692618832264;6861.588304701734;6890.035395044598;6940.965295173693;6954.200266969161;6479.611223326616;6589.0116482528;6594.241662208908;6598.637074960923;6607;6539.7384104637185;6548.116004339353;6616.206055273398;6652.966735166293;6668.066470694203;6532.510061745293;6534.313897040743;6582.473402127723;6589.341065893373;6618.073469714148;6557.950727883515;6581.80254592363;6628.767993120217;6633.900491492728;6711.530192886451;6346.428821406095;6368.395002474757;6374.681265936777;6379.075034120119;6396.392342727433 13:00:02 INFO - PID 3837 | |1;ext.html;966.3477152921778;992.846108853128;994.3337963564406;994.4878387630372;995.6614750984666;39807.20385592287;43941.34087988679;44305.335419968724;44306.556934430686;44391.556084439144;40549.18901621973;40594.391084133764;40834;40846;40916.79541602288;7419.591922444277;7550.6602202901;7553.433492488085;7557.47097703161;7558.244175582426;7430.256974302581;7466.701331946742;7500.174980752113;7525.059367579052;7535.660895259699;7418.035655364822;7481.476296659236;7565.962170189169;7566.827141793031;7569.432292578051;8023.237792409712;8257.95871020647;8300.335973122135;8304.294134998563;8305.501669899764;8033.55815430157;8100.959495202486;8108.432409731262;8109.837803243902;8115.95942020292;40903.795481022404;41334.586654133374;41395.586044139476;41428;41624;3757.6618104370464;3790.507234059555;3792.924141517182;3802.4676545283683;3812.7331086823933;31950;33083.6691633083;33093.17267068318;33143.33713325744;33207;5380.2736630555155;5507.4767897050115;5508.366537848158;5509.696966666832;5530.557555395559;207150;207598;208309;208798;208870;45789;46554.76722616433;51413.485865141614;51489.485105148466;51638.48361516412;54162.72918635382;54183;54270;54368.45631543634;54420.183697244574;15713.21433928299;15819.920900395655;15826.76259856103;15833;15834.28745706446;12708.809367859489;12766.80849787254;12794.744105117845;12876.613701588967;12900;14970;15008;15167.165805880562;15180.089194648357;15245.9237703813;6012;6198.597091189058;6213.347598502182;6297.685115744286;6330.715117819709;1119.9776004479866;1130.581684776638;1136.2500749505286;1136.880627534097;1139.4929256480787;26020.609690854653;26040.218793436226;26112.608310875352;26119;26446.471070578864;1216.2398500936915;1231.6982339326921;1242.6458459339044;1249.4252643783962;1253.5173958026226;13683.452661893412;13812.37844297009;13824.723505530033;13924.791128133085;14147.929260353632;277593;278318;279593;280920;281642;55701.72149139229;55961.72019139878;56066.439335606934;56067;56070;1528.8165420149653;1544.5675210940954;1564.3742502998891;1575.857503310091;1581.5966928433177;24896.751032489443;25165.49669006573;25525.87237063803;25544.361390965376;25648.487030259665;40646.1870762589;40725.796371017954;40753;40794.79602601968;40799.79600102099;225632;225848;226767;227591;228064;35577.822110890316;36473.08817279589;38293.61706383012;38314.80842595769;38488;48006;50108.49891501184;50426.24360634667;50625.240621391444;50638.24042639437;35617.64382356247;36139.27721445504;36217.45673814948;36225.73209937639;36623;35878;36035.63964360323;36322;36357;36649.08377290589;42111;42330.576694233896;42472.150556989305;42613.14773704571;42689;35164.296714066084;35169.47245791264;35428.64571354356;35829.46255806113;35923.640763593074;24258.393540161636;24552.64128560212;24903.229028793758;25243.49513009766;25307.873460632578 13:00:02 INFO - PID 3837 | |2;jquery.html;577.6360892637638;581.790555400056;596.6449962272447;597.1013624495134;612.8835521250962;23000.539989200206;23758.76241237585;23800.285991420264;23875;23901.163459278887;24678.383040424;24796.75203247967;25301.74698253017;25342.619860702103;25365.112221072268;6690.799276021715;6814.250432452451;6886.931130688704;6892.448604111659;6902.033715279865;6452.064450654652;6690.866182676344;6746.8313292167595;6747.05541224229;6846.4522838172825;6629.635370054645;6648;6672.499562532806;6677.465802735769;6696.8995465068065;6671.199456065255;6678.165229346283;6691.732330706766;6691.962745774388;6702.43029342504;5949.6727679977585;6064.241969753781;6113.786017489367;6199.318075011745;6225.470834979033;29958;30319.24201894948;30552;30565.38869222603;30582.84708576465;2279.851809632385;2311.39903625057;2315.2012555668266;2315.235972129193;2315.6758053872472;19962.700559491474;20565;20577.765334080003;20775.168993240404;20840.687389689167;2473.5794914864337;2531.658226139484;2534.2903986883703;2544.910928117507;2579.445419234855;137531;143757;153159;154341;158681.2065939663;15463.922680386526;15736.921315393578;15789.605259868365;16102.43641472543;16318;24955.376115596893;25243;25286.86209120594;25288.494230115295;25289.241322760347;9996.550155243032;10195.847062294071;10322.535485903152;10386.221033422524;10436.165106791439;9207.217386522087;9243.168114869559;9277.072292770805;9343.626254949726;9403.623855045858;9513.525403562458;9535.61857525705;9537.14165725088;9724.97887721793;9770.26722995778;2758.9586156207674;2822.449622323627;2840.6875243723175;2883.7116288371417;2990.925226869346;1030.5568605499557;1035.440861934547;1055.5988724284723;1065.4299949526967;1065.6217042949797;20682.069306881225;20721.792782072287;20750.169993200103;20889;21233.78766212349;1104.6354702948008;1115.341948250536;1118.983215251772;1123.1239633086207;1131.2759833706434;11465.541378344773;11477.827832582518;11510.424478776195;11555.306681599131;11557.595484158013;612247;623298;625677;628601;650056;126761;128596;129402;129512;130112;1192.612400969671;1216.9817452738216;1217.3183017510223;1226.343906010298;1229.4467489629703;17945.551361216076;18332.266709331478;18352;18406.81593184051;18415.723764143815;60083.39916600778;60152.69923650354;60464;60687.69656151691;61253.69373153106;74750.62624686841;76050;76818.23181768111;77030.61484692541;77679.61160194162;14787.778183327044;14860.108393496424;15017.6996460068;15093.773593395888;15143.621409464411;22152.55694886061;22332;22389.32832015042;22659.660105098108;23728.40678983039;19159.233630654617;19218.4234472966;19414.61170776605;19492.122854471298;19530.707039394136;15400;16136.757948630546;16402.507924762278;17483.038432886315;17808.287668493114;17937.103144842444;19014.524636883634;19269.4219173425;19447.8055219446;19459.610807784047;14602.342894569982;14681.92659036698;14708.264586770832;14743.926280368529;14814.77777833355;18624.813751862308;19198.232070717575;19316.613667726284;19347;19434.12546435442 13:00:02 INFO - PID 3837 | |3;mootools.html;1471.1834931612955;1505.845254192467;1528.3351741992242;1531.6860043691045;1544.7451170556858;16956.23696933638;17518.47444576663;17560;17596;17599.472015839514;17179.74230386542;17276.654466910655;17283.222254998524;17291.567710807238;17312.740308895347;2840.957385639217;2886.7690584753223;2906.6947970463116;2909.14180316806;2912.1118058991997;2789.846558439285;2802.6636803583597;2840.5171120909495;2840.8295502269825;2845.189121100487;2750.3811642380506;2790.9302267443272;2990.416868710602;2991.790574659775;2992.1472380371597;2893.059755579445;2908.6073380093626;2910.1691192620256;2914.897978570761;2929.7070292970748;2768.543190373606;2855.172000119963;2870.7846911481515;2871.181713211725;2871.61233233515;16835.494935151964;16992.575185620335;17009.319627214896;17043.488695339158;17119.400820971332;8429.199226073513;8715.041345451995;8747.737567872973;8753.868691969625;8790.472571645721;5225.053234451891;5455.454454554513;5610.438956104357;5615.185798059259;5621.353544342372;1997.0414201183369;1998.41046891166;2036.4501584572083;2056.465319017066;2076.532780124475;30731.231719206975;31148.844255778804;31175.84412077948;31199.376012479624;31274.530882036786;7275.781726548212;7342.375898048619;7361.48469607133;7504.812379690551;7598.772036838904;19836.206551738058;19902.800971990095;19939.700904486443;19960.50098747543;19978.200871965248;8360.12218717026;8501.48991060526;8528.829423411622;8559.22966932979;8561.357898157663;7412.888806667905;7549.320561149523;7594.354479869163;7689.38484921205;7810.062792464941;5438.945610543923;5707.714614269353;5714.771409143587;5721.485066344049;5769.644133628594;1649.2248643137707;1664.7419649954277;1667.1580851669828;1714.7256438969705;1721.9139043047799;944.0889541592396;966.5457235099492;966.8694726212012;978.471625322318;988.5551501824208;8288.50268983863;8299.585020748938;8417.494950303002;8463.407561470638;8506.276966457797;770.5415277909635;778.4161878591057;800.2477670989251;811.1766556944706;818.3902992270796;5351.919721204185;5739.799107031234;5756.510696590753;5772.711364431846;5949.1076338549565;24875.751242487342;25326.366840829127;25372.238832834675;25551.744482554936;25675.35811604725;24168.274951751475;24391.756082438947;25429.491410171693;25443;25451;12021.398930053287;12291.385430728427;12378.44297006637;12387.62837114888;12447.688807779878;8805.911940880766;8966.148215919477;9049.59276832531;9099.636014559343;9133.223675987616;20559.38321850347;20677;20901.79098209059;21223.78776212218;21391.67912481345;21826.563468730856;21958.780412196313;22015.889920550937;22176;22493.437664057874;11583.826242606536;12209.328486933304;12265.202761820454;12265.816012759637;12272.509099635914;15296.31166597528;15383.230838457808;15442;15540;15567.143807090719;12128.21166624202;12176.782321767752;12226.20529665569;12346.876531234931;12470.127091103535;11784.587539436421;11787.11596630239;11962.162648614514;12091.57679481214;12143.514259429523;10965.56137754481;11177.441127943408;11206.663800086011;11209.159313051718;11209.663710088711;7831.647575859214;7875.724349647735;7943.682252709827;7964;8026.077001144943;7738.110117336353;7823.647935842787;7832.21677832235;7876.6849326028605;8044.718434854986 13:00:02 INFO - PID 3837 | |4;prototype.html;535.5153586004665;563.3127584347096;567.1719289836838;574.8878968601122;576.1271673414776;6049.153118563394;6114.056433600325;6205.193324867767;6211.689415529222;6235.719392627331;6032.155498230251;6092.360302168275;6093.51251899848;6143.754249830002;6147.0164773636225;4945.887175385527;4954.331165292693;5016.598672106241;5019.899602007976;5031.496850314976;4976.4774698656665;4978.303037574742;4990.30135780991;5007.624428167884;5037.093323201822;4669.276262179367;4803.207470767319;4960.950390496085;4961.305417241589;5005.824796132136;4786.425628924534;4788.138135135691;4810.518948105197;4836.46798852126;4840.128776820171;4281.186574550826;4304.913901721948;4347.804348804311;4368.191884501346;4368.257396242647;5815.505682017034;6070.544709146788;6084.878302433971;6095.725692343811;6099.725512351954;5705.031764041399;5734.627249228787;5766.192733017381;5766.7116644168045;5779.393163717833;6517.055027021055;6517.739290428377;6560.245571759213;6597.274299827015;6598.505112116611;4763.595094416979;4927.95072049282;4948.975255123702;4981.825636102719;4996.225585034325;6680.966595167041;6712.160979877515;6740.393364597161;6759.485067764735;6793.252742198354;5104.2088476286235;5106.361704786902;5108.565771909355;5128.205128205134;5128.820491282787;5148.510891465305;5186.974065129651;5199.922001169985;5204.9219261711105;5220.895582088337;5725.885482290331;5764.654120752684;5790.031389327649;5833.212516310328;5839.766409343663;6514.283428822826;6551.279359270572;6604.306547812411;6619.966900165468;6622.403983641495;1758.1209395302349;1766.726157445598;1798.0650061967704;1800.090954068187;1821.225978958937;1201.63912910329;1252.8308678328492;1260.4517035089766;1266.8923141533073;1275.591810620611;5941.287045554561;6032.155498230251;6037.818865434044;6065.211522502046;6065.211522502134;6674.299198584175;6704.564203326866;6705.597664140168;6715.731370745213;6750.3924646782025;5981.820545383645;5983.6708981005595;6055.8486037848525;6076.422739839708;6118.816435506942;3332.23358627517;3499.9475007874903;3501.6848483636086;3503.4584782695533;3528.4530897710897;6831.009503621947;6839.692213850389;6888.827779305458;6903.309669033157;6916.757913473004;6574.093512881306;6706.423990362261;6761.222459417131;6812.523123381316;6822.727090916407;6961.721531138698;6966.477514186355;6968.477364197604;6972.546784458994;6987.336203060803;6439.83900402475;6525.771597994048;6626;6631.568948018364;6641.568298060611;6509.967450162719;6538.117354157128;6577.506686998398;6630.76792312286;6635.867282654223;6853.657317134223;6885.518013739191;6909.239983601699;6931.133608298963;6945.131858517685;5100.591952643854;5111.5910727141;5124.333836601218;5130.51260130287;5136.717480538607;6409.391107844747;6462.415033986443;6547.574407663486;6680.164979377578;6684.596234790748;6461.224653041477;6500.594779931266;6530.216374034956;6550.574212676161;6578.407943285128;6364.69407423317;6442.226932768098;6449.774257900951;6462.353764623688;6466.2240531134685;6141;6378.74485020594;6388.105665206967;6454.774082907075;6475.870482590416;6498.805035848932;6610.702518386588;6622.701978410887;6633.369829866155;6637.53537252407;6293.622382657055;6300.905486417799;6348.460380867493;6366.77716279928;6395.840103997437 13:00:02 INFO - PID 3837 | |5;yui.html;961.5048250151174;986.5215370545284;996.2329006664868;1005.1154983614418;1009.7526106104003;20465.795342046575;21119.366419007416;21217.68173477397;21311.893440532796;21314.57370852582;18232;18319;18322.541936451595;18337.174827132778;18444.44666659999;1068.8022715797583;1094.2067001423943;1094.7919895219923;1094.9288296260756;1098.6978580890259;1084.5878566144893;1086.7283179205199;1088.8693356797155;1089.4716062709579;1095.2278643556274;1073.5866691323859;1125.6004118537924;1127.1039523578734;1130.2088538023415;1135.8580177477816;1122.81473556863;1126.4930781148516;1129.3054771315624;1129.4465711801158;1131.1685910855474;790.5651891459731;817.8486979908736;821.2731732416794;830.2486249943811;831.1439217605815;19548.31580894662;19682.70475942862;19717.507062323413;19719.704204436945;19730.50673733154;23322.300330990096;23444.179453719207;23672.526549468916;23768.40578985522;23806.880965595235;17487.387941422116;17751.378701745376;18035.27858885643;18257.360992365204;18269.269229230817;4008.118213992917;4030.435738996543;4046.413270075852;4046.7167298289132;4047.251258517184;130379;152796;154159;158413.99999999884;158488;18526.536836578925;18675.533111672044;18989.525261868563;19026.80973190278;19190.328338508087;34044.65955340464;34443.4833477498;34592.82703586466;34609.30781384358;34689.479657805154;9823.656172033945;9824.65613703517;9827.606895724233;9829.80340393188;9841;4707.529247075334;4753.786079626425;4857.8299759508245;4868.440129385166;4870.439899411613;5963.701814909324;6125;6129.203203583595;6129.233845769279;6136.263648362135;1209.60687776473;1227.5826219085375;1228.9385530723428;1252.2048499203072;1254.830597869276;723.3489859126723;737.8598066367373;748.5246868238708;752.4093586534653;758.635854789704;13182.934085329513;13184.934075329562;13662.248576328397;15280.235988200546;15346.462873799363;716.358858821352;724.5145752345941;735.272080640173;737.4137560639305;749.5203070035182;6021.42796434338;6167.290761562388;6197.876042479125;6237.1891654084675;6354.682265886687;137458.3127084358;142141;143537;145230;145523.2723836374;117460.41269793596;119221.99999999827;120699;121467;129830.35084824516;99761.50119249502;100331;101990;102581;110076;13073.803892941423;13438.260895650834;13537.390817413043;13765;14758.704825903636;54098;54404.18393724018;56820;57110.42889571051;58327.708361457924;65318.34681653123;68837;68938.65530672314;69690.30309696838;71201.64399177971;20452;20585.794142058985;20589.07349169261;20595.691064633742;20921.1631534743;21413;21529.354119376443;21580.02889869991;21615.45961350979;21802.781972180073;21414.143434262456;21428.357149285548;21502.354929352143;21565.784342156378;21577.568448631253;20367.69448458304;20913;20972.895135524224;21068.57862842704;21280.893595531925;21605.891970540048;21738.782612173676;21910.12359505602;22039.779602204413;22089.889550552143;11816.822747658964;11951.282923024646;12160.878391216329;12162.574309899112;12344.259344439362;15043.548693539211;15479.303431345841;15494.767578486106;15603.297851596479;15609.843901561293 13:00:02 INFO - PID 3837 | __end_tp_report 13:00:02 INFO - PID 3837 | __start_cc_report 13:00:02 INFO - PID 3837 | _x_x_mozilla_cycle_collect,357 13:00:02 INFO - PID 3837 | __end_cc_report 13:00:02 INFO - PID 3837 | __startTimestamp1505505602205__endTimestamp 13:00:02 INFO - PID 3837 | 13:00:02 INFO - PID 3837 | ------- Summary: start ------- 13:00:02 INFO - PID 3837 | Number of tests: 6 13:00:02 INFO - PID 3837 | 13:00:02 INFO - PID 3837 | [#0] dojo.html Cycles:165 Average:6266.06 Median:6532.51 stddev:752.53 (11.5%) stddev-sans-first:731.50 13:00:02 INFO - PID 3837 | Values: 3895.8 3897.1 3898.4 3915.9 3924.7 6198.4 6233.1 6269.1 6283.0 6353.5 6312.4 6323.0 6343.5 6346.0 6359.7 5598.0 5627.2 5627.8 5655.5 5658.5 5569.2 5602.2 5652.5 5658.3 5683.6 5387.6 5658.2 5662.8 5674.2 5733.9 5503.6 5593.7 5662.5 5692.9 5745.1 5507.0 5517.4 5524.1 5529.1 5534.5 6196.9 6205.1 6226.2 6238.8 6318.4 6816.3 6884.7 6889.8 6900.6 6904.4 6846.2 6861.2 6873.8 6938.0 6957.2 6213.1 6282.2 6282.6 6284.6 6301.0 6868.0 6955.3 6967.5 6968.7 6979.0 6798.8 6839.6 6844.6 6847.6 6849.0 6864.0 6875.2 6907.9 6964.3 6974.2 6506.0 6671.6 6678.5 6727.7 6882.1 6711.1 6742.4 6766.4 6780.5 6816.0 4951.9 4951.9 4952.4 4955.8 4969.3 4549.2 4559.3 4570.7 4590.7 4591.5 6154.9 6173.3 6185.5 6272.4 6287.2 6641.5 6752.9 6790.1 6862.3 6863.3 6174.1 6241.9 6252.4 6252.9 6264.6 5450.7 5519.2 5525.7 5527.8 5533.6 7061.9 7077.5 7137.9 7139.2 7185.2 6710.7 6746.9 6748.3 6779.1 6846.3 7137.8 7151.9 7152.7 7172.8 7206.2 6757.1 6779.6 6785.0 6861.5 6866.7 6830.7 6861.6 6890.0 6941.0 6954.2 6479.6 6589.0 6594.2 6598.6 6607.0 6539.7 6548.1 6616.2 6653.0 6668.1 6532.5 6534.3 6582.5 6589.3 6618.1 6558.0 6581.8 6628.8 6633.9 6711.5 6346.4 6368.4 6374.7 6379.1 6396.4 13:00:02 INFO - PID 3837 | 13:00:02 INFO - PID 3837 | [#1] ext.html Cycles:180 Average:41784.42 Median:3807.60 stddev:62391.98 (1638.6%) stddev-sans-first:62491.73 13:00:02 INFO - PID 3837 | Values: 966.3 992.8 994.3 994.5 995.7 39807.2 43941.3 44305.3 44306.6 44391.6 40549.2 40594.4 40834.0 40846.0 40916.8 7419.6 7550.7 7553.4 7557.5 7558.2 7430.3 7466.7 7500.2 7525.1 7535.7 7418.0 7481.5 7566.0 7566.8 7569.4 8023.2 8258.0 8300.3 8304.3 8305.5 8033.6 8101.0 8108.4 8109.8 8116.0 40903.8 41334.6 41395.6 41428.0 41624.0 3757.7 3790.5 3792.9 3802.5 3812.7 31950.0 33083.7 33093.2 33143.3 33207.0 5380.3 5507.5 5508.4 5509.7 5530.6 207150.0 207598.0 208309.0 208798.0 208870.0 45789.0 46554.8 51413.5 51489.5 51638.5 54162.7 54183.0 54270.0 54368.5 54420.2 15713.2 15819.9 15826.8 15833.0 15834.3 12708.8 12766.8 12794.7 12876.6 12900.0 14970.0 15008.0 15167.2 15180.1 15245.9 6012.0 6198.6 6213.3 6297.7 6330.7 1120.0 1130.6 1136.3 1136.9 1139.5 26020.6 26040.2 26112.6 26119.0 26446.5 1216.2 1231.7 1242.6 1249.4 1253.5 13683.5 13812.4 13824.7 13924.8 14147.9 277593.0 278318.0 279593.0 280920.0 281642.0 55701.7 55961.7 56066.4 56067.0 56070.0 1528.8 1544.6 1564.4 1575.9 1581.6 24896.8 25165.5 25525.9 25544.4 25648.5 40646.2 40725.8 40753.0 40794.8 40799.8 225632.0 225848.0 226767.0 227591.0 228064.0 35577.8 36473.1 38293.6 38314.8 38488.0 48006.0 50108.5 50426.2 50625.2 50638.2 35617.6 36139.3 36217.5 36225.7 36623.0 35878.0 36035.6 36322.0 36357.0 36649.1 42111.0 42330.6 42472.2 42613.1 42689.0 35164.3 35169.5 35428.6 35829.5 35923.6 24258.4 24552.6 24903.2 25243.5 25307.9 13:00:02 INFO - PID 3837 | 13:00:02 INFO - PID 3837 | [#2] jquery.html Cycles:180 Average:39867.06 Median:2313.30 stddev:104775.52 (4529.3%) stddev-sans-first:105027.91 13:00:02 INFO - PID 3837 | Values: 577.6 581.8 596.6 597.1 612.9 23000.5 23758.8 23800.3 23875.0 23901.2 24678.4 24796.8 25301.7 25342.6 25365.1 6690.8 6814.3 6886.9 6892.4 6902.0 6452.1 6690.9 6746.8 6747.1 6846.5 6629.6 6648.0 6672.5 6677.5 6696.9 6671.2 6678.2 6691.7 6692.0 6702.4 5949.7 6064.2 6113.8 6199.3 6225.5 29958.0 30319.2 30552.0 30565.4 30582.8 2279.9 2311.4 2315.2 2315.2 2315.7 19962.7 20565.0 20577.8 20775.2 20840.7 2473.6 2531.7 2534.3 2544.9 2579.4 137531.0 143757.0 153159.0 154341.0 158681.2 15463.9 15736.9 15789.6 16102.4 16318.0 24955.4 25243.0 25286.9 25288.5 25289.2 9996.6 10195.8 10322.5 10386.2 10436.2 9207.2 9243.2 9277.1 9343.6 9403.6 9513.5 9535.6 9537.1 9725.0 9770.3 2759.0 2822.4 2840.7 2883.7 2990.9 1030.6 1035.4 1055.6 1065.4 1065.6 20682.1 20721.8 20750.2 20889.0 21233.8 1104.6 1115.3 1119.0 1123.1 1131.3 11465.5 11477.8 11510.4 11555.3 11557.6 612247.0 623298.0 625677.0 628601.0 650056.0 126761.0 128596.0 129402.0 129512.0 130112.0 1192.6 1217.0 1217.3 1226.3 1229.4 17945.6 18332.3 18352.0 18406.8 18415.7 60083.4 60152.7 60464.0 60687.7 61253.7 74750.6 76050.0 76818.2 77030.6 77679.6 14787.8 14860.1 15017.7 15093.8 15143.6 22152.6 22332.0 22389.3 22659.7 23728.4 19159.2 19218.4 19414.6 19492.1 19530.7 15400.0 16136.8 16402.5 17483.0 17808.3 17937.1 19014.5 19269.4 19447.8 19459.6 14602.3 14681.9 14708.3 14743.9 14814.8 18624.8 19198.2 19316.6 19347.0 19434.1 13:00:02 INFO - PID 3837 | 13:00:02 INFO - PID 3837 | [#3] mootools.html Cycles:180 Average:10418.13 Median:2840.67 stddev:7808.61 (274.9%) stddev-sans-first:7801.58 13:00:02 INFO - PID 3837 | Values: 1471.2 1505.8 1528.3 1531.7 1544.7 16956.2 17518.5 17560.0 17596.0 17599.5 17179.7 17276.7 17283.2 17291.6 17312.7 2841.0 2886.8 2906.7 2909.1 2912.1 2789.8 2802.7 2840.5 2840.8 2845.2 2750.4 2790.9 2990.4 2991.8 2992.1 2893.1 2908.6 2910.2 2914.9 2929.7 2768.5 2855.2 2870.8 2871.2 2871.6 16835.5 16992.6 17009.3 17043.5 17119.4 8429.2 8715.0 8747.7 8753.9 8790.5 5225.1 5455.5 5610.4 5615.2 5621.4 1997.0 1998.4 2036.5 2056.5 2076.5 30731.2 31148.8 31175.8 31199.4 31274.5 7275.8 7342.4 7361.5 7504.8 7598.8 19836.2 19902.8 19939.7 19960.5 19978.2 8360.1 8501.5 8528.8 8559.2 8561.4 7412.9 7549.3 7594.4 7689.4 7810.1 5438.9 5707.7 5714.8 5721.5 5769.6 1649.2 1664.7 1667.2 1714.7 1721.9 944.1 966.5 966.9 978.5 988.6 8288.5 8299.6 8417.5 8463.4 8506.3 770.5 778.4 800.2 811.2 818.4 5351.9 5739.8 5756.5 5772.7 5949.1 24875.8 25326.4 25372.2 25551.7 25675.4 24168.3 24391.8 25429.5 25443.0 25451.0 12021.4 12291.4 12378.4 12387.6 12447.7 8805.9 8966.1 9049.6 9099.6 9133.2 20559.4 20677.0 20901.8 21223.8 21391.7 21826.6 21958.8 22015.9 22176.0 22493.4 11583.8 12209.3 12265.2 12265.8 12272.5 15296.3 15383.2 15442.0 15540.0 15567.1 12128.2 12176.8 12226.2 12346.9 12470.1 11784.6 11787.1 11962.2 12091.6 12143.5 10965.6 11177.4 11206.7 11209.2 11209.7 7831.6 7875.7 7943.7 7964.0 8026.1 7738.1 7823.6 7832.2 7876.7 8044.7 13:00:02 INFO - PID 3837 | 13:00:02 INFO - PID 3837 | [#4] prototype.html Cycles:180 Average:5539.23 Median:6094.62 stddev:1554.32 (25.5%) stddev-sans-first:1512.63 13:00:02 INFO - PID 3837 | Values: 535.5 563.3 567.2 574.9 576.1 6049.2 6114.1 6205.2 6211.7 6235.7 6032.2 6092.4 6093.5 6143.8 6147.0 4945.9 4954.3 5016.6 5019.9 5031.5 4976.5 4978.3 4990.3 5007.6 5037.1 4669.3 4803.2 4961.0 4961.3 5005.8 4786.4 4788.1 4810.5 4836.5 4840.1 4281.2 4304.9 4347.8 4368.2 4368.3 5815.5 6070.5 6084.9 6095.7 6099.7 5705.0 5734.6 5766.2 5766.7 5779.4 6517.1 6517.7 6560.2 6597.3 6598.5 4763.6 4928.0 4949.0 4981.8 4996.2 6681.0 6712.2 6740.4 6759.5 6793.3 5104.2 5106.4 5108.6 5128.2 5128.8 5148.5 5187.0 5199.9 5204.9 5220.9 5725.9 5764.7 5790.0 5833.2 5839.8 6514.3 6551.3 6604.3 6620.0 6622.4 1758.1 1766.7 1798.1 1800.1 1821.2 1201.6 1252.8 1260.5 1266.9 1275.6 5941.3 6032.2 6037.8 6065.2 6065.2 6674.3 6704.6 6705.6 6715.7 6750.4 5981.8 5983.7 6055.8 6076.4 6118.8 3332.2 3499.9 3501.7 3503.5 3528.5 6831.0 6839.7 6888.8 6903.3 6916.8 6574.1 6706.4 6761.2 6812.5 6822.7 6961.7 6966.5 6968.5 6972.5 6987.3 6439.8 6525.8 6626.0 6631.6 6641.6 6510.0 6538.1 6577.5 6630.8 6635.9 6853.7 6885.5 6909.2 6931.1 6945.1 5100.6 5111.6 5124.3 5130.5 5136.7 6409.4 6462.4 6547.6 6680.2 6684.6 6461.2 6500.6 6530.2 6550.6 6578.4 6364.7 6442.2 6449.8 6462.4 6466.2 6141.0 6378.7 6388.1 6454.8 6475.9 6498.8 6610.7 6622.7 6633.4 6637.5 6293.6 6300.9 6348.5 6366.8 6395.8 13:00:02 INFO - PID 3837 | 13:00:02 INFO - PID 3837 | [#5] yui.html Cycles:180 Average:27752.30 Median:20592.38 stddev:39455.89 (191.6%) stddev-sans-first:39515.30 13:00:02 INFO - PID 3837 | Values: 961.5 986.5 996.2 1005.1 1009.8 20465.8 21119.4 21217.7 21311.9 21314.6 18232.0 18319.0 18322.5 18337.2 18444.4 1068.8 1094.2 1094.8 1094.9 1098.7 1084.6 1086.7 1088.9 1089.5 1095.2 1073.6 1125.6 1127.1 1130.2 1135.9 1122.8 1126.5 1129.3 1129.4 1131.2 790.6 817.8 821.3 830.2 831.1 19548.3 19682.7 19717.5 19719.7 19730.5 23322.3 23444.2 23672.5 23768.4 23806.9 17487.4 17751.4 18035.3 18257.4 18269.3 4008.1 4030.4 4046.4 4046.7 4047.3 130379.0 152796.0 154159.0 158414.0 158488.0 18526.5 18675.5 18989.5 19026.8 19190.3 34044.7 34443.5 34592.8 34609.3 34689.5 9823.7 9824.7 9827.6 9829.8 9841.0 4707.5 4753.8 4857.8 4868.4 4870.4 5963.7 6125.0 6129.2 6129.2 6136.3 1209.6 1227.6 1228.9 1252.2 1254.8 723.3 737.9 748.5 752.4 758.6 13182.9 13184.9 13662.2 15280.2 15346.5 716.4 724.5 735.3 737.4 749.5 6021.4 6167.3 6197.9 6237.2 6354.7 137458.3 142141.0 143537.0 145230.0 145523.3 117460.4 119222.0 120699.0 121467.0 129830.4 99761.5 100331.0 101990.0 102581.0 110076.0 13073.8 13438.3 13537.4 13765.0 14758.7 54098.0 54404.2 56820.0 57110.4 58327.7 65318.3 68837.0 68938.7 69690.3 71201.6 20452.0 20585.8 20589.1 20595.7 20921.2 21413.0 21529.4 21580.0 21615.5 21802.8 21414.1 21428.4 21502.4 21565.8 21577.6 20367.7 20913.0 20972.9 21068.6 21280.9 21605.9 21738.8 21910.1 22039.8 22089.9 11816.8 11951.3 12160.9 12162.6 12344.3 15043.5 15479.3 15494.8 15603.3 15609.8 13:00:02 INFO - PID 3837 | -------- Summary: end -------- 13:00:02 INFO - PID 3837 | 13:00:02 INFO - TEST-INFO | 3837: exit 0 13:00:02 INFO - TEST-OK | dromaeo_css | took 1113966ms 13:00:02 INFO - TEST-START | kraken 13:00:02 INFO - Initialising browser for kraken test... 13:00:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55902/getInfo.html -profile /tmp/tmp8qc9bq/profile 13:00:02 INFO - TEST-INFO | started process 4200 (/builds/slave/test/build/application/firefox/firefox http://localhost:55902/getInfo.html) 13:00:08 INFO - TEST-INFO | 4200: exit 0 13:00:08 INFO - Browser initialized. 13:00:08 INFO - Running cycle 1/1 for kraken test... 13:00:08 INFO - Using env: {'DISPLAY': ':0', 13:00:08 INFO - 'HOME': '/home/cltbld', 13:00:08 INFO - 'JSGC_DISABLE_POISONING': '1', 13:00:08 INFO - 'LANG': 'en_US.UTF-8', 13:00:08 INFO - 'LANGUAGE': 'en_US:en', 13:00:08 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:00:08 INFO - 'LOGNAME': 'cltbld', 13:00:08 INFO - 'MAIL': '/var/mail/cltbld', 13:00:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:00:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:00:08 INFO - 'MOZ_CRASHREPORTER': '1', 13:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:08 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:00:08 INFO - 'MOZ_NO_REMOTE': '1', 13:00:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:08 INFO - 'NO_EM_RESTART': '1', 13:00:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:08 INFO - 'PWD': '/builds/slave/test', 13:00:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:00:08 INFO - 'RUST_BACKTRACE': 'full', 13:00:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:00:08 INFO - 'SHELL': '/bin/bash', 13:00:08 INFO - 'SHLVL': '1', 13:00:08 INFO - 'STYLO_FORCE_DISABLED': '1', 13:00:08 INFO - 'TERM': 'linux', 13:00:08 INFO - 'TMOUT': '86400', 13:00:08 INFO - 'USER': 'cltbld', 13:00:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728', 13:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:08 INFO - '_': '/tools/buildbot/bin/python'} 13:00:08 INFO - TEST-INFO | started process 4434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8qc9bq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:00:09 INFO - PID 4434 | 13:00:09 INFO - PID 4434 | (/builds/slave/test/build/application/firefox/firefox:4483): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:00:09 INFO - PID 4434 | 13:00:19 INFO - PID 4434 | RSS: Main: 165666816 13:00:19 INFO - PID 4434 | 13:00:22 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55902/tests/kraken/driver.html?testName=audio-beat-detection) 13:00:23 INFO - PID 4434 | RSS: Main: 170950656 13:00:23 INFO - PID 4434 | 13:00:26 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55902/tests/kraken/driver.html?testName=audio-dft) 13:00:26 INFO - PID 4434 | RSS: Main: 171425792 13:00:26 INFO - PID 4434 | 13:00:29 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55902/tests/kraken/driver.html?testName=audio-fft) 13:00:30 INFO - PID 4434 | RSS: Main: 166682624 13:00:30 INFO - PID 4434 | 13:00:32 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55902/tests/kraken/driver.html?testName=audio-oscillator) 13:00:33 INFO - PID 4434 | RSS: Main: 167395328 13:00:33 INFO - PID 4434 | 13:00:35 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55902/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:00:35 INFO - PID 4434 | RSS: Main: 168132608 13:00:35 INFO - PID 4434 | 13:00:38 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55902/tests/kraken/driver.html?testName=imaging-darkroom) 13:00:39 INFO - PID 4434 | RSS: Main: 171409408 13:00:39 INFO - PID 4434 | 13:00:43 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55902/tests/kraken/driver.html?testName=imaging-desaturate) 13:00:43 INFO - PID 4434 | RSS: Main: 170442752 13:00:43 INFO - PID 4434 | 13:00:46 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55902/tests/kraken/driver.html?testName=json-parse-financial) 13:00:47 INFO - PID 4434 | RSS: Main: 170381312 13:00:47 INFO - PID 4434 | 13:00:48 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55902/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:00:49 INFO - PID 4434 | RSS: Main: 170692608 13:00:49 INFO - PID 4434 | 13:00:50 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55902/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:00:51 INFO - PID 4434 | RSS: Main: 170582016 13:00:51 INFO - PID 4434 | 13:00:53 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55902/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:00:54 INFO - PID 4434 | RSS: Main: 167747584 13:00:54 INFO - PID 4434 | 13:00:56 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:00:57 INFO - PID 4434 | RSS: Main: 167751680 13:00:57 INFO - PID 4434 | 13:01:00 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:01:00 INFO - PID 4434 | RSS: Main: 167911424 13:01:00 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | Cycle 1(1): loaded http://localhost:55902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55902/tests/kraken/driver.html?testName=ai-astar) 13:01:02 INFO - PID 4434 | RSS: Main: 169803776 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | __start_tp_report 13:01:02 INFO - PID 4434 | _x_x_mozilla_page_load 13:01:02 INFO - PID 4434 | _x_x_mozilla_page_load_details 13:01:02 INFO - PID 4434 | |i|pagename|runs| 13:01:02 INFO - PID 4434 | |0;ai-astar;107;105;106;107;105;106;112;108;109;106 13:01:02 INFO - PID 4434 | |1;audio-beat-detection;112;113;116;119;115;109;113;115;111;139 13:01:02 INFO - PID 4434 | |2;audio-dft;163;161;164;162;163;166;162;164;163;171 13:01:02 INFO - PID 4434 | |3;audio-fft;74;75;72;72;73;74;73;72;74;75 13:01:02 INFO - PID 4434 | |4;audio-oscillator;78;79;78;78;80;79;79;79;78;78 13:01:02 INFO - PID 4434 | |5;imaging-gaussian-blur;113;113;114;113;113;113;112;116;112;115 13:01:02 INFO - PID 4434 | |6;imaging-darkroom;149;158;149;157;151;151;149;149;151;149 13:01:02 INFO - PID 4434 | |7;imaging-desaturate;93;96;94;94;94;98;94;99;98;98 13:01:02 INFO - PID 4434 | |8;json-parse-financial;49;48;46;46;46;45;47;47;46;47 13:01:02 INFO - PID 4434 | |9;json-stringify-tinderbox;39;39;38;43;39;38;38;39;39;39 13:01:02 INFO - PID 4434 | |10;stanford-crypto-aes;73;71;71;72;72;72;71;72;73;72 13:01:02 INFO - PID 4434 | |11;stanford-crypto-ccm;105;108;107;104;107;105;107;104;111;108 13:01:02 INFO - PID 4434 | |12;stanford-crypto-pbkdf2;164;154;150;157;154;152;153;161;151;154 13:01:02 INFO - PID 4434 | |13;stanford-crypto-sha256-iterative;61;61;60;61;60;60;60;59;64;60 13:01:02 INFO - PID 4434 | __end_tp_report 13:01:02 INFO - PID 4434 | __start_cc_report 13:01:02 INFO - PID 4434 | _x_x_mozilla_cycle_collect,906 13:01:02 INFO - PID 4434 | __end_cc_report 13:01:02 INFO - PID 4434 | __startTimestamp1505505662568__endTimestamp 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | ------- Summary: start ------- 13:01:02 INFO - PID 4434 | Number of tests: 14 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#0] ai-astar Cycles:10 Average:107.10 Median:107.00 stddev:2.13 (2.0%) stddev-sans-first:2.26 13:01:02 INFO - PID 4434 | Values: 107.0 105.0 106.0 107.0 105.0 106.0 112.0 108.0 109.0 106.0 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#1] audio-beat-detection Cycles:10 Average:116.20 Median:115.00 stddev:8.48 (7.4%) stddev-sans-first:8.86 13:01:02 INFO - PID 4434 | Values: 112.0 113.0 116.0 119.0 115.0 109.0 113.0 115.0 111.0 139.0 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.85 (1.7%) stddev-sans-first:3.00 13:01:02 INFO - PID 4434 | Values: 163.0 161.0 164.0 162.0 163.0 166.0 162.0 164.0 163.0 171.0 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#3] audio-fft Cycles:10 Average:73.40 Median:74.00 stddev:1.17 (1.6%) stddev-sans-first:1.22 13:01:02 INFO - PID 4434 | Values: 74.0 75.0 72.0 72.0 73.0 74.0 73.0 72.0 74.0 75.0 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:79.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 13:01:02 INFO - PID 4434 | Values: 78.0 79.0 78.0 78.0 80.0 79.0 79.0 79.0 78.0 78.0 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.00 stddev:1.26 (1.1%) stddev-sans-first:1.33 13:01:02 INFO - PID 4434 | Values: 113.0 113.0 114.0 113.0 113.0 113.0 112.0 116.0 112.0 115.0 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.00 stddev:3.40 (2.3%) stddev-sans-first:3.50 13:01:02 INFO - PID 4434 | Values: 149.0 158.0 149.0 157.0 151.0 151.0 149.0 149.0 151.0 149.0 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:97.00 stddev:2.25 (2.3%) stddev-sans-first:2.15 13:01:02 INFO - PID 4434 | Values: 93.0 96.0 94.0 94.0 94.0 98.0 94.0 99.0 98.0 98.0 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#8] json-parse-financial Cycles:10 Average:46.70 Median:47.00 stddev:1.16 (2.5%) stddev-sans-first:0.88 13:01:02 INFO - PID 4434 | Values: 49.0 48.0 46.0 46.0 46.0 45.0 47.0 47.0 46.0 47.0 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#9] json-stringify-tinderbox Cycles:10 Average:39.10 Median:39.00 stddev:1.45 (3.7%) stddev-sans-first:1.54 13:01:02 INFO - PID 4434 | Values: 39.0 39.0 38.0 43.0 39.0 38.0 38.0 39.0 39.0 39.0 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#10] stanford-crypto-aes Cycles:10 Average:71.90 Median:72.00 stddev:0.74 (1.0%) stddev-sans-first:0.67 13:01:02 INFO - PID 4434 | Values: 73.0 71.0 71.0 72.0 72.0 72.0 71.0 72.0 73.0 72.0 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#11] stanford-crypto-ccm Cycles:10 Average:106.60 Median:107.00 stddev:2.17 (2.0%) stddev-sans-first:2.22 13:01:02 INFO - PID 4434 | Values: 105.0 108.0 107.0 104.0 107.0 105.0 107.0 104.0 111.0 108.0 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:154.00 stddev:4.45 (2.9%) stddev-sans-first:3.32 13:01:02 INFO - PID 4434 | Values: 164.0 154.0 150.0 157.0 154.0 152.0 153.0 161.0 151.0 154.0 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:60.50 stddev:1.35 (2.2%) stddev-sans-first:1.42 13:01:02 INFO - PID 4434 | Values: 61.0 61.0 60.0 61.0 60.0 60.0 60.0 59.0 64.0 60.0 13:01:02 INFO - PID 4434 | -------- Summary: end -------- 13:01:02 INFO - PID 4434 | 13:01:02 INFO - PID 4434 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:01:03 INFO - TEST-INFO | 4434: exit 0 13:01:03 INFO - TEST-OK | kraken | took 60342ms 13:01:03 INFO - SUITE-END | took 1174s 13:01:03 INFO - Completed test suite (00:19:34) 13:01:03 INFO - javascript benchmark 13:01:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9033.135631456178, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3895.8246878890445, 3897.0841852164717, 3898.3567711327632, 3915.862944796932, 3924.744891582045, 6198.411150940665, 6233.096201050845, 6269.059641053838, 6282.968585157074, 6353.459955903742, 6312.431881130698, 6322.968385158079, 6343.524235682331, 6346.048092786084, 6359.650219237951, 5598.048331783586, 5627.184058311543, 5627.831165065044, 5655.519280861132, 5658.490735833774, 5569.220309156722, 5602.187682785993, 5652.5195358394585, 5658.349289831681, 5683.573731970098, 5387.595930305223, 5658.179563963223, 5662.8301150965535, 5674.2339784129235, 5733.942660573382, 5503.6147469677135, 5593.74828132735, 5662.546996240332, 5692.9146062809095, 5745.052066409058, 5507.03626865297, 5517.420670829585, 5524.088525393306, 5529.060059789846, 5534.4742249486235, 6196.87606247877, 6205.100260462253, 6226.159468471744, 6238.812835614939, 6318.4313411793155, 6816.318368163144, 6884.65576721167, 6889.827754306182, 6900.6204658743745, 6904.447644188504, 6846.212685541177, 6861.245263021114, 6873.759418420382, 6938.0, 6957.16514018316, 6213.130161777355, 6282.151909492206, 6282.623042617458, 6284.591501552431, 6301.0233413820015, 6867.965660171667, 6955.339242771928, 6967.477439192081, 6968.651567421609, 6979.0, 6798.76204332846, 6839.555428897106, 6844.555103918229, 6847.623380714109, 6849.006894000442, 6864.039034535169, 6875.209350924608, 6907.861842763217, 6964.268751781091, 6974.163100427981, 6505.967470162714, 6671.566348187353, 6678.4991125665765, 6727.663616819237, 6882.105326307548, 6711.094002309724, 6742.39318461331, 6766.357196066366, 6780.457563394916, 6815.977603359535, 4951.8514444566, 4951.851444456672, 4952.430470495867, 4955.8017679292425, 4969.279454479152, 4549.249373853278, 4559.316102584573, 4570.702904311209, 4590.724556526619, 4591.540845915381, 6154.876902461926, 6173.290071641729, 6185.536084793658, 6272.40412160844, 6287.1826662534495, 6641.501887358468, 6752.932470675329, 6790.083338749305, 6862.3137686230975, 6863.2793556676825, 6174.135621013062, 6241.875162496815, 6252.374762523802, 6252.874942501216, 6264.624122552661, 5450.727463626803, 5519.172124181325, 5525.70146015686, 5527.778888844482, 5533.584981126432, 7061.858762824715, 7077.469189810785, 7137.89293160603, 7139.178994415604, 7185.209626941032, 6710.698018589273, 6746.898796518154, 6748.325167483213, 6779.084823548757, 6846.281140480178, 7137.785866424016, 7151.928480715334, 7152.713891444284, 7172.784816455514, 7206.171290301473, 6757.054012438361, 6779.559328643622, 6784.96607516979, 6861.519693621399, 6866.656667166521, 6830.692618832264, 6861.588304701734, 6890.035395044598, 6940.965295173693, 6954.200266969161, 6479.611223326616, 6589.0116482528, 6594.241662208908, 6598.637074960923, 6607.0, 6539.7384104637185, 6548.116004339353, 6616.206055273398, 6652.966735166293, 6668.066470694203, 6532.510061745293, 6534.313897040743, 6582.473402127723, 6589.341065893373, 6618.073469714148, 6557.950727883515, 6581.80254592363, 6628.767993120217, 6633.900491492728, 6711.530192886451, 6346.428821406095, 6368.395002474757, 6374.681265936777, 6379.075034120119, 6396.392342727433], "value": 6214.886423188452, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [966.3477152921778, 992.846108853128, 994.3337963564406, 994.4878387630372, 995.6614750984666, 39807.20385592287, 43941.34087988679, 44305.335419968724, 44306.556934430686, 44391.556084439144, 40549.18901621973, 40594.391084133764, 40834.0, 40846.0, 40916.79541602288, 7419.591922444277, 7550.6602202901, 7553.433492488085, 7557.47097703161, 7558.244175582426, 7430.256974302581, 7466.701331946742, 7500.174980752113, 7525.059367579052, 7535.660895259699, 7418.035655364822, 7481.476296659236, 7565.962170189169, 7566.827141793031, 7569.432292578051, 8023.237792409712, 8257.95871020647, 8300.335973122135, 8304.294134998563, 8305.501669899764, 8033.55815430157, 8100.959495202486, 8108.432409731262, 8109.837803243902, 8115.95942020292, 40903.795481022404, 41334.586654133374, 41395.586044139476, 41428.0, 41624.0, 3757.6618104370464, 3790.507234059555, 3792.924141517182, 3802.4676545283683, 3812.7331086823933, 31950.0, 33083.6691633083, 33093.17267068318, 33143.33713325744, 33207.0, 5380.2736630555155, 5507.4767897050115, 5508.366537848158, 5509.696966666832, 5530.557555395559, 207150.0, 207598.0, 208309.0, 208798.0, 208870.0, 45789.0, 46554.76722616433, 51413.485865141614, 51489.485105148466, 51638.48361516412, 54162.72918635382, 54183.0, 54270.0, 54368.45631543634, 54420.183697244574, 15713.21433928299, 15819.920900395655, 15826.76259856103, 15833.0, 15834.28745706446, 12708.809367859489, 12766.80849787254, 12794.744105117845, 12876.613701588967, 12900.0, 14970.0, 15008.0, 15167.165805880562, 15180.089194648357, 15245.9237703813, 6012.0, 6198.597091189058, 6213.347598502182, 6297.685115744286, 6330.715117819709, 1119.9776004479866, 1130.581684776638, 1136.2500749505286, 1136.880627534097, 1139.4929256480787, 26020.609690854653, 26040.218793436226, 26112.608310875352, 26119.0, 26446.471070578864, 1216.2398500936915, 1231.6982339326921, 1242.6458459339044, 1249.4252643783962, 1253.5173958026226, 13683.452661893412, 13812.37844297009, 13824.723505530033, 13924.791128133085, 14147.929260353632, 277593.0, 278318.0, 279593.0, 280920.0, 281642.0, 55701.72149139229, 55961.72019139878, 56066.439335606934, 56067.0, 56070.0, 1528.8165420149653, 1544.5675210940954, 1564.3742502998891, 1575.857503310091, 1581.5966928433177, 24896.751032489443, 25165.49669006573, 25525.87237063803, 25544.361390965376, 25648.487030259665, 40646.1870762589, 40725.796371017954, 40753.0, 40794.79602601968, 40799.79600102099, 225632.0, 225848.0, 226767.0, 227591.0, 228064.0, 35577.822110890316, 36473.08817279589, 38293.61706383012, 38314.80842595769, 38488.0, 48006.0, 50108.49891501184, 50426.24360634667, 50625.240621391444, 50638.24042639437, 35617.64382356247, 36139.27721445504, 36217.45673814948, 36225.73209937639, 36623.0, 35878.0, 36035.63964360323, 36322.0, 36357.0, 36649.08377290589, 42111.0, 42330.576694233896, 42472.150556989305, 42613.14773704571, 42689.0, 35164.296714066084, 35169.47245791264, 35428.64571354356, 35829.46255806113, 35923.640763593074, 24258.393540161636, 24552.64128560212, 24903.229028793758, 25243.49513009766, 25307.873460632578], "value": 18477.296760090314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.6360892637638, 581.790555400056, 596.6449962272447, 597.1013624495134, 612.8835521250962, 23000.539989200206, 23758.76241237585, 23800.285991420264, 23875.0, 23901.163459278887, 24678.383040424, 24796.75203247967, 25301.74698253017, 25342.619860702103, 25365.112221072268, 6690.799276021715, 6814.250432452451, 6886.931130688704, 6892.448604111659, 6902.033715279865, 6452.064450654652, 6690.866182676344, 6746.8313292167595, 6747.05541224229, 6846.4522838172825, 6629.635370054645, 6648.0, 6672.499562532806, 6677.465802735769, 6696.8995465068065, 6671.199456065255, 6678.165229346283, 6691.732330706766, 6691.962745774388, 6702.43029342504, 5949.6727679977585, 6064.241969753781, 6113.786017489367, 6199.318075011745, 6225.470834979033, 29958.0, 30319.24201894948, 30552.0, 30565.38869222603, 30582.84708576465, 2279.851809632385, 2311.39903625057, 2315.2012555668266, 2315.235972129193, 2315.6758053872472, 19962.700559491474, 20565.0, 20577.765334080003, 20775.168993240404, 20840.687389689167, 2473.5794914864337, 2531.658226139484, 2534.2903986883703, 2544.910928117507, 2579.445419234855, 137531.0, 143757.0, 153159.0, 154341.0, 158681.2065939663, 15463.922680386526, 15736.921315393578, 15789.605259868365, 16102.43641472543, 16318.0, 24955.376115596893, 25243.0, 25286.86209120594, 25288.494230115295, 25289.241322760347, 9996.550155243032, 10195.847062294071, 10322.535485903152, 10386.221033422524, 10436.165106791439, 9207.217386522087, 9243.168114869559, 9277.072292770805, 9343.626254949726, 9403.623855045858, 9513.525403562458, 9535.61857525705, 9537.14165725088, 9724.97887721793, 9770.26722995778, 2758.9586156207674, 2822.449622323627, 2840.6875243723175, 2883.7116288371417, 2990.925226869346, 1030.5568605499557, 1035.440861934547, 1055.5988724284723, 1065.4299949526967, 1065.6217042949797, 20682.069306881225, 20721.792782072287, 20750.169993200103, 20889.0, 21233.78766212349, 1104.6354702948008, 1115.341948250536, 1118.983215251772, 1123.1239633086207, 1131.2759833706434, 11465.541378344773, 11477.827832582518, 11510.424478776195, 11555.306681599131, 11557.595484158013, 612247.0, 623298.0, 625677.0, 628601.0, 650056.0, 126761.0, 128596.0, 129402.0, 129512.0, 130112.0, 1192.612400969671, 1216.9817452738216, 1217.3183017510223, 1226.343906010298, 1229.4467489629703, 17945.551361216076, 18332.266709331478, 18352.0, 18406.81593184051, 18415.723764143815, 60083.39916600778, 60152.69923650354, 60464.0, 60687.69656151691, 61253.69373153106, 74750.62624686841, 76050.0, 76818.23181768111, 77030.61484692541, 77679.61160194162, 14787.778183327044, 14860.108393496424, 15017.6996460068, 15093.773593395888, 15143.621409464411, 22152.55694886061, 22332.0, 22389.32832015042, 22659.660105098108, 23728.40678983039, 19159.233630654617, 19218.4234472966, 19414.61170776605, 19492.122854471298, 19530.707039394136, 15400.0, 16136.757948630546, 16402.507924762278, 17483.038432886315, 17808.287668493114, 17937.103144842444, 19014.524636883634, 19269.4219173425, 19447.8055219446, 19459.610807784047, 14602.342894569982, 14681.92659036698, 14708.264586770832, 14743.926280368529, 14814.77777833355, 18624.813751862308, 19198.232070717575, 19316.613667726284, 19347.0, 19434.12546435442], "value": 12543.809102624398, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.1834931612955, 1505.845254192467, 1528.3351741992242, 1531.6860043691045, 1544.7451170556858, 16956.23696933638, 17518.47444576663, 17560.0, 17596.0, 17599.472015839514, 17179.74230386542, 17276.654466910655, 17283.222254998524, 17291.567710807238, 17312.740308895347, 2840.957385639217, 2886.7690584753223, 2906.6947970463116, 2909.14180316806, 2912.1118058991997, 2789.846558439285, 2802.6636803583597, 2840.5171120909495, 2840.8295502269825, 2845.189121100487, 2750.3811642380506, 2790.9302267443272, 2990.416868710602, 2991.790574659775, 2992.1472380371597, 2893.059755579445, 2908.6073380093626, 2910.1691192620256, 2914.897978570761, 2929.7070292970748, 2768.543190373606, 2855.172000119963, 2870.7846911481515, 2871.181713211725, 2871.61233233515, 16835.494935151964, 16992.575185620335, 17009.319627214896, 17043.488695339158, 17119.400820971332, 8429.199226073513, 8715.041345451995, 8747.737567872973, 8753.868691969625, 8790.472571645721, 5225.053234451891, 5455.454454554513, 5610.438956104357, 5615.185798059259, 5621.353544342372, 1997.0414201183369, 1998.41046891166, 2036.4501584572083, 2056.465319017066, 2076.532780124475, 30731.231719206975, 31148.844255778804, 31175.84412077948, 31199.376012479624, 31274.530882036786, 7275.781726548212, 7342.375898048619, 7361.48469607133, 7504.812379690551, 7598.772036838904, 19836.206551738058, 19902.800971990095, 19939.700904486443, 19960.50098747543, 19978.200871965248, 8360.12218717026, 8501.48991060526, 8528.829423411622, 8559.22966932979, 8561.357898157663, 7412.888806667905, 7549.320561149523, 7594.354479869163, 7689.38484921205, 7810.062792464941, 5438.945610543923, 5707.714614269353, 5714.771409143587, 5721.485066344049, 5769.644133628594, 1649.2248643137707, 1664.7419649954277, 1667.1580851669828, 1714.7256438969705, 1721.9139043047799, 944.0889541592396, 966.5457235099492, 966.8694726212012, 978.471625322318, 988.5551501824208, 8288.50268983863, 8299.585020748938, 8417.494950303002, 8463.407561470638, 8506.276966457797, 770.5415277909635, 778.4161878591057, 800.2477670989251, 811.1766556944706, 818.3902992270796, 5351.919721204185, 5739.799107031234, 5756.510696590753, 5772.711364431846, 5949.1076338549565, 24875.751242487342, 25326.366840829127, 25372.238832834675, 25551.744482554936, 25675.35811604725, 24168.274951751475, 24391.756082438947, 25429.491410171693, 25443.0, 25451.0, 12021.398930053287, 12291.385430728427, 12378.44297006637, 12387.62837114888, 12447.688807779878, 8805.911940880766, 8966.148215919477, 9049.59276832531, 9099.636014559343, 9133.223675987616, 20559.38321850347, 20677.0, 20901.79098209059, 21223.78776212218, 21391.67912481345, 21826.563468730856, 21958.780412196313, 22015.889920550937, 22176.0, 22493.437664057874, 11583.826242606536, 12209.328486933304, 12265.202761820454, 12265.816012759637, 12272.509099635914, 15296.31166597528, 15383.230838457808, 15442.0, 15540.0, 15567.143807090719, 12128.21166624202, 12176.782321767752, 12226.20529665569, 12346.876531234931, 12470.127091103535, 11784.587539436421, 11787.11596630239, 11962.162648614514, 12091.57679481214, 12143.514259429523, 10965.56137754481, 11177.441127943408, 11206.663800086011, 11209.159313051718, 11209.663710088711, 7831.647575859214, 7875.724349647735, 7943.682252709827, 7964.0, 8026.077001144943, 7738.110117336353, 7823.647935842787, 7832.21677832235, 7876.6849326028605, 8044.718434854986], "value": 7256.814842526473, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.5153586004665, 563.3127584347096, 567.1719289836838, 574.8878968601122, 576.1271673414776, 6049.153118563394, 6114.056433600325, 6205.193324867767, 6211.689415529222, 6235.719392627331, 6032.155498230251, 6092.360302168275, 6093.51251899848, 6143.754249830002, 6147.0164773636225, 4945.887175385527, 4954.331165292693, 5016.598672106241, 5019.899602007976, 5031.496850314976, 4976.4774698656665, 4978.303037574742, 4990.30135780991, 5007.624428167884, 5037.093323201822, 4669.276262179367, 4803.207470767319, 4960.950390496085, 4961.305417241589, 5005.824796132136, 4786.425628924534, 4788.138135135691, 4810.518948105197, 4836.46798852126, 4840.128776820171, 4281.186574550826, 4304.913901721948, 4347.804348804311, 4368.191884501346, 4368.257396242647, 5815.505682017034, 6070.544709146788, 6084.878302433971, 6095.725692343811, 6099.725512351954, 5705.031764041399, 5734.627249228787, 5766.192733017381, 5766.7116644168045, 5779.393163717833, 6517.055027021055, 6517.739290428377, 6560.245571759213, 6597.274299827015, 6598.505112116611, 4763.595094416979, 4927.95072049282, 4948.975255123702, 4981.825636102719, 4996.225585034325, 6680.966595167041, 6712.160979877515, 6740.393364597161, 6759.485067764735, 6793.252742198354, 5104.2088476286235, 5106.361704786902, 5108.565771909355, 5128.205128205134, 5128.820491282787, 5148.510891465305, 5186.974065129651, 5199.922001169985, 5204.9219261711105, 5220.895582088337, 5725.885482290331, 5764.654120752684, 5790.031389327649, 5833.212516310328, 5839.766409343663, 6514.283428822826, 6551.279359270572, 6604.306547812411, 6619.966900165468, 6622.403983641495, 1758.1209395302349, 1766.726157445598, 1798.0650061967704, 1800.090954068187, 1821.225978958937, 1201.63912910329, 1252.8308678328492, 1260.4517035089766, 1266.8923141533073, 1275.591810620611, 5941.287045554561, 6032.155498230251, 6037.818865434044, 6065.211522502046, 6065.211522502134, 6674.299198584175, 6704.564203326866, 6705.597664140168, 6715.731370745213, 6750.3924646782025, 5981.820545383645, 5983.6708981005595, 6055.8486037848525, 6076.422739839708, 6118.816435506942, 3332.23358627517, 3499.9475007874903, 3501.6848483636086, 3503.4584782695533, 3528.4530897710897, 6831.009503621947, 6839.692213850389, 6888.827779305458, 6903.309669033157, 6916.757913473004, 6574.093512881306, 6706.423990362261, 6761.222459417131, 6812.523123381316, 6822.727090916407, 6961.721531138698, 6966.477514186355, 6968.477364197604, 6972.546784458994, 6987.336203060803, 6439.83900402475, 6525.771597994048, 6626.0, 6631.568948018364, 6641.568298060611, 6509.967450162719, 6538.117354157128, 6577.506686998398, 6630.76792312286, 6635.867282654223, 6853.657317134223, 6885.518013739191, 6909.239983601699, 6931.133608298963, 6945.131858517685, 5100.591952643854, 5111.5910727141, 5124.333836601218, 5130.51260130287, 5136.717480538607, 6409.391107844747, 6462.415033986443, 6547.574407663486, 6680.164979377578, 6684.596234790748, 6461.224653041477, 6500.594779931266, 6530.216374034956, 6550.574212676161, 6578.407943285128, 6364.69407423317, 6442.226932768098, 6449.774257900951, 6462.353764623688, 6466.2240531134685, 6141.0, 6378.74485020594, 6388.105665206967, 6454.774082907075, 6475.870482590416, 6498.805035848932, 6610.702518386588, 6622.701978410887, 6633.369829866155, 6637.53537252407, 6293.622382657055, 6300.905486417799, 6348.460380867493, 6366.77716279928, 6395.840103997437], "value": 5093.581480646335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [961.5048250151174, 986.5215370545284, 996.2329006664868, 1005.1154983614418, 1009.7526106104003, 20465.795342046575, 21119.366419007416, 21217.68173477397, 21311.893440532796, 21314.57370852582, 18232.0, 18319.0, 18322.541936451595, 18337.174827132778, 18444.44666659999, 1068.8022715797583, 1094.2067001423943, 1094.7919895219923, 1094.9288296260756, 1098.6978580890259, 1084.5878566144893, 1086.7283179205199, 1088.8693356797155, 1089.4716062709579, 1095.2278643556274, 1073.5866691323859, 1125.6004118537924, 1127.1039523578734, 1130.2088538023415, 1135.8580177477816, 1122.81473556863, 1126.4930781148516, 1129.3054771315624, 1129.4465711801158, 1131.1685910855474, 790.5651891459731, 817.8486979908736, 821.2731732416794, 830.2486249943811, 831.1439217605815, 19548.31580894662, 19682.70475942862, 19717.507062323413, 19719.704204436945, 19730.50673733154, 23322.300330990096, 23444.179453719207, 23672.526549468916, 23768.40578985522, 23806.880965595235, 17487.387941422116, 17751.378701745376, 18035.27858885643, 18257.360992365204, 18269.269229230817, 4008.118213992917, 4030.435738996543, 4046.413270075852, 4046.7167298289132, 4047.251258517184, 130379.0, 152796.0, 154159.0, 158413.99999999884, 158488.0, 18526.536836578925, 18675.533111672044, 18989.525261868563, 19026.80973190278, 19190.328338508087, 34044.65955340464, 34443.4833477498, 34592.82703586466, 34609.30781384358, 34689.479657805154, 9823.656172033945, 9824.65613703517, 9827.606895724233, 9829.80340393188, 9841.0, 4707.529247075334, 4753.786079626425, 4857.8299759508245, 4868.440129385166, 4870.439899411613, 5963.701814909324, 6125.0, 6129.203203583595, 6129.233845769279, 6136.263648362135, 1209.60687776473, 1227.5826219085375, 1228.9385530723428, 1252.2048499203072, 1254.830597869276, 723.3489859126723, 737.8598066367373, 748.5246868238708, 752.4093586534653, 758.635854789704, 13182.934085329513, 13184.934075329562, 13662.248576328397, 15280.235988200546, 15346.462873799363, 716.358858821352, 724.5145752345941, 735.272080640173, 737.4137560639305, 749.5203070035182, 6021.42796434338, 6167.290761562388, 6197.876042479125, 6237.1891654084675, 6354.682265886687, 137458.3127084358, 142141.0, 143537.0, 145230.0, 145523.2723836374, 117460.41269793596, 119221.99999999827, 120699.0, 121467.0, 129830.35084824516, 99761.50119249502, 100331.0, 101990.0, 102581.0, 110076.0, 13073.803892941423, 13438.260895650834, 13537.390817413043, 13765.0, 14758.704825903636, 54098.0, 54404.18393724018, 56820.0, 57110.42889571051, 58327.708361457924, 65318.34681653123, 68837.0, 68938.65530672314, 69690.30309696838, 71201.64399177971, 20452.0, 20585.794142058985, 20589.07349169261, 20595.691064633742, 20921.1631534743, 21413.0, 21529.354119376443, 21580.02889869991, 21615.45961350979, 21802.781972180073, 21414.143434262456, 21428.357149285548, 21502.354929352143, 21565.784342156378, 21577.568448631253, 20367.69448458304, 20913.0, 20972.895135524224, 21068.57862842704, 21280.893595531925, 21605.891970540048, 21738.782612173676, 21910.12359505602, 22039.779602204413, 22089.889550552143, 11816.822747658964, 11951.282923024646, 12160.878391216329, 12162.574309899112, 12344.259344439362, 15043.548693539211, 15479.303431345841, 15494.767578486106, 15603.297851596479, 15609.843901561293], "value": 10203.134551778776, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1379.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 106.0, 107.0, 105.0, 106.0, 112.0, 108.0, 109.0, 106.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 116.0, 119.0, 115.0, 109.0, 113.0, 115.0, 111.0, 139.0], "value": 116.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 162.0, 163.0, 166.0, 162.0, 164.0, 163.0, 171.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 72.0, 72.0, 73.0, 74.0, 73.0, 72.0, 74.0, 75.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 78.0, 80.0, 79.0, 79.0, 79.0, 78.0, 78.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 112.0, 116.0, 112.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 158.0, 149.0, 157.0, 151.0, 151.0, 149.0, 149.0, 151.0, 149.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 94.0, 94.0, 94.0, 98.0, 94.0, 99.0, 98.0, 98.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 46.0, 46.0, 46.0, 45.0, 47.0, 47.0, 46.0, 47.0], "value": 46.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 38.0, 43.0, 39.0, 38.0, 38.0, 39.0, 39.0, 39.0], "value": 39.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 71.0, 72.0, 72.0, 72.0, 71.0, 72.0, 73.0, 72.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 108.0, 107.0, 104.0, 107.0, 105.0, 107.0, 104.0, 111.0, 108.0], "value": 106.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 154.0, 150.0, 157.0, 154.0, 152.0, 153.0, 161.0, 151.0, 154.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0, 59.0, 64.0, 60.0], "value": 60.6, "unit": "score"}]}]} 13:01:03 INFO - Return code: 0 13:01:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:01:03 INFO - # TBPL SUCCESS # 13:01:03 INFO - Running post-action listener: _package_coverage_data 13:01:03 INFO - Running post-action listener: _resource_record_post_action 13:01:03 INFO - [mozharness: 2017-09-15 20:01:03.846349Z] Finished run-tests step (success) 13:01:03 INFO - Running post-run listener: _resource_record_post_run 13:01:03 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 11644928; Write bytes: 454348800; Read time: 4556; Write time: 615668 13:01:03 INFO - TinderboxPrint: CPU usage
13.1% 13:01:03 INFO - TinderboxPrint: I/O read bytes / time
11,644,928 / 4,556 13:01:03 INFO - TinderboxPrint: I/O write bytes / time
454,348,800 / 615,668 13:01:03 INFO - TinderboxPrint: CPU idle
8,261.6 (86.9%) 13:01:03 INFO - TinderboxPrint: CPU user
1,189.4 (12.5%) 13:01:03 INFO - TinderboxPrint: Swap in / out
0 / 0 13:01:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9154560; Read time: 0; Write time: 1236 13:01:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:01:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 11640832; Write bytes: 445194240; Read time: 4536; Write time: 614432 13:01:04 INFO - Running post-run listener: _upload_blobber_files 13:01:04 INFO - Blob upload gear active. 13:01:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:01:04 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 13:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:01:04 INFO - (blobuploader) - INFO - Open directory for files ... 13:01:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:01:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:01:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:01:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:12 INFO - (blobuploader) - INFO - Done attempting. 13:01:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 13:01:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:01:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 13:01:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:13 INFO - (blobuploader) - INFO - Done attempting. 13:01:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:01:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:01:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:01:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:14 INFO - (blobuploader) - INFO - Done attempting. 13:01:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 13:01:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:01:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 13:01:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:15 INFO - (blobuploader) - INFO - Done attempting. 13:01:15 INFO - (blobuploader) - INFO - Iteration through files over. 13:01:15 INFO - Return code: 0 13:01:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:01:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:01:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82e638a65bb4eb28a123633a9376439c3cab0b216ee7bd09b2d6763874625ec57b5fb139f4d0e4151cff10b8f8000ae409f2c70b11056280dc2123fae223c15a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e873340e0e1d0af8a3d5a1d7c2c045d075c173859e5b6965af8aeda91a8109486ddfb993a00766fe1216d06930dbb6769363b19014c4eda48e76e22e28394cd8", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa6f49d41fbe6ee0ca5e478a9c99f8544b1b32f5166e95c70da72dbf5f5ff596809ce9856facfc6d3c487c5edf76a025685f1a9c1f396df2d1d10b9531f70e9a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c96be38248974401268f5b7ecf5d3ae5b4c425903524dfe15f6c11fa0a463a72ff5e1628ed83169e1c31ab0feafdfbeaa33a6a413a7a12ce154210c9347503c1"} 13:01:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:01:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:01:15 INFO - Contents: 13:01:15 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82e638a65bb4eb28a123633a9376439c3cab0b216ee7bd09b2d6763874625ec57b5fb139f4d0e4151cff10b8f8000ae409f2c70b11056280dc2123fae223c15a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e873340e0e1d0af8a3d5a1d7c2c045d075c173859e5b6965af8aeda91a8109486ddfb993a00766fe1216d06930dbb6769363b19014c4eda48e76e22e28394cd8", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa6f49d41fbe6ee0ca5e478a9c99f8544b1b32f5166e95c70da72dbf5f5ff596809ce9856facfc6d3c487c5edf76a025685f1a9c1f396df2d1d10b9531f70e9a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c96be38248974401268f5b7ecf5d3ae5b4c425903524dfe15f6c11fa0a463a72ff5e1628ed83169e1c31ab0feafdfbeaa33a6a413a7a12ce154210c9347503c1"} 13:01:15 INFO - Running post-run listener: copy_logs_to_upload_dir 13:01:15 INFO - Copying logs to upload dir... 13:01:15 INFO - mkdir: /builds/slave/test/build/upload/logs 13:01:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.275763 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-15 13:01:15.361702) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 13:01:15.370226) ========= 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=fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82e638a65bb4eb28a123633a9376439c3cab0b216ee7bd09b2d6763874625ec57b5fb139f4d0e4151cff10b8f8000ae409f2c70b11056280dc2123fae223c15a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e873340e0e1d0af8a3d5a1d7c2c045d075c173859e5b6965af8aeda91a8109486ddfb993a00766fe1216d06930dbb6769363b19014c4eda48e76e22e28394cd8", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa6f49d41fbe6ee0ca5e478a9c99f8544b1b32f5166e95c70da72dbf5f5ff596809ce9856facfc6d3c487c5edf76a025685f1a9c1f396df2d1d10b9531f70e9a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c96be38248974401268f5b7ecf5d3ae5b4c425903524dfe15f6c11fa0a463a72ff5e1628ed83169e1c31ab0feafdfbeaa33a6a413a7a12ce154210c9347503c1"} build_url:https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/Yrrp_8EOT5an_C13Djd2RA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82e638a65bb4eb28a123633a9376439c3cab0b216ee7bd09b2d6763874625ec57b5fb139f4d0e4151cff10b8f8000ae409f2c70b11056280dc2123fae223c15a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e873340e0e1d0af8a3d5a1d7c2c045d075c173859e5b6965af8aeda91a8109486ddfb993a00766fe1216d06930dbb6769363b19014c4eda48e76e22e28394cd8", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa6f49d41fbe6ee0ca5e478a9c99f8544b1b32f5166e95c70da72dbf5f5ff596809ce9856facfc6d3c487c5edf76a025685f1a9c1f396df2d1d10b9531f70e9a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c96be38248974401268f5b7ecf5d3ae5b4c425903524dfe15f6c11fa0a463a72ff5e1628ed83169e1c31ab0feafdfbeaa33a6a413a7a12ce154210c9347503c1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 13:01:15.398129) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:01:15.398477) ========= 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=fa44defc139c4ba8574fe040000001db-1505504250.598852-1041724728 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:01:15.452723) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 13:01:15.458172) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 13:01:15.458911) ========= ========= Total master_lag: 0.16 =========