builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-011 starttime: 1506175936.45 results: success (0) revision: 3828e44f5b0a56e7933b817d430cf32d41b03fe6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:16.448201) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:16.448666) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:16.448971) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:16.467135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:16.467446) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 07:12:16-- 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% 40.7M=0s 2017-09-23 07:12:16 (40.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116212 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:16.604076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:16.604404) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016427 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:16.660948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:16.661329) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3828e44f5b0a56e7933b817d430cf32d41b03fe6 --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 3828e44f5b0a56e7933b817d430cf32d41b03fe6 --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=5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 07:12:16,779 truncating revision to first 12 chars 2017-09-23 07:12:16,779 Setting DEBUG logging. 2017-09-23 07:12:16,780 attempt 1/10 2017-09-23 07:12:16,780 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3828e44f5b0a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-23 07:12:17,158 unpacking tar archive at: mozilla-central-3828e44f5b0a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.733517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:17.414199) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:17.414504) ========= script_repo_revision: 3828e44f5b0a56e7933b817d430cf32d41b03fe6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:17.414913) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:17.415182) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 07:12:17.434355) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-23 07:12:17.434651) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:12:17 INFO - MultiFileLogger online at 20170923 07:12:17 in /builds/slave/test 07:12:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:12:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:12:17 INFO - {'append_to_log': False, 07:12:17 INFO - 'base_work_dir': '/builds/slave/test', 07:12:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:12:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:12:17 INFO - 'branch': 'Firefox-Non-PGO', 07:12:17 INFO - 'buildbot_json_path': 'buildprops.json', 07:12:17 INFO - 'code_coverage': False, 07:12:17 INFO - 'config_files': ('talos/linux_config.py',), 07:12:17 INFO - 'default_actions': ('clobber', 07:12:17 INFO - 'read-buildbot-config', 07:12:17 INFO - 'download-and-extract', 07:12:17 INFO - 'populate-webroot', 07:12:17 INFO - 'create-virtualenv', 07:12:17 INFO - 'install', 07:12:17 INFO - 'setup-mitmproxy', 07:12:17 INFO - 'run-tests'), 07:12:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:12:17 INFO - 'disable_ccov_upload': False, 07:12:17 INFO - 'disable_stylo': False, 07:12:17 INFO - 'download_minidump_stackwalk': True, 07:12:17 INFO - 'download_symbols': 'ondemand', 07:12:17 INFO - 'enable_stylo': False, 07:12:17 INFO - 'enable_webrender': False, 07:12:17 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:12:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:12:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:12:17 INFO - 'gecko_profile': False, 07:12:17 INFO - 'gecko_profile_interval': 0, 07:12:17 INFO - 'installer_path': 'installer.exe', 07:12:17 INFO - 'log_level': 'info', 07:12:17 INFO - 'log_name': 'talos', 07:12:17 INFO - 'log_to_console': True, 07:12:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:12:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:12:17 INFO - 'opt_config_files': (), 07:12:17 INFO - 'pip_index': False, 07:12:17 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 07:12:17 INFO - 'system_bits': '32', 07:12:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:12:17 INFO - 'title': 'talos-linux64-ix-011', 07:12:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:12:17 INFO - 'use_talos_json': True, 07:12:17 INFO - 'verify': 'False', 07:12:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:12:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:12:17 INFO - 'work_dir': 'build'} 07:12:17 INFO - [mozharness: 2017-09-23 14:12:17.696924Z] Running clobber step. 07:12:17 INFO - Running pre-action listener: _resource_record_pre_action 07:12:17 INFO - Running main action method: clobber 07:12:17 INFO - rmtree: /builds/slave/test/build 07:12:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:12:18 INFO - Running post-action listener: _resource_record_post_action 07:12:18 INFO - [mozharness: 2017-09-23 14:12:18.689798Z] Finished clobber step (success) 07:12:18 INFO - [mozharness: 2017-09-23 14:12:18.689895Z] Running read-buildbot-config step. 07:12:18 INFO - Running pre-action listener: _resource_record_pre_action 07:12:18 INFO - Running main action method: read_buildbot_config 07:12:18 INFO - Using buildbot properties: 07:12:18 INFO - { 07:12:18 INFO - "project": "", 07:12:18 INFO - "product": "firefox", 07:12:18 INFO - "who": "philringnalda@gmail.com", 07:12:18 INFO - "installer_path": "public/build/target.tar.bz2", 07:12:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 07:12:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:12:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 07:12:18 INFO - "stage_platform": "linux64", 07:12:18 INFO - "basedir": "/builds/slave/test", 07:12:18 INFO - "buildnumber": 63, 07:12:18 INFO - "platform": "ubuntu64_hw", 07:12:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:12:18 INFO - "slavebuilddir": "test", 07:12:18 INFO - "taskId": "AHDVYqCUSY6anev7P9HTQQ", 07:12:18 INFO - "branch": "mozilla-central", 07:12:18 INFO - "script_repo_revision": "production", 07:12:18 INFO - "revision": "3828e44f5b0a56e7933b817d430cf32d41b03fe6", 07:12:18 INFO - "slavename": "talos-linux64-ix-011", 07:12:18 INFO - "repo_path": "mozilla-central" 07:12:18 INFO - } 07:12:18 INFO - Finding installer, test and symbols from parent task. 07:12:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AHDVYqCUSY6anev7P9HTQQ'}, attempt #1 07:12:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AHDVYqCUSY6anev7P9HTQQ'}, attempt #1 07:12:19 INFO - Task dependencies: RZ7fYPz7S4aFd-96ndeTBg 07:12:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg'}, attempt #1 07:12:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.tar.bz2 07:12:20 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.test_packages.json 07:12:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.crashreporter-symbols.zip 07:12:20 INFO - Running post-action listener: _resource_record_post_action 07:12:20 INFO - [mozharness: 2017-09-23 14:12:20.087634Z] Finished read-buildbot-config step (success) 07:12:20 INFO - [mozharness: 2017-09-23 14:12:20.087850Z] Running download-and-extract step. 07:12:20 INFO - Running pre-action listener: _resource_record_pre_action 07:12:20 INFO - Running main action method: download_and_extract 07:12:20 INFO - mkdir: /builds/slave/test/build/tests 07:12:20 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')]} 07:12:20 INFO - trying https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.test_packages.json 07:12:20 INFO - Downloading https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:12:20 INFO - Downloaded 989 bytes. 07:12:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:12:20 INFO - Using the following test package requirements: 07:12:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:12:20 INFO - u'common': [u'target.common.tests.zip'], 07:12:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:12:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:12:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:12:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:12:20 INFO - u'mozbase': [u'target.common.tests.zip'], 07:12:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:12:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:12:20 INFO - u'web-platform': [u'target.common.tests.zip', 07:12:20 INFO - u'target.web-platform.tests.tar.gz'], 07:12:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:12:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:12:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.common.tests.zip 07:12:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:12:20 INFO - Fetch https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.common.tests.zip into memory 07:12:22 INFO - Content-Length response header: 54943978 07:12:22 INFO - Bytes received: 54943978 07:12:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.talos.tests.zip 07:12:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:12:33 INFO - Fetch https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.talos.tests.zip into memory 07:12:34 INFO - Content-Length response header: 14513823 07:12:34 INFO - Bytes received: 14513823 07:12:35 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')]} 07:12:35 INFO - trying https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.tar.bz2 07:12:35 INFO - Downloading https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:12:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:12:38 INFO - Downloaded 61580232 bytes. 07:12:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.tar.bz2 07:12:38 INFO - mkdir: /builds/slave/test/properties 07:12:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:12:38 INFO - Writing to file /builds/slave/test/properties/build_url 07:12:38 INFO - Contents: 07:12:38 INFO - build_url:https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.tar.bz2 07:12:38 INFO - Running post-action listener: _resource_record_post_action 07:12:38 INFO - Running post-action listener: find_tests_for_verification 07:12:38 INFO - Running post-action listener: set_extra_try_arguments 07:12:38 INFO - [mozharness: 2017-09-23 14:12:38.194827Z] Finished download-and-extract step (success) 07:12:38 INFO - [mozharness: 2017-09-23 14:12:38.194925Z] Running populate-webroot step. 07:12:38 INFO - Running pre-action listener: _resource_record_pre_action 07:12:38 INFO - Running main action method: populate_webroot 07:12:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:12:38 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:12:38 INFO - 'tests': ['tresize', 07:12:38 INFO - 'tcanvasmark']}, 07:12:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:12:38 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:12:38 INFO - 'tests': ['dromaeo_css', 07:12:38 INFO - 'kraken']}, 07:12:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:12:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:38 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:12:38 INFO - 'talos_options': ['--disable-stylo'], 07:12:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:12:38 INFO - 'tests': ['damp', 'tps']}, 07:12:38 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:12:38 INFO - 'talos_options': ['--disable-stylo'], 07:12:38 INFO - 'tests': ['damp', 'tps']}, 07:12:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:12:38 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:12:38 INFO - 'tests': ['dromaeo_dom']}, 07:12:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:12:38 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:12:38 INFO - 'tests': ['basic_compositor_video', 07:12:38 INFO - 'glvideo']}, 07:12:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:12:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:12:38 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:12:38 INFO - 'talos_options': ['--disable-stylo'], 07:12:38 INFO - 'tests': ['ts_paint_webext', 07:12:38 INFO - 'tp5o_webext']}, 07:12:38 INFO - 'other-e10s': {'tests': ['a11yr', 07:12:38 INFO - 'ts_paint', 07:12:38 INFO - 'tpaint', 07:12:38 INFO - 'sessionrestore', 07:12:38 INFO - 'sessionrestore_many_windows', 07:12:38 INFO - 'sessionrestore_no_auto_restore', 07:12:38 INFO - 'tabpaint']}, 07:12:38 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:12:38 INFO - 'tests': ['a11yr', 07:12:38 INFO - 'ts_paint', 07:12:38 INFO - 'tpaint', 07:12:38 INFO - 'sessionrestore', 07:12:38 INFO - 'sessionrestore_many_windows', 07:12:38 INFO - 'sessionrestore_no_auto_restore', 07:12:38 INFO - 'tabpaint']}, 07:12:38 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 07:12:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:12:38 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:12:38 INFO - 'tests': ['perf_reftest_singletons']}, 07:12:38 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:12:38 INFO - 'tests': ['perf_reftest']}, 07:12:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:12:38 INFO - 'tsvgr_opacity', 07:12:38 INFO - 'tart', 07:12:38 INFO - 'tscrollx', 07:12:38 INFO - 'tsvg_static']}, 07:12:38 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:12:38 INFO - 'tests': ['tsvgx', 07:12:38 INFO - 'tsvgr_opacity', 07:12:38 INFO - 'tart', 07:12:38 INFO - 'tscrollx', 07:12:38 INFO - 'tsvg_static']}, 07:12:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:12:38 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:12:38 INFO - 'talos_options': ['--disable-stylo'], 07:12:38 INFO - 'tests': ['tp5o']}, 07:12:38 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:12:38 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 07:12:38 INFO - 'talos_options': ['--mitmproxy', 07:12:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:12:38 INFO - '--firstNonBlankPaint'], 07:12:38 INFO - 'tests': ['tp6_google', 07:12:38 INFO - 'tp6_youtube', 07:12:38 INFO - 'tp6_amazon', 07:12:38 INFO - 'tp6_facebook']}, 07:12:38 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:12:38 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 07:12:38 INFO - 'talos_options': ['--disable-stylo', 07:12:38 INFO - '--mitmproxy', 07:12:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:12:38 INFO - '--firstNonBlankPaint'], 07:12:38 INFO - 'tests': ['tp6_google', 07:12:38 INFO - 'tp6_youtube', 07:12:38 INFO - 'tp6_amazon', 07:12:38 INFO - 'tp6_facebook']}, 07:12:38 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:12:38 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 07:12:38 INFO - 'talos_options': ['--stylo-threads=1', 07:12:38 INFO - '--mitmproxy', 07:12:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:12:38 INFO - '--firstNonBlankPaint'], 07:12:38 INFO - 'tests': ['tp6_google', 07:12:38 INFO - 'tp6_youtube', 07:12:38 INFO - 'tp6_amazon', 07:12:38 INFO - 'tp6_facebook']}, 07:12:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:12:38 INFO - 'talos_options': ['--xperf_path', 07:12:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:38 INFO - 'tests': ['tp5n']}, 07:12:38 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:12:38 INFO - 'talos_options': ['--disable-stylo', 07:12:38 INFO - '--xperf_path', 07:12:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:38 INFO - 'tests': ['tp5n']}}} 07:12:38 INFO - Running post-action listener: _resource_record_post_action 07:12:38 INFO - [mozharness: 2017-09-23 14:12:38.210396Z] Finished populate-webroot step (success) 07:12:38 INFO - [mozharness: 2017-09-23 14:12:38.210486Z] Running create-virtualenv step. 07:12:38 INFO - Running pre-action listener: _resource_record_pre_action 07:12:38 INFO - Running main action method: create_virtualenv 07:12:38 INFO - Creating virtualenv /builds/slave/test/build/venv 07:12:38 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:12:38 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:12:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:12:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:12:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:12:38 INFO - Installing distribute.............................................................................................................................................................................................done. 07:12:39 INFO - Installing pip...............done. 07:12:39 INFO - Return code: 0 07:12:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:12:39 INFO - Reading from file tmpfile_stdout 07:12:39 INFO - Output received: 07:12:39 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:12:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bcb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15619c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155ed60>, '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 0x155fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', '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 07:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:12:39 INFO - Using env: {'DISPLAY': ':0', 07:12:39 INFO - 'HOME': '/home/cltbld', 07:12:39 INFO - 'LANG': 'en_US.UTF-8', 07:12:39 INFO - 'LANGUAGE': 'en_US:en', 07:12:39 INFO - 'LOGNAME': 'cltbld', 07:12:39 INFO - 'MAIL': '/var/mail/cltbld', 07:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:39 INFO - 'MOZ_NO_REMOTE': '1', 07:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:39 INFO - 'NO_EM_RESTART': '1', 07:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:39 INFO - 'PWD': '/builds/slave/test', 07:12:39 INFO - 'SHELL': '/bin/bash', 07:12:39 INFO - 'SHLVL': '1', 07:12:39 INFO - 'TERM': 'linux', 07:12:39 INFO - 'TMOUT': '86400', 07:12:39 INFO - 'USER': 'cltbld', 07:12:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', 07:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:39 INFO - '_': '/tools/buildbot/bin/python'} 07:12:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:12:40 INFO - Downloading/unpacking pip>=1.5 07:12:40 INFO - Running setup.py egg_info for package pip 07:12:40 INFO - warning: no files found matching 'pip/cacert.pem' 07:12:40 INFO - warning: no files found matching '*.html' under directory 'docs' 07:12:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:12:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:12:40 INFO - Installing collected packages: pip 07:12:40 INFO - Found existing installation: pip 1.1 07:12:40 INFO - Uninstalling pip: 07:12:40 INFO - Successfully uninstalled pip 07:12:40 INFO - Running setup.py install for pip 07:12:40 INFO - warning: no files found matching 'pip/cacert.pem' 07:12:40 INFO - warning: no files found matching '*.html' under directory 'docs' 07:12:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:12:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:12:40 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Successfully installed pip 07:12:40 INFO - Cleaning up... 07:12:40 INFO - Return code: 0 07:12:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:40 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 0x11f41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bcb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15619c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155ed60>, '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 0x155fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', '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 07:12:40 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 07:12:40 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 07:12:40 INFO - Using env: {'DISPLAY': ':0', 07:12:40 INFO - 'HOME': '/home/cltbld', 07:12:40 INFO - 'LANG': 'en_US.UTF-8', 07:12:40 INFO - 'LANGUAGE': 'en_US:en', 07:12:40 INFO - 'LOGNAME': 'cltbld', 07:12:40 INFO - 'MAIL': '/var/mail/cltbld', 07:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:40 INFO - 'MOZ_NO_REMOTE': '1', 07:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:40 INFO - 'NO_EM_RESTART': '1', 07:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:40 INFO - 'PWD': '/builds/slave/test', 07:12:40 INFO - 'SHELL': '/bin/bash', 07:12:40 INFO - 'SHLVL': '1', 07:12:40 INFO - 'TERM': 'linux', 07:12:40 INFO - 'TMOUT': '86400', 07:12:40 INFO - 'USER': 'cltbld', 07:12:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', 07:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:40 INFO - '_': '/tools/buildbot/bin/python'} 07:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:40 INFO - Downloading/unpacking psutil>=3.1.1 07:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:12:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:41 INFO - Installing collected packages: psutil 07:12:41 INFO - Running setup.py install for psutil 07:12:41 INFO - building 'psutil._psutil_linux' extension 07:12:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:12:42 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 07:12:42 INFO - building 'psutil._psutil_posix' extension 07:12:42 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 07:12:42 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 07:12:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:42 INFO - Successfully installed psutil 07:12:42 INFO - Cleaning up... 07:12:42 INFO - Return code: 0 07:12:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:12:42 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')]} 07:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:42 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')]} 07:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:42 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 0x11f41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bcb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15619c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155ed60>, '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 0x155fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', '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 07:12:42 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 07:12:42 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 07:12:42 INFO - Using env: {'DISPLAY': ':0', 07:12:42 INFO - 'HOME': '/home/cltbld', 07:12:42 INFO - 'LANG': 'en_US.UTF-8', 07:12:42 INFO - 'LANGUAGE': 'en_US:en', 07:12:42 INFO - 'LOGNAME': 'cltbld', 07:12:42 INFO - 'MAIL': '/var/mail/cltbld', 07:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:42 INFO - 'MOZ_NO_REMOTE': '1', 07:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:42 INFO - 'NO_EM_RESTART': '1', 07:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:42 INFO - 'PWD': '/builds/slave/test', 07:12:42 INFO - 'SHELL': '/bin/bash', 07:12:42 INFO - 'SHLVL': '1', 07:12:42 INFO - 'TERM': 'linux', 07:12:42 INFO - 'TMOUT': '86400', 07:12:42 INFO - 'USER': 'cltbld', 07:12:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', 07:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:42 INFO - '_': '/tools/buildbot/bin/python'} 07:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:12:43 INFO - Installing collected packages: mozsystemmonitor 07:12:43 INFO - Running setup.py install for mozsystemmonitor 07:12:43 INFO - Successfully installed mozsystemmonitor 07:12:43 INFO - Cleaning up... 07:12:44 INFO - Return code: 0 07:12:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:12: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')]} 07:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12: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')]} 07:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bcb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15619c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155ed60>, '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 0x155fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', '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 07:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:12:44 INFO - Using env: {'DISPLAY': ':0', 07:12:44 INFO - 'HOME': '/home/cltbld', 07:12:44 INFO - 'LANG': 'en_US.UTF-8', 07:12:44 INFO - 'LANGUAGE': 'en_US:en', 07:12:44 INFO - 'LOGNAME': 'cltbld', 07:12:44 INFO - 'MAIL': '/var/mail/cltbld', 07:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:44 INFO - 'MOZ_NO_REMOTE': '1', 07:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:44 INFO - 'NO_EM_RESTART': '1', 07:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:44 INFO - 'PWD': '/builds/slave/test', 07:12:44 INFO - 'SHELL': '/bin/bash', 07:12:44 INFO - 'SHLVL': '1', 07:12:44 INFO - 'TERM': 'linux', 07:12:44 INFO - 'TMOUT': '86400', 07:12:44 INFO - 'USER': 'cltbld', 07:12:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', 07:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:44 INFO - '_': '/tools/buildbot/bin/python'} 07:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:44 INFO - Downloading/unpacking jsonschema==2.5.1 07:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:12:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:12:46 INFO - warning: no files found matching '*.txt' 07:12:46 INFO - no previously-included directories found matching 'build' 07:12:46 INFO - no previously-included directories found matching 'dist' 07:12:46 INFO - no previously-included directories found matching '.git*' 07:12:46 INFO - Installing collected packages: jsonschema, functools32 07:12:46 INFO - Running setup.py install for functools32 07:12:46 INFO - warning: no files found matching '*.txt' 07:12:46 INFO - no previously-included directories found matching 'build' 07:12:46 INFO - no previously-included directories found matching 'dist' 07:12:46 INFO - no previously-included directories found matching '.git*' 07:12:46 INFO - Successfully installed jsonschema functools32 07:12:46 INFO - Cleaning up... 07:12:46 INFO - Return code: 0 07:12:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:46 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 0x11f41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bcb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15619c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155ed60>, '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 0x155fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', '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 07:12:46 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 07:12:46 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 07:12:46 INFO - Using env: {'DISPLAY': ':0', 07:12:46 INFO - 'HOME': '/home/cltbld', 07:12:46 INFO - 'LANG': 'en_US.UTF-8', 07:12:46 INFO - 'LANGUAGE': 'en_US:en', 07:12:46 INFO - 'LOGNAME': 'cltbld', 07:12:46 INFO - 'MAIL': '/var/mail/cltbld', 07:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:46 INFO - 'MOZ_NO_REMOTE': '1', 07:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:46 INFO - 'NO_EM_RESTART': '1', 07:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:46 INFO - 'PWD': '/builds/slave/test', 07:12:46 INFO - 'SHELL': '/bin/bash', 07:12:46 INFO - 'SHLVL': '1', 07:12:46 INFO - 'TERM': 'linux', 07:12:46 INFO - 'TMOUT': '86400', 07:12:46 INFO - 'USER': 'cltbld', 07:12:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', 07:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:46 INFO - '_': '/tools/buildbot/bin/python'} 07:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:12:47 INFO - Cleaning up... 07:12:47 INFO - Return code: 0 07:12:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bcb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15619c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155ed60>, '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 0x155fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', '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 07:12:48 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 07:12:48 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 07:12:48 INFO - Using env: {'DISPLAY': ':0', 07:12:48 INFO - 'HOME': '/home/cltbld', 07:12:48 INFO - 'LANG': 'en_US.UTF-8', 07:12:48 INFO - 'LANGUAGE': 'en_US:en', 07:12:48 INFO - 'LOGNAME': 'cltbld', 07:12:48 INFO - 'MAIL': '/var/mail/cltbld', 07:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:48 INFO - 'MOZ_NO_REMOTE': '1', 07:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:48 INFO - 'NO_EM_RESTART': '1', 07:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:48 INFO - 'PWD': '/builds/slave/test', 07:12:48 INFO - 'SHELL': '/bin/bash', 07:12:48 INFO - 'SHLVL': '1', 07:12:48 INFO - 'TERM': 'linux', 07:12:48 INFO - 'TMOUT': '86400', 07:12:48 INFO - 'USER': 'cltbld', 07:12:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', 07:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:48 INFO - '_': '/tools/buildbot/bin/python'} 07:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:48 INFO - Downloading/unpacking blobuploader==1.2.4 07:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:12:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:12:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:49 INFO - Downloading docopt-0.6.1.tar.gz 07:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:12:49 INFO - Installing collected packages: blobuploader, requests, docopt 07:12:49 INFO - Running setup.py install for blobuploader 07:12:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:12:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:12:49 INFO - Running setup.py install for requests 07:12:50 INFO - Running setup.py install for docopt 07:12:50 INFO - Successfully installed blobuploader requests docopt 07:12:50 INFO - Cleaning up... 07:12:50 INFO - Return code: 0 07:12:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12: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')]} 07:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12: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')]} 07:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:50 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 0x11f41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bcb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15619c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155ed60>, '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 0x155fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', '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 07:12:50 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 07:12:50 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 07:12:50 INFO - Using env: {'DISPLAY': ':0', 07:12:50 INFO - 'HOME': '/home/cltbld', 07:12:50 INFO - 'LANG': 'en_US.UTF-8', 07:12:50 INFO - 'LANGUAGE': 'en_US:en', 07:12:50 INFO - 'LOGNAME': 'cltbld', 07:12:50 INFO - 'MAIL': '/var/mail/cltbld', 07:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:50 INFO - 'MOZ_NO_REMOTE': '1', 07:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:50 INFO - 'NO_EM_RESTART': '1', 07:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:50 INFO - 'PWD': '/builds/slave/test', 07:12:50 INFO - 'SHELL': '/bin/bash', 07:12:50 INFO - 'SHLVL': '1', 07:12:50 INFO - 'TERM': 'linux', 07:12:50 INFO - 'TMOUT': '86400', 07:12:50 INFO - 'USER': 'cltbld', 07:12:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', 07:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:50 INFO - '_': '/tools/buildbot/bin/python'} 07:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:50 INFO - Running setup.py (path:/tmp/pip-pBhpdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:50 INFO - Running setup.py (path:/tmp/pip-VYfp_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:50 INFO - Running setup.py (path:/tmp/pip-Klm1MB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:50 INFO - Running setup.py (path:/tmp/pip-eVgJSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:50 INFO - Running setup.py (path:/tmp/pip-kYTQWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:51 INFO - Running setup.py (path:/tmp/pip-c3yQ3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:51 INFO - Running setup.py (path:/tmp/pip-ScOKUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:51 INFO - Running setup.py (path:/tmp/pip-vFeaZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:51 INFO - Running setup.py (path:/tmp/pip-QD36TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:51 INFO - Running setup.py (path:/tmp/pip-z5ZryT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:51 INFO - Running setup.py (path:/tmp/pip-E4I2Ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:51 INFO - Running setup.py (path:/tmp/pip-dh77Iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:51 INFO - Running setup.py (path:/tmp/pip-RzS0Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:51 INFO - Running setup.py (path:/tmp/pip-_s_t3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:51 INFO - Running setup.py (path:/tmp/pip-GyNSdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:51 INFO - Running setup.py (path:/tmp/pip-BEbcSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:51 INFO - Running setup.py (path:/tmp/pip-thdBCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:12:51 INFO - Running setup.py install for manifestparser 07:12:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:12:51 INFO - Running setup.py install for mozcrash 07:12:52 INFO - Running setup.py install for mozdebug 07:12:52 INFO - Running setup.py install for mozdevice 07:12:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:12:52 INFO - Running setup.py install for mozfile 07:12:52 INFO - Running setup.py install for mozhttpd 07:12:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:12:52 INFO - Running setup.py install for mozinfo 07:12:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:12:52 INFO - Running setup.py install for mozInstall 07:12:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:12:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:12:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:12:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:12:52 INFO - Running setup.py install for mozleak 07:12:52 INFO - Running setup.py install for mozlog 07:12:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:12:52 INFO - Running setup.py install for moznetwork 07:12:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:12:52 INFO - Running setup.py install for mozprocess 07:12:53 INFO - Running setup.py install for mozprofile 07:12:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:12:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:12:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:12:53 INFO - Running setup.py install for mozrunner 07:12:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:12:53 INFO - Running setup.py install for mozscreenshot 07:12:53 INFO - Running setup.py install for moztest 07:12:53 INFO - Running setup.py install for mozversion 07:12:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:12:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:12:53 INFO - Cleaning up... 07:12:53 INFO - Return code: 0 07:12:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bcb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15619c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155ed60>, '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 0x155fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', '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 07:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:12:53 INFO - Using env: {'DISPLAY': ':0', 07:12:53 INFO - 'HOME': '/home/cltbld', 07:12:53 INFO - 'LANG': 'en_US.UTF-8', 07:12:53 INFO - 'LANGUAGE': 'en_US:en', 07:12:53 INFO - 'LOGNAME': 'cltbld', 07:12:53 INFO - 'MAIL': '/var/mail/cltbld', 07:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:53 INFO - 'MOZ_NO_REMOTE': '1', 07:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:53 INFO - 'NO_EM_RESTART': '1', 07:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:53 INFO - 'PWD': '/builds/slave/test', 07:12:53 INFO - 'SHELL': '/bin/bash', 07:12:53 INFO - 'SHLVL': '1', 07:12:53 INFO - 'TERM': 'linux', 07:12:53 INFO - 'TMOUT': '86400', 07:12:53 INFO - 'USER': 'cltbld', 07:12:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', 07:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:53 INFO - '_': '/tools/buildbot/bin/python'} 07:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:53 INFO - Running setup.py (path:/tmp/pip-z0lGJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:53 INFO - Running setup.py (path:/tmp/pip-CS1IF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:53 INFO - Running setup.py (path:/tmp/pip-7AQISr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:54 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)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:54 INFO - Running setup.py (path:/tmp/pip-2G0Xpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:54 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)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:54 INFO - Running setup.py (path:/tmp/pip-nDSzVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:54 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)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:54 INFO - Running setup.py (path:/tmp/pip-hXTSlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:54 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)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:54 INFO - Running setup.py (path:/tmp/pip-ScHVcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:54 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)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:54 INFO - Running setup.py (path:/tmp/pip-3KomNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:54 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)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:54 INFO - Running setup.py (path:/tmp/pip-0xIm08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:54 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)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:54 INFO - Running setup.py (path:/tmp/pip-VKU0Iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:54 INFO - Running setup.py (path:/tmp/pip-EtHOtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:54 INFO - Running setup.py (path:/tmp/pip-bLtCBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:54 INFO - Running setup.py (path:/tmp/pip-svgnp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:54 INFO - Running setup.py (path:/tmp/pip-epc1UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:54 INFO - Running setup.py (path:/tmp/pip-5pQU6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:54 INFO - Running setup.py (path:/tmp/pip-rmcYC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:54 INFO - Running setup.py (path:/tmp/pip-hQ2Wil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:55 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)) 07:12:55 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)) 07:12:55 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)) 07:12:55 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)) 07:12:55 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)) 07:12:55 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)) 07:12:55 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)) 07:12:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12: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 07:12: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 07:12: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 07:12: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 07:12:56 INFO - Downloading blessings-1.6.tar.gz 07:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:12:56 INFO - Installing collected packages: blessings 07:12:56 INFO - Running setup.py install for blessings 07:12:56 INFO - Successfully installed blessings 07:12:56 INFO - Cleaning up... 07:12:56 INFO - Return code: 0 07:12:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:56 INFO - Reading from file tmpfile_stdout 07:12:56 INFO - Current package versions: 07:12:56 INFO - argparse == 1.2.1 07:12:56 INFO - blessings == 1.6 07:12:56 INFO - blobuploader == 1.2.4 07:12:56 INFO - docopt == 0.6.1 07:12:56 INFO - functools32 == 3.2.3-2 07:12:56 INFO - jsonschema == 2.5.1 07:12:56 INFO - manifestparser == 1.1 07:12:56 INFO - mozInstall == 1.13 07:12:56 INFO - mozcrash == 1.0 07:12:56 INFO - mozdebug == 0.1 07:12:56 INFO - mozdevice == 0.51 07:12:56 INFO - mozfile == 1.2 07:12:56 INFO - mozhttpd == 0.7 07:12:56 INFO - mozinfo == 0.10 07:12:56 INFO - mozleak == 0.1 07:12:56 INFO - mozlog == 3.5 07:12:56 INFO - moznetwork == 0.27 07:12:56 INFO - mozprocess == 0.25 07:12:56 INFO - mozprofile == 0.28 07:12:56 INFO - mozrunner == 6.13 07:12:56 INFO - mozscreenshot == 0.1 07:12:56 INFO - mozsystemmonitor == 0.3 07:12:56 INFO - moztest == 0.8 07:12:56 INFO - mozversion == 1.4 07:12:56 INFO - psutil == 3.1.1 07:12:56 INFO - requests == 1.2.3 07:12:56 INFO - wsgiref == 0.1.2 07:12:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bcb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15619c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155ed60>, '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 0x155fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', '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 07:12:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:12:56 INFO - Using env: {'DISPLAY': ':0', 07:12:56 INFO - 'HOME': '/home/cltbld', 07:12:56 INFO - 'LANG': 'en_US.UTF-8', 07:12:56 INFO - 'LANGUAGE': 'en_US:en', 07:12:56 INFO - 'LOGNAME': 'cltbld', 07:12:56 INFO - 'MAIL': '/var/mail/cltbld', 07:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:56 INFO - 'MOZ_NO_REMOTE': '1', 07:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:56 INFO - 'NO_EM_RESTART': '1', 07:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:56 INFO - 'PWD': '/builds/slave/test', 07:12:56 INFO - 'SHELL': '/bin/bash', 07:12:56 INFO - 'SHLVL': '1', 07:12:56 INFO - 'TERM': 'linux', 07:12:56 INFO - 'TMOUT': '86400', 07:12:56 INFO - 'USER': 'cltbld', 07:12:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', 07:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:56 INFO - '_': '/tools/buildbot/bin/python'} 07:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:12:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:12:58 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)) 07:12:58 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)) 07:12:58 INFO - Installing collected packages: simplejson 07:12:58 INFO - Running setup.py install for simplejson 07:12:58 INFO - building 'simplejson._speedups' extension 07:12:58 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 07:12:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 07:12:59 INFO - Successfully installed simplejson 07:12:59 INFO - Cleaning up... 07:12:59 INFO - Return code: 0 07:12:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:12: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')]} 07:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12: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')]} 07:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bcb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15619c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155ed60>, '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 0x155fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', '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 07:12:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:12:59 INFO - Using env: {'DISPLAY': ':0', 07:12:59 INFO - 'HOME': '/home/cltbld', 07:12:59 INFO - 'LANG': 'en_US.UTF-8', 07:12:59 INFO - 'LANGUAGE': 'en_US:en', 07:12:59 INFO - 'LOGNAME': 'cltbld', 07:12:59 INFO - 'MAIL': '/var/mail/cltbld', 07:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:59 INFO - 'MOZ_NO_REMOTE': '1', 07:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:59 INFO - 'NO_EM_RESTART': '1', 07:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:59 INFO - 'PWD': '/builds/slave/test', 07:12:59 INFO - 'SHELL': '/bin/bash', 07:12:59 INFO - 'SHLVL': '1', 07:12:59 INFO - 'TERM': 'linux', 07:12:59 INFO - 'TMOUT': '86400', 07:12:59 INFO - 'USER': 'cltbld', 07:12:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', 07:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:59 INFO - '_': '/tools/buildbot/bin/python'} 07:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:12:59 INFO - Cleaning up... 07:12:59 INFO - Return code: 0 07:12:59 INFO - Running post-action listener: _resource_record_post_action 07:12:59 INFO - Running post-action listener: _start_resource_monitoring 07:12:59 INFO - Starting resource monitoring. 07:12:59 INFO - [mozharness: 2017-09-23 14:12:59.310988Z] Finished create-virtualenv step (success) 07:12:59 INFO - [mozharness: 2017-09-23 14:12:59.311503Z] Running install step. 07:12:59 INFO - Running pre-action listener: _resource_record_pre_action 07:12:59 INFO - Running main action method: install 07:12:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:59 INFO - Reading from file tmpfile_stdout 07:12:59 INFO - Detecting whether we're running mozinstall >=1.0... 07:12:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:12:59 INFO - Reading from file tmpfile_stdout 07:12:59 INFO - Output received: 07:12:59 INFO - Usage: mozinstall [options] installer 07:12:59 INFO - Options: 07:12:59 INFO - -h, --help show this help message and exit 07:12:59 INFO - -d DEST, --destination=DEST 07:12:59 INFO - Directory to install application into. [default: 07:12:59 INFO - "/builds/slave/test"] 07:12:59 INFO - --app=APP Application being installed. [default: firefox] 07:12:59 INFO - mkdir: /builds/slave/test/build/application 07:12:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:13:17 INFO - Reading from file tmpfile_stdout 07:13:17 INFO - Output received: 07:13:17 INFO - /builds/slave/test/build/application/firefox/firefox 07:13:17 INFO - Running post-action listener: _resource_record_post_action 07:13:17 INFO - [mozharness: 2017-09-23 14:13:17.422464Z] Finished install step (success) 07:13:17 INFO - [mozharness: 2017-09-23 14:13:17.422716Z] Running setup-mitmproxy step. 07:13:17 INFO - Running pre-action listener: _resource_record_pre_action 07:13:17 INFO - Running main action method: setup_mitmproxy 07:13:17 INFO - Skipping: mitmproxy is not required 07:13:17 INFO - Running post-action listener: _resource_record_post_action 07:13:17 INFO - [mozharness: 2017-09-23 14:13:17.423849Z] Finished setup-mitmproxy step (success) 07:13:17 INFO - [mozharness: 2017-09-23 14:13:17.424084Z] Running run-tests step. 07:13:17 INFO - Running pre-action listener: _resource_record_pre_action 07:13:17 INFO - Running pre-action listener: _set_gcov_prefix 07:13:17 INFO - Running main action method: run_tests 07:13:17 WARNING - Try message not found. 07:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:13:17 INFO - Python 2.7.3 07:13:17 INFO - Return code: 0 07:13:17 INFO - grabbing minidump binary from tooltool 07:13:17 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')]} 07:13:17 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 0x155ed60>, '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 0x155fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:13:17 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 07:13:17 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 07:13:17 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 07:13:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:13:17 INFO - Return code: 0 07:13:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:13:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:13:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:13:17 INFO - ENV: RUST_BACKTRACE is now full 07:13:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:13:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 07:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 07:13:17 INFO - Using env: {'DISPLAY': ':0', 07:13:17 INFO - 'HOME': '/home/cltbld', 07:13:17 INFO - 'LANG': 'en_US.UTF-8', 07:13:17 INFO - 'LANGUAGE': 'en_US:en', 07:13:17 INFO - 'LOGNAME': 'cltbld', 07:13:17 INFO - 'MAIL': '/var/mail/cltbld', 07:13:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:13:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:17 INFO - 'MOZ_NO_REMOTE': '1', 07:13:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:17 INFO - 'NO_EM_RESTART': '1', 07:13:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:17 INFO - 'PWD': '/builds/slave/test', 07:13:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:13:17 INFO - 'RUST_BACKTRACE': 'full', 07:13:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:13:17 INFO - 'SHELL': '/bin/bash', 07:13:17 INFO - 'SHLVL': '1', 07:13:17 INFO - 'TERM': 'linux', 07:13:17 INFO - 'TMOUT': '86400', 07:13:17 INFO - 'USER': 'cltbld', 07:13:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', 07:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:17 INFO - '_': '/tools/buildbot/bin/python'} 07:13:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 07:13:17 INFO - mozversion application_buildid: 20170923131849 07:13:17 INFO - mozversion application_changeset: 3828e44f5b0a56e7933b817d430cf32d41b03fe6 07:13:17 INFO - mozversion application_display_name: Nightly 07:13:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:13:17 INFO - mozversion application_name: Firefox 07:13:17 INFO - mozversion application_remotingname: firefox 07:13:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:13:17 INFO - mozversion application_vendor: Mozilla 07:13:17 INFO - mozversion application_version: 58.0a1 07:13:17 INFO - mozversion platform_buildid: 20170923131849 07:13:17 INFO - mozversion platform_changeset: 3828e44f5b0a56e7933b817d430cf32d41b03fe6 07:13:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:13:17 INFO - mozversion platform_version: 58.0a1 07:13:17 INFO - using testdate: 1506175997 07:13:17 INFO - actual date: 1506175997 07:13:17 INFO - starting webserver on 'localhost:59451' 07:13:17 INFO - SUITE-START | Running 2 tests 07:13:17 INFO - TEST-START | dromaeo_css 07:13:17 INFO - Initialising browser for dromaeo_css test... 07:13:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59451/getInfo.html -profile /tmp/tmpjodW_n/profile 07:13:17 INFO - TEST-INFO | started process 31225 (/builds/slave/test/build/application/firefox/firefox http://localhost:59451/getInfo.html) 07:13:24 INFO - TEST-INFO | 31225: exit 0 07:13:24 INFO - Browser initialized. 07:13:24 INFO - Running cycle 1/1 for dromaeo_css test... 07:13:24 INFO - Using env: {'DISPLAY': ':0', 07:13:24 INFO - 'HOME': '/home/cltbld', 07:13:24 INFO - 'JSGC_DISABLE_POISONING': '1', 07:13:24 INFO - 'LANG': 'en_US.UTF-8', 07:13:24 INFO - 'LANGUAGE': 'en_US:en', 07:13:24 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:13:24 INFO - 'LOGNAME': 'cltbld', 07:13:24 INFO - 'MAIL': '/var/mail/cltbld', 07:13:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:13:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:13:24 INFO - 'MOZ_CRASHREPORTER': '1', 07:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:24 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:13:24 INFO - 'MOZ_NO_REMOTE': '1', 07:13:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:24 INFO - 'NO_EM_RESTART': '1', 07:13:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:24 INFO - 'PWD': '/builds/slave/test', 07:13:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:13:24 INFO - 'RUST_BACKTRACE': 'full', 07:13:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:13:24 INFO - 'SHELL': '/bin/bash', 07:13:24 INFO - 'SHLVL': '1', 07:13:24 INFO - 'STYLO_FORCE_DISABLED': '1', 07:13:24 INFO - 'TERM': 'linux', 07:13:24 INFO - 'TMOUT': '86400', 07:13:24 INFO - 'USER': 'cltbld', 07:13:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', 07:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:24 INFO - '_': '/tools/buildbot/bin/python'} 07:13:24 INFO - TEST-INFO | started process 31463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjodW_n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:25 INFO - PID 31463 | 07:13:25 INFO - PID 31463 | (/builds/slave/test/build/application/firefox/firefox:31511): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:13:25 INFO - PID 31463 | 07:13:35 INFO - PID 31463 | RSS: Main: 151220224 07:13:35 INFO - PID 31463 | 07:16:32 INFO - PID 31463 | Cycle 1(1): loaded http://localhost:59451/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59451/tests/dromaeo/cssquery-ext.html) 07:16:33 INFO - PID 31463 | RSS: Main: 152260608 07:16:33 INFO - PID 31463 | 07:19:35 INFO - PID 31463 | Cycle 1(1): loaded http://localhost:59451/tests/dromaeo/cssquery-ext.html (next: http://localhost:59451/tests/dromaeo/cssquery-jquery.html) 07:19:36 INFO - PID 31463 | RSS: Main: 151162880 07:19:36 INFO - PID 31463 | 07:22:37 INFO - PID 31463 | Cycle 1(1): loaded http://localhost:59451/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59451/tests/dromaeo/cssquery-mootools.html) 07:22:38 INFO - PID 31463 | RSS: Main: 153362432 07:22:38 INFO - PID 31463 | 07:25:40 INFO - PID 31463 | Cycle 1(1): loaded http://localhost:59451/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59451/tests/dromaeo/cssquery-prototype.html) 07:25:40 INFO - PID 31463 | RSS: Main: 153317376 07:25:40 INFO - PID 31463 | 07:28:43 INFO - PID 31463 | Cycle 1(1): loaded http://localhost:59451/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59451/tests/dromaeo/cssquery-yui.html) 07:28:44 INFO - PID 31463 | RSS: Main: 154554368 07:28:44 INFO - PID 31463 | 07:31:46 INFO - PID 31463 | Cycle 1(1): loaded http://localhost:59451/tests/dromaeo/cssquery-yui.html (next: http://localhost:59451/tests/dromaeo/cssquery-dojo.html) 07:31:46 INFO - PID 31463 | RSS: Main: 157052928 07:31:46 INFO - PID 31463 | 07:31:46 INFO - PID 31463 | __start_tp_report 07:31:46 INFO - PID 31463 | _x_x_mozilla_page_load 07:31:46 INFO - PID 31463 | _x_x_mozilla_page_load_details 07:31:46 INFO - PID 31463 | |i|pagename|runs| 07:31:46 INFO - PID 31463 | |0;dojo.html;3110.206897241203;3120.781545291829;3126.499760038393;3129.9843500782495;3159.605049368829;6175.814725558241;6310.179676642036;6331.335209802974;6404.071409645599;6430.7106180221945;6281.466075383598;6308.747650093991;6334.651594162331;6362.14111095002;6387.329330420309;5877.911831322513;5908.881822363561;5934.64392136471;5940.792072277472;5957.970210148943;1319.2964355691915;5751.367349591542;5879;5894.970525147368;5907.291125064999;5348.491893270133;5716.942830571683;5780.71096445176;5819.272590926134;5883.676397798119;5821.301443826768;5851.94664960307;5876.265466816648;5906.055031195031;5921;5800.680962547058;5811.186433899257;5843.065109582446;5888.676122813244;5913.201717768132;6216.129741836146;6318.304986451487;6395.232572091332;6443.83890402739;6475.384838440341;6626.370494802986;6699.363560461748;6782.966085169592;6855.4172895303955;6865.107536020335;6776.15298087739;6886.414654754352;6905.102336696197;6905.343992320722;6912.723491060352;6312.305646378894;6425.58233714807;6433.871322573569;6469.644169570672;6473.643949582818;7052;7062.540934839219;7132.215456299803;7138.750143745048;7152.284771522806;6720.831979200461;6734.3602357775935;6801.081853949752;6808.965955170292;6845.452363810883;6627.834304142339;6717.093192419059;6721;6723.731050757915;6736.966315168491;6622.437092847162;6697.6986035628515;6710.731570737116;6717.227518835299;6727.831804204934;6852.486063545254;6877.552959057645;6879.346462086094;6909.965450172717;6921.169459664772;5354.518093371616;5419.295491586068;5421.566274698014;5423.511883930465;5429.728513574384;4630.398048253705;4633.096546173464;4670.509596492319;4703;4708.976455117702;5669.121286200645;5824.88350232993;5826.271716035496;5915.053591425351;5921.970390148022;6931.202911665223;6971.372576468142;6985.022096906438;6985.266547012592;6985.790426287118;5838.766449341979;5854.882902341929;5867.266591676041;5918.911216331759;5936.7922122725495;5708.971455142698;5805.883882322414;5880.26496687914;5945.910811337833;5955.076963070731;6547.148870646881;6613.074169616258;6619.669016549154;6632.502562307846;6654.567453115532;6877.140357455318;6940.687669054904;6965.825854353681;6968.547044442298;6969.16370035599;6589.374009469093;6599.241087274832;6603.042558828847;6691.230508491586;6703;6520.576162549609;6659.467242620675;6662.100616416916;6673.432758215606;6713.63075030878;6769.3907548320885;6815.659217039228;6816.113905192294;6930.792076237721;6935.653217339213;6552.312007239171;6670.599764014175;6715.3620406061345;6715.395614394728;6721.495887808532;6641.236257830218;6641.634710090992;6644.069830223869;6725.932740672531;6729.360710732472;6392.93607063942;6516.57642253252;6567.540272180901;6646.169228846395;6655.866882662222;6638.435732962752;6666.133402657623;6678.065070889982;6709.664516774239;6716.932830671826;6394.296627371078;6521.836954075996;6528.37980391862;6530.934690653033;6538.934610653832 07:31:46 INFO - PID 31463 | |1;ext.html;866.3199388480044;897.6319708919342;902.7201567514071;904.9366544341894;905.2305540290749;37079.629203707955;40780.38829417557;40819.59180408195;40844.99999999996;41015.58984410155;38229.42655860164;38652;38681.80659096708;38728.22543549127;38943.221135577274;7229.096362954644;7348.559086454829;7369.078865141857;7787.454878158503;7961;7810.648520816577;7913.920860791405;7931.246531579491;7932.286094251516;7934.761957141266;7831.765047048598;7842.490238134532;7938;7956.085050219241;7957.761267161965;7871.134175240719;7907.96046019772;7932.682692692343;7952.721654742085;7957.562334071624;7796.064472263308;7890.763277101696;7928.405369597303;7957.084935232465;7963.6018199090395;36608;36903.63096369029;36915.81542092272;36944.26111477782;37031.4445283321;3487.442009278503;3519.278547897675;3521.2781379817075;3521.3133438979407;3522.5420695309704;31469.527957080663;31577.368452630817;31611.20971975696;31637.52543711823;31652.525212121607;5087.796488140507;5105.948940510584;5132.435432102466;5146.7683954221775;5152.201408781645;185114;185947;187418;187914;188305;41282.1743565127;41873.79063104665;47578.5242147581;47852;48062.279065814044;43095;50079.74960125176;50739.74630126826;51024;51114.488855110976;16225.837741622432;16368.099754513378;16372.672546549002;16376.099314537576;16382.426615068654;13476.056676032584;13519.188848669111;13520.526781562598;13524.661883452796;13540.119892206974;14299.07056041354;14301.28493575338;14368.425262989573;14399.496017639332;14565.854341456661;5832.766689332464;5855.560832937462;5944.881102377928;6027.427394397525;6035.66803825785;995.6465454763454;1015.3755440404099;1016.7763092119721;1024.4212020208558;1034.9586016559404;22604.434889127904;22825;22926.082956681545;23054.96252668634;23443.296701098996;1101.9393933333743;1119.2333251722596;1121.556984990924;1126.0597401170114;1131.5813149134708;12135.575254866037;12201.572944946884;12217.511299548096;12239.143259971894;12259.080568957364;211218;213371;213537;213737;214004;51543.74228128835;51701.2244816328;51922.48077519252;51958.480415195365;51959.48040519622;1432.58455048037;1465.9924422146494;1470.4485817818318;1485.1979930837442;1488.278185080257;21738.782612173676;21897.890510547346;22061.11755529761;22160.667589985842;22423.32730018102;35783.28433431369;35792.28415431625;35896.102597435274;35915.1021224461;35934.281314373045;188093;188828;189626;189813;190004;30467.695323047374;31683.683163168072;31706.524402133524;31966.52050219202;31993.200169995936;39431;40895.591044089175;40926.795366022976;41109.58890411058;41574.79212604039;30040.3991920156;30290.545641815832;30300.24249393783;30482.237944051576;30643.080707578807;30425;30874.845625771726;30967.845160774054;31007;31592.526112108797;34053.65946340505;34229;34254.48618270778;34514.654853451146;34647.82676086603;29829.701702982693;30068.69931300659;30126.397472049997;30204.395912082076;30459.39081218319;22376.216832410788;22631.88684056569;22684.319470415914;22836.31491055271;23042.423939401648 07:31:46 INFO - PID 31463 | |2;jquery.html;577.1861675038197;584.2521572387341;597.417517920028;599.3886236039237;612.9080637904315;22276.220332288354;23007.769922300773;23022.769772302272;23032.76967230327;23045.654315185286;24046.158384456503;24778;24928.501429971435;25304.367390815238;25309.2407227783;6550.737970481175;6783.3216678332265;6784.2876497967745;6802.931970680304;6805.183377994623;6352.936470635281;6685.398314151726;6773.627450490221;6791.932080679204;6806.761763338284;6701.128853249095;6701.564398314094;6718.160229971254;6723.29405412432;6726.159230096238;6614.404703576653;6649.93350066498;6658.234303055138;6658.667066646648;6673.733050677967;5969;6188.81433556994;6206.193194884681;6206.410391012847;6224.782132625336;27998.720012799815;28498.430031399257;28512;28550.143495694956;28553.14340569786;2053.9589208215752;2077.2833372486466;2077.5637116205617;2078.6985887046294;2080.583883223361;18792.436226913214;19193.61612767751;19457.51356216092;19500.31748888782;19522.902385488123;2471.8269721119527;2483.75162483752;2533.8606376649277;2540.898364065435;2541.7458254174435;123971;129535;134797;140998.2950085243;142007;14595;14686.153569322098;15100.54698359051;15174.344489714256;15670.216489175496;23746.7625323748;23852.64221036686;23860.64209036866;23916.52166956686;23916.760832391803;10095.444750538643;10125.898741012496;10164.593416263267;10267.691969240936;10381.896181038093;9219.078092190728;9321.347505674674;9340.532973351304;9347.953260233791;9411.43531388119;9238.95380523093;9339.299552533586;9458.621655133718;9462.195713364441;9481.952590237004;2781.425867759959;2786.3591373984095;2787.665480142396;2808.873600687974;2883.5530492773655;942.9245660347156;961.3751061809879;966.7438128895848;983.409954027592;991.4992928571025;18898.976163813724;19089;19152.904235478734;19283.22867085301;19666.115024823917;1028.7993841200894;1039.6257347354947;1040.547361897577;1046.984295235572;1048.821700310949;10509.684709458728;10653.627123050655;10687.091597214168;10701.946490267655;10743.83884241737;459129;463678;476977;478070;480534.3893122118;114384;115178.4241078806;116160;117740;118172.40913795376;1126.819708846597;1128.8476055732372;1151.1308961733837;1157.6469176900957;1158.8956993870424;16670.833291666928;16809.41167059147;16832.57918552046;16879.240434180247;16921.492355229362;58072.709636451546;58175.12737308859;58366.7081664589;59333.70333148307;60572.091418629636;72321.6383918077;72358;72395.63802180956;72418.63790681012;72637.27362726306;14137.222452765196;14474.348654310792;14609.342579583732;14609.342579584158;14625.561233163022;21448.678269826276;21651.566968660853;21907.452313692283;21967.450813729785;21996.120155193614;15386.307616157075;15639.530814075595;15657.21713914277;15694.529164125095;16055.518334449986;15753.763693544377;16042.35830566811;16060.919695401448;16234.67530649404;16621.41825036118;16355.754663679816;17427.651446970736;17503.82496175022;17751.822481775016;17788.733169002735;13928.164310141425;13983.091099078527;14031.228282444563;14087.718245635235;14116.647083822987;16682.332706692083;16776.58058548546;16804.663906722042;17621;17642 07:31:46 INFO - PID 31463 | |3;mootools.html;1344.677277453411;1385.258886495725;1402.7545179593576;1418.2625034981813;1421.9289035548213;14947.626309342271;15646.84353156468;15646.84353156468;15654;15673.764893526606;14971.850281497182;15291.617709557268;15318.0809151451;15366.769498457532;15405.92297038516;2732.8087033907636;2829.618001569793;2830.066078194191;2840.9289767755868;2842.8294302341824;2698.3254186453387;2734.917952461419;2792.706765789593;2799.860006999652;2802.7897907657007;2754.077384076337;2769.1830909881633;2773.209635253953;2782.373965857686;2783.7633801126926;2636.064197209982;2684.127658510982;2686.3149896776395;2688.0323083689955;2704.567269236932;2576.755208255213;2701.554243549812;2748.3816141368234;2754.3664957059787;2762.986185069082;15338.693226135527;15379.538613841603;15397.692046159125;15446.382144714311;15579.688406231926;8012.679492820338;8368.037675667316;8371.706990255312;8391.580420978988;8393.202645748644;5310.522053015208;5428.75570599324;5577.581681373913;5600.439956004408;5619.381867994517;1972.4279958811928;1974.5614166504356;1985.4440756588178;1988.2842176816334;2033.5932813437223;27088.45823083547;27089.1873243803;27203.183904482896;27222.591661125098;27449.725502745117;6873.175218973655;6959.19969203548;6976.755813546603;6999.160100787836;7028.297170282931;16787.160641968097;17424.825751742574;17499.737503937453;17513.7372939406;17531.386401475887;8130.02439707239;8280.668773249003;8293.668253269801;8302.6678932842;8303.169683031769;7365.631718414058;7369.8894516582295;7543.660535275926;7566;7591.810204744926;5293.232481290192;5392.865178370572;5442.292501974718;5444.891102177934;5455.8363249102595;1579.2577488580348;1591.0930769461295;1591.9840801591836;1597.209381356236;1615.3619320368389;862.7498025572639;872.1365847810622;894.4096896048577;895.7536677413633;898.0390981649572;7277.053982982178;7380.225076367012;7383.8154046149275;7422.814429639194;7477.626118694044;696.6531867913742;715.2882881532908;725.7822653204017;738.8706976279129;747.1892996099184;4809.663323567387;5061.089003979319;5266.34170728659;5288.0745869472685;5288.153895376721;21406;21407.250746223806;21785.891070544545;22381.216657416913;22535.661965070536;21694.240701575683;21896;22091.889540552515;22100.557988840133;22123.778762212172;10817.945910270399;11411.144164187719;11455;11518.136139789549;11539.249948753304;8084.797880053045;8139.186081391814;8177;8254.174582541698;8268.503889766393;18277.817221828143;19272.22911083541;19365.8063419364;19376.903115484332;19410.4176874694;19622.215111395384;19857.304994325128;19955.501112472306;20337.389878303675;20502.487437814176;10950.780984380108;10971.725706857393;11081.5567377304;11085.612003579836;11088.833667494833;13776.173429594257;13964.441422342992;14075.577732668036;14174.362153702901;14194.290285485891;11332.660020199408;11774.470148843495;11824.290542567473;11832.881671183179;11950.940245298718;10950.671479855617;10991;11234;11287.43562821872;11298.830517542408;9388.061193880558;9404.482753448627;9512.191463725661;9605.279604029585;9605.37565058269;7091.503594748318;7180.783312770632;7206.7117315306805;7231.674574644048;7361.190269070291;6940.236573976959;7022.473314501331;7087.3267039631155;7216.097987751531;7286.417086633162 07:31:46 INFO - PID 31463 | |4;prototype.html;509.5198448507088;539.3366159623661;539.6465315218531;545.3210752612999;546.0907588864541;6431.839204019901;6440.903386449207;6479.060536222257;6504.83737906552;6521.608703477795;6288.559800813945;6297.401746834055;6315.179026726519;6316.652584107872;6382.361763823616;5289.68261904285;5319.7340132993295;5336.519713225809;5343.145096784515;5347.839564813062;4951.504849515038;5281.70950597717;5291.100512912795;5312.521873031426;5314.3091398118195;5072.51811077947;5078.5937125029905;5108.438071812097;5114.718690472023;5137.713717395742;5055.898882022376;5060.51925067118;5093.617978651598;5095.108356037678;5154.716490593035;4505.887352816206;4547.79534920926;4562.726236425825;4579.473360563545;4580.580020193717;6121.204243448323;6136.815895523141;6171;6216;6250.562460627758;5780.50865676418;5828.883422331572;5834.5624078194305;5848.502877255439;5883.941160588382;6559.93440065598;6595.571287866273;6665.93334066658;6694.263631000586;6716.563423377514;4972.977292934126;5016.724080175589;5034.395872495287;5037.949620503821;5055.949440505585;6708.94742891983;6799.252082270996;6884.277150899134;6912.135983002125;6992.825179370557;5066.392032955995;5087.847364579068;5141.717205553656;5149.150390185652;5150.253213284052;5179.22311653255;5204.245384419238;5209.6874187548865;5212.218167274863;5224.302101816925;5840.364697884599;5847.736851841677;5857.941420585739;5872.17789509469;5881.911771323434;6613.371729685672;6700.865982680319;6717.227518835299;6717.932820671731;6743.763968261087;1779.6084861330487;1783.7056885613729;1797.6494583556344;1798.397536825152;1801.9549511262323;1205.7009105755678;1257.7736007518552;1269;1270.7966725323904;1274.2991354754847;5793.333766616809;5817.069268916953;5842;5843.415658434123;5850.970745146332;6718.395344418928;6811.795646130624;6860.485463590251;6874.181585550001;6888.345607167311;5845.912311315334;5859.824205273849;5862.355140934494;5875.294964604275;5908.632079714607;3486;3571.1250743567994;3582.3193593217206;3588.748787584844;3635.2911182319194;6444.548881578338;6502.284748677642;6527.5430719849155;6528.37980391862;6536.934630653727;6849.212340580797;6852.657367131723;6906.689198986058;6908.095252370773;6921.757738479129;6561.703403808724;6574.539782215199;6583.308752581006;6626.171728533934;6674.763954075439;6806.489513286622;6855.383015528626;6855.628874225075;6862.691178896862;6910.239873613999;6732.259451460238;6767.458603311625;6814.454843612598;6825.761098361533;6858.987492316851;6540;6580.276169621242;6609.537332386687;6655.966720166562;6666.600003999775;5062.265971434195;5092;5120.308758317579;5155.896882062263;5158.8968220636125;6514.185726784152;6607.3062328456745;6742.966285168739;6799.524033317818;6910.792676219721;6383.425491705769;6611.239707433514;6612.404883560503;6670.39966403026;6735.898961515483;6613.677264547014;6648.7340506379205;6682.966585167043;6699.430548403246;6703.927371620517;6348.904766428415;6553.4101930826455;6576.605403675795;6577.835554111186;6623.271440141677;6605.649423966603;6644.534882558174;6717.798466046026;6735.898961515679;6745.494087943326;6437.774677886251;6445.25879523842;6448.291202831159;6497.693318871921;6506.4469520091325 07:31:46 INFO - PID 31463 | |5;yui.html;907.0566610724838;915.3272344826553;927.2720914082447;940.6331530703027;954.3891909178125;18481.63036739266;19607.411777646692;19614.803851961475;19616.313429029986;19654.312099076535;18284.817151828476;18565.164567594456;18622.441326760185;19211.32760353388;19384.709229361535;955.4219697083252;963.0850691842743;967.6468089147446;969.2633598465146;969.8448248280276;960.6973803251988;996.7109538233904;998.8202123617746;999.0708640963937;999.1956475037592;1039.1530902314628;1054.2146101154613;1054.2725519391595;1054.4833031814394;1054.488573042074;1027.748201690583;1032.1226957086417;1034.9793004139913;1035.3529044347283;1036.6475398364555;723.2767232767233;746.7237122264743;746.8543633991374;752.9887051694229;766.5477368352699;20159.697604535944;20372.490687732778;20376.28682996088;20422.69365959497;20455;21635.567288654296;21705.457363566038;22824.657630135396;22959.311220663407;22966.54066918669;17343.13284335778;17665.470035898943;17700.734488982675;17840.107994600217;17872.463826085237;3811.3330167220624;3835.9808200959096;3837.827297771607;3840.0975770693863;3840.443135745329;137444;139087;140533;141821.29089354488;143125.2843735785;16965.91517042407;17043.573910652332;17231.3969011084;17340.739888901677;17365.82634173642;31268.84365578203;31612.683873161433;31814.840925795223;31870;31890;8545.786355341166;8559.101294364127;8568.443051201652;8626.051134375213;8677.219050285505;4092.7339722917914;4187.623113919701;4245.0448649053715;4253.404523366731;4313.180495705806;5368.812091576776;5466.671999680032;5473.17902314648;5487.835364939058;5494.5054945055135;982.4350998176077;999.4003597841237;1014.0569270578433;1014.6448742939912;1016.6695823857128;680.550836447942;687.1445050911548;696.7178292791427;712.1205311440367;714.0538786108324;11277.605283815192;11959.222650527689;12182.512699491921;12696.555620553236;12726.80909786354;628.827072555051;632.914556534871;664.5945972956492;670.1054092786185;678.7658257901016;5697.544196464273;5700.258966334433;5734.655920644691;5757.366689664133;5762.827115186551;115468.42265788617;116524;117993.410032951;121705.39147304384;121850;104614.47692761487;105543;107430.46284768682;107750;108076;94372.52813735888;94915.52542237383;97801.51099244459;98436.50781746046;98740.99999999856;10688.893111069101;10775.137988960707;10840.837387439036;10916.50875710579;11153.888461115284;46156.307655384524;46162.769186153855;46394.30408543807;47095.764521177174;47418.288725668455;59587;59630.70184649049;59928.400715992284;60567.39432605617;60942.69528652506;15308.158051307286;15636.140012299433;15778.289976950835;15859.762103568224;15868.206589670239;17329.56676083108;17449.56376090608;17554.21006054705;17625.73561396606;17684.204210810803;15503;15714.371425142866;15754.921225394259;15887.761683574525;15898.125603091941;14895.255237237878;15026.849731502545;15158.848411515744;15160.772588410962;15197.164155971528;14555.781663274847;14618.926905365404;14664.413423462942;14697.632559185678;14774.039687420283;12015.158938874194;12333.198342107735;12531.812022819482;12542.372881356077;12617.81073283883;11090.500927458123;11135.164862635496;11141.777164456827;11350.886491134983;11627.302361858316 07:31:46 INFO - PID 31463 | __end_tp_report 07:31:46 INFO - PID 31463 | __start_cc_report 07:31:46 INFO - PID 31463 | _x_x_mozilla_cycle_collect,322 07:31:46 INFO - PID 31463 | __end_cc_report 07:31:46 INFO - PID 31463 | __startTimestamp1506177106432__endTimestamp 07:31:46 INFO - PID 31463 | 07:31:46 INFO - PID 31463 | ------- Summary: start ------- 07:31:46 INFO - PID 31463 | Number of tests: 6 07:31:46 INFO - PID 31463 | 07:31:46 INFO - PID 31463 | [#0] dojo.html Cycles:165 Average:6246.38 Median:6538.93 stddev:860.46 (13.2%) stddev-sans-first:827.18 07:31:46 INFO - PID 31463 | Values: 3110.2 3120.8 3126.5 3130.0 3159.6 6175.8 6310.2 6331.3 6404.1 6430.7 6281.5 6308.7 6334.7 6362.1 6387.3 5877.9 5908.9 5934.6 5940.8 5958.0 1319.3 5751.4 5879.0 5895.0 5907.3 5348.5 5716.9 5780.7 5819.3 5883.7 5821.3 5851.9 5876.3 5906.1 5921.0 5800.7 5811.2 5843.1 5888.7 5913.2 6216.1 6318.3 6395.2 6443.8 6475.4 6626.4 6699.4 6783.0 6855.4 6865.1 6776.2 6886.4 6905.1 6905.3 6912.7 6312.3 6425.6 6433.9 6469.6 6473.6 7052.0 7062.5 7132.2 7138.8 7152.3 6720.8 6734.4 6801.1 6809.0 6845.5 6627.8 6717.1 6721.0 6723.7 6737.0 6622.4 6697.7 6710.7 6717.2 6727.8 6852.5 6877.6 6879.3 6910.0 6921.2 5354.5 5419.3 5421.6 5423.5 5429.7 4630.4 4633.1 4670.5 4703.0 4709.0 5669.1 5824.9 5826.3 5915.1 5922.0 6931.2 6971.4 6985.0 6985.3 6985.8 5838.8 5854.9 5867.3 5918.9 5936.8 5709.0 5805.9 5880.3 5945.9 5955.1 6547.1 6613.1 6619.7 6632.5 6654.6 6877.1 6940.7 6965.8 6968.5 6969.2 6589.4 6599.2 6603.0 6691.2 6703.0 6520.6 6659.5 6662.1 6673.4 6713.6 6769.4 6815.7 6816.1 6930.8 6935.7 6552.3 6670.6 6715.4 6715.4 6721.5 6641.2 6641.6 6644.1 6725.9 6729.4 6392.9 6516.6 6567.5 6646.2 6655.9 6638.4 6666.1 6678.1 6709.7 6716.9 6394.3 6521.8 6528.4 6530.9 6538.9 07:31:46 INFO - PID 31463 | 07:31:46 INFO - PID 31463 | [#1] ext.html Cycles:180 Average:36095.74 Median:34241.74 stddev:50856.63 (148.5%) stddev-sans-first:50930.50 07:31:46 INFO - PID 31463 | Values: 866.3 897.6 902.7 904.9 905.2 37079.6 40780.4 40819.6 40845.0 41015.6 38229.4 38652.0 38681.8 38728.2 38943.2 7229.1 7348.6 7369.1 7787.5 7961.0 7810.6 7913.9 7931.2 7932.3 7934.8 7831.8 7842.5 7938.0 7956.1 7957.8 7871.1 7908.0 7932.7 7952.7 7957.6 7796.1 7890.8 7928.4 7957.1 7963.6 36608.0 36903.6 36915.8 36944.3 37031.4 3487.4 3519.3 3521.3 3521.3 3522.5 31469.5 31577.4 31611.2 31637.5 31652.5 5087.8 5105.9 5132.4 5146.8 5152.2 185114.0 185947.0 187418.0 187914.0 188305.0 41282.2 41873.8 47578.5 47852.0 48062.3 43095.0 50079.7 50739.7 51024.0 51114.5 16225.8 16368.1 16372.7 16376.1 16382.4 13476.1 13519.2 13520.5 13524.7 13540.1 14299.1 14301.3 14368.4 14399.5 14565.9 5832.8 5855.6 5944.9 6027.4 6035.7 995.6 1015.4 1016.8 1024.4 1035.0 22604.4 22825.0 22926.1 23055.0 23443.3 1101.9 1119.2 1121.6 1126.1 1131.6 12135.6 12201.6 12217.5 12239.1 12259.1 211218.0 213371.0 213537.0 213737.0 214004.0 51543.7 51701.2 51922.5 51958.5 51959.5 1432.6 1466.0 1470.4 1485.2 1488.3 21738.8 21897.9 22061.1 22160.7 22423.3 35783.3 35792.3 35896.1 35915.1 35934.3 188093.0 188828.0 189626.0 189813.0 190004.0 30467.7 31683.7 31706.5 31966.5 31993.2 39431.0 40895.6 40926.8 41109.6 41574.8 30040.4 30290.5 30300.2 30482.2 30643.1 30425.0 30874.8 30967.8 31007.0 31592.5 34053.7 34229.0 34254.5 34514.7 34647.8 29829.7 30068.7 30126.4 30204.4 30459.4 22376.2 22631.9 22684.3 22836.3 23042.4 07:31:46 INFO - PID 31463 | 07:31:46 INFO - PID 31463 | [#2] jquery.html Cycles:180 Average:34008.64 Median:22642.00 stddev:79738.82 (352.2%) stddev-sans-first:79923.00 07:31:46 INFO - PID 31463 | Values: 577.2 584.3 597.4 599.4 612.9 22276.2 23007.8 23022.8 23032.8 23045.7 24046.2 24778.0 24928.5 25304.4 25309.2 6550.7 6783.3 6784.3 6802.9 6805.2 6352.9 6685.4 6773.6 6791.9 6806.8 6701.1 6701.6 6718.2 6723.3 6726.2 6614.4 6649.9 6658.2 6658.7 6673.7 5969.0 6188.8 6206.2 6206.4 6224.8 27998.7 28498.4 28512.0 28550.1 28553.1 2054.0 2077.3 2077.6 2078.7 2080.6 18792.4 19193.6 19457.5 19500.3 19522.9 2471.8 2483.8 2533.9 2540.9 2541.7 123971.0 129535.0 134797.0 140998.3 142007.0 14595.0 14686.2 15100.5 15174.3 15670.2 23746.8 23852.6 23860.6 23916.5 23916.8 10095.4 10125.9 10164.6 10267.7 10381.9 9219.1 9321.3 9340.5 9348.0 9411.4 9239.0 9339.3 9458.6 9462.2 9482.0 2781.4 2786.4 2787.7 2808.9 2883.6 942.9 961.4 966.7 983.4 991.5 18899.0 19089.0 19152.9 19283.2 19666.1 1028.8 1039.6 1040.5 1047.0 1048.8 10509.7 10653.6 10687.1 10701.9 10743.8 459129.0 463678.0 476977.0 478070.0 480534.4 114384.0 115178.4 116160.0 117740.0 118172.4 1126.8 1128.8 1151.1 1157.6 1158.9 16670.8 16809.4 16832.6 16879.2 16921.5 58072.7 58175.1 58366.7 59333.7 60572.1 72321.6 72358.0 72395.6 72418.6 72637.3 14137.2 14474.3 14609.3 14609.3 14625.6 21448.7 21651.6 21907.5 21967.5 21996.1 15386.3 15639.5 15657.2 15694.5 16055.5 15753.8 16042.4 16060.9 16234.7 16621.4 16355.8 17427.7 17503.8 17751.8 17788.7 13928.2 13983.1 14031.2 14087.7 14116.6 16682.3 16776.6 16804.7 17621.0 17642.0 07:31:46 INFO - PID 31463 | 07:31:46 INFO - PID 31463 | [#3] mootools.html Cycles:180 Average:9444.01 Median:27212.89 stddev:6840.03 (25.1%) stddev-sans-first:6832.15 07:31:46 INFO - PID 31463 | Values: 1344.7 1385.3 1402.8 1418.3 1421.9 14947.6 15646.8 15646.8 15654.0 15673.8 14971.9 15291.6 15318.1 15366.8 15405.9 2732.8 2829.6 2830.1 2840.9 2842.8 2698.3 2734.9 2792.7 2799.9 2802.8 2754.1 2769.2 2773.2 2782.4 2783.8 2636.1 2684.1 2686.3 2688.0 2704.6 2576.8 2701.6 2748.4 2754.4 2763.0 15338.7 15379.5 15397.7 15446.4 15579.7 8012.7 8368.0 8371.7 8391.6 8393.2 5310.5 5428.8 5577.6 5600.4 5619.4 1972.4 1974.6 1985.4 1988.3 2033.6 27088.5 27089.2 27203.2 27222.6 27449.7 6873.2 6959.2 6976.8 6999.2 7028.3 16787.2 17424.8 17499.7 17513.7 17531.4 8130.0 8280.7 8293.7 8302.7 8303.2 7365.6 7369.9 7543.7 7566.0 7591.8 5293.2 5392.9 5442.3 5444.9 5455.8 1579.3 1591.1 1592.0 1597.2 1615.4 862.7 872.1 894.4 895.8 898.0 7277.1 7380.2 7383.8 7422.8 7477.6 696.7 715.3 725.8 738.9 747.2 4809.7 5061.1 5266.3 5288.1 5288.2 21406.0 21407.3 21785.9 22381.2 22535.7 21694.2 21896.0 22091.9 22100.6 22123.8 10817.9 11411.1 11455.0 11518.1 11539.2 8084.8 8139.2 8177.0 8254.2 8268.5 18277.8 19272.2 19365.8 19376.9 19410.4 19622.2 19857.3 19955.5 20337.4 20502.5 10950.8 10971.7 11081.6 11085.6 11088.8 13776.2 13964.4 14075.6 14174.4 14194.3 11332.7 11774.5 11824.3 11832.9 11950.9 10950.7 10991.0 11234.0 11287.4 11298.8 9388.1 9404.5 9512.2 9605.3 9605.4 7091.5 7180.8 7206.7 7231.7 7361.2 6940.2 7022.5 7087.3 7216.1 7286.4 07:31:46 INFO - PID 31463 | 07:31:46 INFO - PID 31463 | [#4] prototype.html Cycles:180 Average:5618.99 Median:6292.98 stddev:1558.91 (24.8%) stddev-sans-first:1515.38 07:31:46 INFO - PID 31463 | Values: 509.5 539.3 539.6 545.3 546.1 6431.8 6440.9 6479.1 6504.8 6521.6 6288.6 6297.4 6315.2 6316.7 6382.4 5289.7 5319.7 5336.5 5343.1 5347.8 4951.5 5281.7 5291.1 5312.5 5314.3 5072.5 5078.6 5108.4 5114.7 5137.7 5055.9 5060.5 5093.6 5095.1 5154.7 4505.9 4547.8 4562.7 4579.5 4580.6 6121.2 6136.8 6171.0 6216.0 6250.6 5780.5 5828.9 5834.6 5848.5 5883.9 6559.9 6595.6 6665.9 6694.3 6716.6 4973.0 5016.7 5034.4 5037.9 5055.9 6708.9 6799.3 6884.3 6912.1 6992.8 5066.4 5087.8 5141.7 5149.2 5150.3 5179.2 5204.2 5209.7 5212.2 5224.3 5840.4 5847.7 5857.9 5872.2 5881.9 6613.4 6700.9 6717.2 6717.9 6743.8 1779.6 1783.7 1797.6 1798.4 1802.0 1205.7 1257.8 1269.0 1270.8 1274.3 5793.3 5817.1 5842.0 5843.4 5851.0 6718.4 6811.8 6860.5 6874.2 6888.3 5845.9 5859.8 5862.4 5875.3 5908.6 3486.0 3571.1 3582.3 3588.7 3635.3 6444.5 6502.3 6527.5 6528.4 6536.9 6849.2 6852.7 6906.7 6908.1 6921.8 6561.7 6574.5 6583.3 6626.2 6674.8 6806.5 6855.4 6855.6 6862.7 6910.2 6732.3 6767.5 6814.5 6825.8 6859.0 6540.0 6580.3 6609.5 6656.0 6666.6 5062.3 5092.0 5120.3 5155.9 5158.9 6514.2 6607.3 6743.0 6799.5 6910.8 6383.4 6611.2 6612.4 6670.4 6735.9 6613.7 6648.7 6683.0 6699.4 6703.9 6348.9 6553.4 6576.6 6577.8 6623.3 6605.6 6644.5 6717.8 6735.9 6745.5 6437.8 6445.3 6448.3 6497.7 6506.4 07:31:46 INFO - PID 31463 | 07:31:46 INFO - PID 31463 | [#5] yui.html Cycles:180 Average:24397.91 Median:19615.56 stddev:35127.11 (179.1%) stddev-sans-first:35181.37 07:31:46 INFO - PID 31463 | Values: 907.1 915.3 927.3 940.6 954.4 18481.6 19607.4 19614.8 19616.3 19654.3 18284.8 18565.2 18622.4 19211.3 19384.7 955.4 963.1 967.6 969.3 969.8 960.7 996.7 998.8 999.1 999.2 1039.2 1054.2 1054.3 1054.5 1054.5 1027.7 1032.1 1035.0 1035.4 1036.6 723.3 746.7 746.9 753.0 766.5 20159.7 20372.5 20376.3 20422.7 20455.0 21635.6 21705.5 22824.7 22959.3 22966.5 17343.1 17665.5 17700.7 17840.1 17872.5 3811.3 3836.0 3837.8 3840.1 3840.4 137444.0 139087.0 140533.0 141821.3 143125.3 16965.9 17043.6 17231.4 17340.7 17365.8 31268.8 31612.7 31814.8 31870.0 31890.0 8545.8 8559.1 8568.4 8626.1 8677.2 4092.7 4187.6 4245.0 4253.4 4313.2 5368.8 5466.7 5473.2 5487.8 5494.5 982.4 999.4 1014.1 1014.6 1016.7 680.6 687.1 696.7 712.1 714.1 11277.6 11959.2 12182.5 12696.6 12726.8 628.8 632.9 664.6 670.1 678.8 5697.5 5700.3 5734.7 5757.4 5762.8 115468.4 116524.0 117993.4 121705.4 121850.0 104614.5 105543.0 107430.5 107750.0 108076.0 94372.5 94915.5 97801.5 98436.5 98741.0 10688.9 10775.1 10840.8 10916.5 11153.9 46156.3 46162.8 46394.3 47095.8 47418.3 59587.0 59630.7 59928.4 60567.4 60942.7 15308.2 15636.1 15778.3 15859.8 15868.2 17329.6 17449.6 17554.2 17625.7 17684.2 15503.0 15714.4 15754.9 15887.8 15898.1 14895.3 15026.8 15158.8 15160.8 15197.2 14555.8 14618.9 14664.4 14697.6 14774.0 12015.2 12333.2 12531.8 12542.4 12617.8 11090.5 11135.2 11141.8 11350.9 11627.3 07:31:46 INFO - PID 31463 | -------- Summary: end -------- 07:31:46 INFO - PID 31463 | 07:31:47 INFO - TEST-INFO | 31463: exit 0 07:31:47 INFO - TEST-OK | dromaeo_css | took 1109362ms 07:31:47 INFO - TEST-START | kraken 07:31:47 INFO - Initialising browser for kraken test... 07:31:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59451/getInfo.html -profile /tmp/tmp0Z1P96/profile 07:31:47 INFO - TEST-INFO | started process 31829 (/builds/slave/test/build/application/firefox/firefox http://localhost:59451/getInfo.html) 07:31:52 INFO - TEST-INFO | 31829: exit 0 07:31:53 INFO - Browser initialized. 07:31:53 INFO - Running cycle 1/1 for kraken test... 07:31:53 INFO - Using env: {'DISPLAY': ':0', 07:31:53 INFO - 'HOME': '/home/cltbld', 07:31:53 INFO - 'JSGC_DISABLE_POISONING': '1', 07:31:53 INFO - 'LANG': 'en_US.UTF-8', 07:31:53 INFO - 'LANGUAGE': 'en_US:en', 07:31:53 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:31:53 INFO - 'LOGNAME': 'cltbld', 07:31:53 INFO - 'MAIL': '/var/mail/cltbld', 07:31:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:31:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:31:53 INFO - 'MOZ_CRASHREPORTER': '1', 07:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:53 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:31:53 INFO - 'MOZ_NO_REMOTE': '1', 07:31:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:53 INFO - 'NO_EM_RESTART': '1', 07:31:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:53 INFO - 'PWD': '/builds/slave/test', 07:31:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:31:53 INFO - 'RUST_BACKTRACE': 'full', 07:31:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:31:53 INFO - 'SHELL': '/bin/bash', 07:31:53 INFO - 'SHLVL': '1', 07:31:53 INFO - 'STYLO_FORCE_DISABLED': '1', 07:31:53 INFO - 'TERM': 'linux', 07:31:53 INFO - 'TMOUT': '86400', 07:31:53 INFO - 'USER': 'cltbld', 07:31:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628', 07:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:53 INFO - '_': '/tools/buildbot/bin/python'} 07:31:53 INFO - TEST-INFO | started process 32068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Z1P96/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:53 INFO - PID 32068 | 07:31:53 INFO - PID 32068 | (/builds/slave/test/build/application/firefox/firefox:32116): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:31:53 INFO - PID 32068 | 07:32:04 INFO - PID 32068 | RSS: Main: 151711744 07:32:04 INFO - PID 32068 | 07:32:06 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59451/tests/kraken/driver.html?testName=audio-beat-detection) 07:32:07 INFO - PID 32068 | RSS: Main: 157368320 07:32:07 INFO - PID 32068 | 07:32:10 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59451/tests/kraken/driver.html?testName=audio-dft) 07:32:11 INFO - PID 32068 | RSS: Main: 157810688 07:32:11 INFO - PID 32068 | 07:32:14 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59451/tests/kraken/driver.html?testName=audio-fft) 07:32:14 INFO - PID 32068 | RSS: Main: 154673152 07:32:14 INFO - PID 32068 | 07:32:16 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59451/tests/kraken/driver.html?testName=audio-oscillator) 07:32:17 INFO - PID 32068 | RSS: Main: 155254784 07:32:17 INFO - PID 32068 | 07:32:19 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59451/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:32:20 INFO - PID 32068 | RSS: Main: 155312128 07:32:20 INFO - PID 32068 | 07:32:23 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59451/tests/kraken/driver.html?testName=imaging-darkroom) 07:32:23 INFO - PID 32068 | RSS: Main: 156856320 07:32:23 INFO - PID 32068 | 07:32:27 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59451/tests/kraken/driver.html?testName=imaging-desaturate) 07:32:28 INFO - PID 32068 | RSS: Main: 157827072 07:32:28 INFO - PID 32068 | 07:32:31 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59451/tests/kraken/driver.html?testName=json-parse-financial) 07:32:31 INFO - PID 32068 | RSS: Main: 158318592 07:32:31 INFO - PID 32068 | 07:32:33 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59451/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:32:34 INFO - PID 32068 | RSS: Main: 158117888 07:32:34 INFO - PID 32068 | 07:32:35 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59451/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:32:36 INFO - PID 32068 | RSS: Main: 157945856 07:32:36 INFO - PID 32068 | 07:32:38 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59451/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:32:39 INFO - PID 32068 | RSS: Main: 154374144 07:32:39 INFO - PID 32068 | 07:32:41 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:32:42 INFO - PID 32068 | RSS: Main: 155037696 07:32:42 INFO - PID 32068 | 07:32:45 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:32:45 INFO - PID 32068 | RSS: Main: 155168768 07:32:45 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | Cycle 1(1): loaded http://localhost:59451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59451/tests/kraken/driver.html?testName=ai-astar) 07:32:47 INFO - PID 32068 | RSS: Main: 156479488 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | __start_tp_report 07:32:47 INFO - PID 32068 | _x_x_mozilla_page_load 07:32:47 INFO - PID 32068 | _x_x_mozilla_page_load_details 07:32:47 INFO - PID 32068 | |i|pagename|runs| 07:32:47 INFO - PID 32068 | |0;ai-astar;108;108;106;107;108;107;108;106;107;107 07:32:47 INFO - PID 32068 | |1;audio-beat-detection;116;116;116;114;148;117;120;116;117;139 07:32:47 INFO - PID 32068 | |2;audio-dft;164;162;162;164;162;163;163;164;169;167 07:32:47 INFO - PID 32068 | |3;audio-fft;74;74;77;77;75;77;75;75;77;77 07:32:47 INFO - PID 32068 | |4;audio-oscillator;81;78;80;78;80;79;80;81;80;78 07:32:47 INFO - PID 32068 | |5;imaging-gaussian-blur;116;114;113;114;114;114;113;113;114;113 07:32:47 INFO - PID 32068 | |6;imaging-darkroom;149;148;148;147;148;148;148;149;149;149 07:32:47 INFO - PID 32068 | |7;imaging-desaturate;94;94;94;94;94;95;95;94;94;94 07:32:47 INFO - PID 32068 | |8;json-parse-financial;53;59;50;55;54;55;55;55;54;56 07:32:47 INFO - PID 32068 | |9;json-stringify-tinderbox;38;38;38;39;39;39;39;39;38;39 07:32:47 INFO - PID 32068 | |10;stanford-crypto-aes;73;77;74;77;79;73;76;84;74;78 07:32:47 INFO - PID 32068 | |11;stanford-crypto-ccm;113;115;111;119;121;125;110;116;112;113 07:32:47 INFO - PID 32068 | |12;stanford-crypto-pbkdf2;169;175;169;171;166;175;171;170;171;170 07:32:47 INFO - PID 32068 | |13;stanford-crypto-sha256-iterative;72;68;66;66;65;63;63;67;68;71 07:32:47 INFO - PID 32068 | __end_tp_report 07:32:47 INFO - PID 32068 | __start_cc_report 07:32:47 INFO - PID 32068 | _x_x_mozilla_cycle_collect,732 07:32:47 INFO - PID 32068 | __end_cc_report 07:32:47 INFO - PID 32068 | __startTimestamp1506177167804__endTimestamp 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | ------- Summary: start ------- 07:32:47 INFO - PID 32068 | Number of tests: 14 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#0] ai-astar Cycles:10 Average:107.20 Median:107.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 07:32:47 INFO - PID 32068 | Values: 108.0 108.0 106.0 107.0 108.0 107.0 108.0 106.0 107.0 107.0 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#1] audio-beat-detection Cycles:10 Average:121.90 Median:117.00 stddev:11.68 (10.0%) stddev-sans-first:12.19 07:32:47 INFO - PID 32068 | Values: 116.0 116.0 116.0 114.0 148.0 117.0 120.0 116.0 117.0 139.0 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.31 (1.4%) stddev-sans-first:2.45 07:32:47 INFO - PID 32068 | Values: 164.0 162.0 162.0 164.0 162.0 163.0 163.0 164.0 169.0 167.0 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#3] audio-fft Cycles:10 Average:75.80 Median:77.00 stddev:1.32 (1.7%) stddev-sans-first:1.22 07:32:47 INFO - PID 32068 | Values: 74.0 74.0 77.0 77.0 75.0 77.0 75.0 75.0 77.0 77.0 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:80.00 stddev:1.18 (1.5%) stddev-sans-first:1.12 07:32:47 INFO - PID 32068 | Values: 81.0 78.0 80.0 78.0 80.0 79.0 80.0 81.0 80.0 78.0 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.53 07:32:47 INFO - PID 32068 | Values: 116.0 114.0 113.0 114.0 114.0 114.0 113.0 113.0 114.0 113.0 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 07:32:47 INFO - PID 32068 | Values: 149.0 148.0 148.0 147.0 148.0 148.0 148.0 149.0 149.0 149.0 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:32:47 INFO - PID 32068 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:2.27 (4.1%) stddev-sans-first:2.33 07:32:47 INFO - PID 32068 | Values: 53.0 59.0 50.0 55.0 54.0 55.0 55.0 55.0 54.0 56.0 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#9] json-stringify-tinderbox Cycles:10 Average:38.60 Median:39.00 stddev:0.52 (1.3%) stddev-sans-first:0.50 07:32:47 INFO - PID 32068 | Values: 38.0 38.0 38.0 39.0 39.0 39.0 39.0 39.0 38.0 39.0 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:77.00 stddev:3.37 (4.4%) stddev-sans-first:3.33 07:32:47 INFO - PID 32068 | Values: 73.0 77.0 74.0 77.0 79.0 73.0 76.0 84.0 74.0 78.0 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:115.50 stddev:4.81 (4.2%) stddev-sans-first:5.02 07:32:47 INFO - PID 32068 | Values: 113.0 115.0 111.0 119.0 121.0 125.0 110.0 116.0 112.0 113.0 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:171.00 stddev:2.71 (1.6%) stddev-sans-first:2.80 07:32:47 INFO - PID 32068 | Values: 169.0 175.0 169.0 171.0 166.0 175.0 171.0 170.0 171.0 170.0 07:32:47 INFO - PID 32068 | 07:32:47 INFO - PID 32068 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:3.00 (4.4%) stddev-sans-first:2.55 07:32:47 INFO - PID 32068 | Values: 72.0 68.0 66.0 66.0 65.0 63.0 63.0 67.0 68.0 71.0 07:32:47 INFO - PID 32068 | -------- Summary: end -------- 07:32:47 INFO - PID 32068 | 07:32:48 INFO - PID 32068 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:32:48 INFO - TEST-INFO | 32068: exit 0 07:32:48 INFO - TEST-OK | kraken | took 61333ms 07:32:48 INFO - SUITE-END | took 1170s 07:32:48 INFO - Completed test suite (00:19:31) 07:32:48 INFO - javascript benchmark 07:32:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8522.282716205944, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.206897241203, 3120.781545291829, 3126.499760038393, 3129.9843500782495, 3159.605049368829, 6175.814725558241, 6310.179676642036, 6331.335209802974, 6404.071409645599, 6430.7106180221945, 6281.466075383598, 6308.747650093991, 6334.651594162331, 6362.14111095002, 6387.329330420309, 5877.911831322513, 5908.881822363561, 5934.64392136471, 5940.792072277472, 5957.970210148943, 1319.2964355691915, 5751.367349591542, 5879.0, 5894.970525147368, 5907.291125064999, 5348.491893270133, 5716.942830571683, 5780.71096445176, 5819.272590926134, 5883.676397798119, 5821.301443826768, 5851.94664960307, 5876.265466816648, 5906.055031195031, 5921.0, 5800.680962547058, 5811.186433899257, 5843.065109582446, 5888.676122813244, 5913.201717768132, 6216.129741836146, 6318.304986451487, 6395.232572091332, 6443.83890402739, 6475.384838440341, 6626.370494802986, 6699.363560461748, 6782.966085169592, 6855.4172895303955, 6865.107536020335, 6776.15298087739, 6886.414654754352, 6905.102336696197, 6905.343992320722, 6912.723491060352, 6312.305646378894, 6425.58233714807, 6433.871322573569, 6469.644169570672, 6473.643949582818, 7052.0, 7062.540934839219, 7132.215456299803, 7138.750143745048, 7152.284771522806, 6720.831979200461, 6734.3602357775935, 6801.081853949752, 6808.965955170292, 6845.452363810883, 6627.834304142339, 6717.093192419059, 6721.0, 6723.731050757915, 6736.966315168491, 6622.437092847162, 6697.6986035628515, 6710.731570737116, 6717.227518835299, 6727.831804204934, 6852.486063545254, 6877.552959057645, 6879.346462086094, 6909.965450172717, 6921.169459664772, 5354.518093371616, 5419.295491586068, 5421.566274698014, 5423.511883930465, 5429.728513574384, 4630.398048253705, 4633.096546173464, 4670.509596492319, 4703.0, 4708.976455117702, 5669.121286200645, 5824.88350232993, 5826.271716035496, 5915.053591425351, 5921.970390148022, 6931.202911665223, 6971.372576468142, 6985.022096906438, 6985.266547012592, 6985.790426287118, 5838.766449341979, 5854.882902341929, 5867.266591676041, 5918.911216331759, 5936.7922122725495, 5708.971455142698, 5805.883882322414, 5880.26496687914, 5945.910811337833, 5955.076963070731, 6547.148870646881, 6613.074169616258, 6619.669016549154, 6632.502562307846, 6654.567453115532, 6877.140357455318, 6940.687669054904, 6965.825854353681, 6968.547044442298, 6969.16370035599, 6589.374009469093, 6599.241087274832, 6603.042558828847, 6691.230508491586, 6703.0, 6520.576162549609, 6659.467242620675, 6662.100616416916, 6673.432758215606, 6713.63075030878, 6769.3907548320885, 6815.659217039228, 6816.113905192294, 6930.792076237721, 6935.653217339213, 6552.312007239171, 6670.599764014175, 6715.3620406061345, 6715.395614394728, 6721.495887808532, 6641.236257830218, 6641.634710090992, 6644.069830223869, 6725.932740672531, 6729.360710732472, 6392.93607063942, 6516.57642253252, 6567.540272180901, 6646.169228846395, 6655.866882662222, 6638.435732962752, 6666.133402657623, 6678.065070889982, 6709.664516774239, 6716.932830671826, 6394.296627371078, 6521.836954075996, 6528.37980391862, 6530.934690653033, 6538.934610653832], "value": 6181.8543312973925, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [866.3199388480044, 897.6319708919342, 902.7201567514071, 904.9366544341894, 905.2305540290749, 37079.629203707955, 40780.38829417557, 40819.59180408195, 40844.99999999996, 41015.58984410155, 38229.42655860164, 38652.0, 38681.80659096708, 38728.22543549127, 38943.221135577274, 7229.096362954644, 7348.559086454829, 7369.078865141857, 7787.454878158503, 7961.0, 7810.648520816577, 7913.920860791405, 7931.246531579491, 7932.286094251516, 7934.761957141266, 7831.765047048598, 7842.490238134532, 7938.0, 7956.085050219241, 7957.761267161965, 7871.134175240719, 7907.96046019772, 7932.682692692343, 7952.721654742085, 7957.562334071624, 7796.064472263308, 7890.763277101696, 7928.405369597303, 7957.084935232465, 7963.6018199090395, 36608.0, 36903.63096369029, 36915.81542092272, 36944.26111477782, 37031.4445283321, 3487.442009278503, 3519.278547897675, 3521.2781379817075, 3521.3133438979407, 3522.5420695309704, 31469.527957080663, 31577.368452630817, 31611.20971975696, 31637.52543711823, 31652.525212121607, 5087.796488140507, 5105.948940510584, 5132.435432102466, 5146.7683954221775, 5152.201408781645, 185114.0, 185947.0, 187418.0, 187914.0, 188305.0, 41282.1743565127, 41873.79063104665, 47578.5242147581, 47852.0, 48062.279065814044, 43095.0, 50079.74960125176, 50739.74630126826, 51024.0, 51114.488855110976, 16225.837741622432, 16368.099754513378, 16372.672546549002, 16376.099314537576, 16382.426615068654, 13476.056676032584, 13519.188848669111, 13520.526781562598, 13524.661883452796, 13540.119892206974, 14299.07056041354, 14301.28493575338, 14368.425262989573, 14399.496017639332, 14565.854341456661, 5832.766689332464, 5855.560832937462, 5944.881102377928, 6027.427394397525, 6035.66803825785, 995.6465454763454, 1015.3755440404099, 1016.7763092119721, 1024.4212020208558, 1034.9586016559404, 22604.434889127904, 22825.0, 22926.082956681545, 23054.96252668634, 23443.296701098996, 1101.9393933333743, 1119.2333251722596, 1121.556984990924, 1126.0597401170114, 1131.5813149134708, 12135.575254866037, 12201.572944946884, 12217.511299548096, 12239.143259971894, 12259.080568957364, 211218.0, 213371.0, 213537.0, 213737.0, 214004.0, 51543.74228128835, 51701.2244816328, 51922.48077519252, 51958.480415195365, 51959.48040519622, 1432.58455048037, 1465.9924422146494, 1470.4485817818318, 1485.1979930837442, 1488.278185080257, 21738.782612173676, 21897.890510547346, 22061.11755529761, 22160.667589985842, 22423.32730018102, 35783.28433431369, 35792.28415431625, 35896.102597435274, 35915.1021224461, 35934.281314373045, 188093.0, 188828.0, 189626.0, 189813.0, 190004.0, 30467.695323047374, 31683.683163168072, 31706.524402133524, 31966.52050219202, 31993.200169995936, 39431.0, 40895.591044089175, 40926.795366022976, 41109.58890411058, 41574.79212604039, 30040.3991920156, 30290.545641815832, 30300.24249393783, 30482.237944051576, 30643.080707578807, 30425.0, 30874.845625771726, 30967.845160774054, 31007.0, 31592.526112108797, 34053.65946340505, 34229.0, 34254.48618270778, 34514.654853451146, 34647.82676086603, 29829.701702982693, 30068.69931300659, 30126.397472049997, 30204.395912082076, 30459.39081218319, 22376.216832410788, 22631.88684056569, 22684.319470415914, 22836.31491055271, 23042.423939401648], "value": 16869.962225538853, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.1861675038197, 584.2521572387341, 597.417517920028, 599.3886236039237, 612.9080637904315, 22276.220332288354, 23007.769922300773, 23022.769772302272, 23032.76967230327, 23045.654315185286, 24046.158384456503, 24778.0, 24928.501429971435, 25304.367390815238, 25309.2407227783, 6550.737970481175, 6783.3216678332265, 6784.2876497967745, 6802.931970680304, 6805.183377994623, 6352.936470635281, 6685.398314151726, 6773.627450490221, 6791.932080679204, 6806.761763338284, 6701.128853249095, 6701.564398314094, 6718.160229971254, 6723.29405412432, 6726.159230096238, 6614.404703576653, 6649.93350066498, 6658.234303055138, 6658.667066646648, 6673.733050677967, 5969.0, 6188.81433556994, 6206.193194884681, 6206.410391012847, 6224.782132625336, 27998.720012799815, 28498.430031399257, 28512.0, 28550.143495694956, 28553.14340569786, 2053.9589208215752, 2077.2833372486466, 2077.5637116205617, 2078.6985887046294, 2080.583883223361, 18792.436226913214, 19193.61612767751, 19457.51356216092, 19500.31748888782, 19522.902385488123, 2471.8269721119527, 2483.75162483752, 2533.8606376649277, 2540.898364065435, 2541.7458254174435, 123971.0, 129535.0, 134797.0, 140998.2950085243, 142007.0, 14595.0, 14686.153569322098, 15100.54698359051, 15174.344489714256, 15670.216489175496, 23746.7625323748, 23852.64221036686, 23860.64209036866, 23916.52166956686, 23916.760832391803, 10095.444750538643, 10125.898741012496, 10164.593416263267, 10267.691969240936, 10381.896181038093, 9219.078092190728, 9321.347505674674, 9340.532973351304, 9347.953260233791, 9411.43531388119, 9238.95380523093, 9339.299552533586, 9458.621655133718, 9462.195713364441, 9481.952590237004, 2781.425867759959, 2786.3591373984095, 2787.665480142396, 2808.873600687974, 2883.5530492773655, 942.9245660347156, 961.3751061809879, 966.7438128895848, 983.409954027592, 991.4992928571025, 18898.976163813724, 19089.0, 19152.904235478734, 19283.22867085301, 19666.115024823917, 1028.7993841200894, 1039.6257347354947, 1040.547361897577, 1046.984295235572, 1048.821700310949, 10509.684709458728, 10653.627123050655, 10687.091597214168, 10701.946490267655, 10743.83884241737, 459129.0, 463678.0, 476977.0, 478070.0, 480534.3893122118, 114384.0, 115178.4241078806, 116160.0, 117740.0, 118172.40913795376, 1126.819708846597, 1128.8476055732372, 1151.1308961733837, 1157.6469176900957, 1158.8956993870424, 16670.833291666928, 16809.41167059147, 16832.57918552046, 16879.240434180247, 16921.492355229362, 58072.709636451546, 58175.12737308859, 58366.7081664589, 59333.70333148307, 60572.091418629636, 72321.6383918077, 72358.0, 72395.63802180956, 72418.63790681012, 72637.27362726306, 14137.222452765196, 14474.348654310792, 14609.342579583732, 14609.342579584158, 14625.561233163022, 21448.678269826276, 21651.566968660853, 21907.452313692283, 21967.450813729785, 21996.120155193614, 15386.307616157075, 15639.530814075595, 15657.21713914277, 15694.529164125095, 16055.518334449986, 15753.763693544377, 16042.35830566811, 16060.919695401448, 16234.67530649404, 16621.41825036118, 16355.754663679816, 17427.651446970736, 17503.82496175022, 17751.822481775016, 17788.733169002735, 13928.164310141425, 13983.091099078527, 14031.228282444563, 14087.718245635235, 14116.647083822987, 16682.332706692083, 16776.58058548546, 16804.663906722042, 17621.0, 17642.0], "value": 11851.628982932078, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.677277453411, 1385.258886495725, 1402.7545179593576, 1418.2625034981813, 1421.9289035548213, 14947.626309342271, 15646.84353156468, 15646.84353156468, 15654.0, 15673.764893526606, 14971.850281497182, 15291.617709557268, 15318.0809151451, 15366.769498457532, 15405.92297038516, 2732.8087033907636, 2829.618001569793, 2830.066078194191, 2840.9289767755868, 2842.8294302341824, 2698.3254186453387, 2734.917952461419, 2792.706765789593, 2799.860006999652, 2802.7897907657007, 2754.077384076337, 2769.1830909881633, 2773.209635253953, 2782.373965857686, 2783.7633801126926, 2636.064197209982, 2684.127658510982, 2686.3149896776395, 2688.0323083689955, 2704.567269236932, 2576.755208255213, 2701.554243549812, 2748.3816141368234, 2754.3664957059787, 2762.986185069082, 15338.693226135527, 15379.538613841603, 15397.692046159125, 15446.382144714311, 15579.688406231926, 8012.679492820338, 8368.037675667316, 8371.706990255312, 8391.580420978988, 8393.202645748644, 5310.522053015208, 5428.75570599324, 5577.581681373913, 5600.439956004408, 5619.381867994517, 1972.4279958811928, 1974.5614166504356, 1985.4440756588178, 1988.2842176816334, 2033.5932813437223, 27088.45823083547, 27089.1873243803, 27203.183904482896, 27222.591661125098, 27449.725502745117, 6873.175218973655, 6959.19969203548, 6976.755813546603, 6999.160100787836, 7028.297170282931, 16787.160641968097, 17424.825751742574, 17499.737503937453, 17513.7372939406, 17531.386401475887, 8130.02439707239, 8280.668773249003, 8293.668253269801, 8302.6678932842, 8303.169683031769, 7365.631718414058, 7369.8894516582295, 7543.660535275926, 7566.0, 7591.810204744926, 5293.232481290192, 5392.865178370572, 5442.292501974718, 5444.891102177934, 5455.8363249102595, 1579.2577488580348, 1591.0930769461295, 1591.9840801591836, 1597.209381356236, 1615.3619320368389, 862.7498025572639, 872.1365847810622, 894.4096896048577, 895.7536677413633, 898.0390981649572, 7277.053982982178, 7380.225076367012, 7383.8154046149275, 7422.814429639194, 7477.626118694044, 696.6531867913742, 715.2882881532908, 725.7822653204017, 738.8706976279129, 747.1892996099184, 4809.663323567387, 5061.089003979319, 5266.34170728659, 5288.0745869472685, 5288.153895376721, 21406.0, 21407.250746223806, 21785.891070544545, 22381.216657416913, 22535.661965070536, 21694.240701575683, 21896.0, 22091.889540552515, 22100.557988840133, 22123.778762212172, 10817.945910270399, 11411.144164187719, 11455.0, 11518.136139789549, 11539.249948753304, 8084.797880053045, 8139.186081391814, 8177.0, 8254.174582541698, 8268.503889766393, 18277.817221828143, 19272.22911083541, 19365.8063419364, 19376.903115484332, 19410.4176874694, 19622.215111395384, 19857.304994325128, 19955.501112472306, 20337.389878303675, 20502.487437814176, 10950.780984380108, 10971.725706857393, 11081.5567377304, 11085.612003579836, 11088.833667494833, 13776.173429594257, 13964.441422342992, 14075.577732668036, 14174.362153702901, 14194.290285485891, 11332.660020199408, 11774.470148843495, 11824.290542567473, 11832.881671183179, 11950.940245298718, 10950.671479855617, 10991.0, 11234.0, 11287.43562821872, 11298.830517542408, 9388.061193880558, 9404.482753448627, 9512.191463725661, 9605.279604029585, 9605.37565058269, 7091.503594748318, 7180.783312770632, 7206.7117315306805, 7231.674574644048, 7361.190269070291, 6940.236573976959, 7022.473314501331, 7087.3267039631155, 7216.097987751531, 7286.417086633162], "value": 6693.741421941832, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.5198448507088, 539.3366159623661, 539.6465315218531, 545.3210752612999, 546.0907588864541, 6431.839204019901, 6440.903386449207, 6479.060536222257, 6504.83737906552, 6521.608703477795, 6288.559800813945, 6297.401746834055, 6315.179026726519, 6316.652584107872, 6382.361763823616, 5289.68261904285, 5319.7340132993295, 5336.519713225809, 5343.145096784515, 5347.839564813062, 4951.504849515038, 5281.70950597717, 5291.100512912795, 5312.521873031426, 5314.3091398118195, 5072.51811077947, 5078.5937125029905, 5108.438071812097, 5114.718690472023, 5137.713717395742, 5055.898882022376, 5060.51925067118, 5093.617978651598, 5095.108356037678, 5154.716490593035, 4505.887352816206, 4547.79534920926, 4562.726236425825, 4579.473360563545, 4580.580020193717, 6121.204243448323, 6136.815895523141, 6171.0, 6216.0, 6250.562460627758, 5780.50865676418, 5828.883422331572, 5834.5624078194305, 5848.502877255439, 5883.941160588382, 6559.93440065598, 6595.571287866273, 6665.93334066658, 6694.263631000586, 6716.563423377514, 4972.977292934126, 5016.724080175589, 5034.395872495287, 5037.949620503821, 5055.949440505585, 6708.94742891983, 6799.252082270996, 6884.277150899134, 6912.135983002125, 6992.825179370557, 5066.392032955995, 5087.847364579068, 5141.717205553656, 5149.150390185652, 5150.253213284052, 5179.22311653255, 5204.245384419238, 5209.6874187548865, 5212.218167274863, 5224.302101816925, 5840.364697884599, 5847.736851841677, 5857.941420585739, 5872.17789509469, 5881.911771323434, 6613.371729685672, 6700.865982680319, 6717.227518835299, 6717.932820671731, 6743.763968261087, 1779.6084861330487, 1783.7056885613729, 1797.6494583556344, 1798.397536825152, 1801.9549511262323, 1205.7009105755678, 1257.7736007518552, 1269.0, 1270.7966725323904, 1274.2991354754847, 5793.333766616809, 5817.069268916953, 5842.0, 5843.415658434123, 5850.970745146332, 6718.395344418928, 6811.795646130624, 6860.485463590251, 6874.181585550001, 6888.345607167311, 5845.912311315334, 5859.824205273849, 5862.355140934494, 5875.294964604275, 5908.632079714607, 3486.0, 3571.1250743567994, 3582.3193593217206, 3588.748787584844, 3635.2911182319194, 6444.548881578338, 6502.284748677642, 6527.5430719849155, 6528.37980391862, 6536.934630653727, 6849.212340580797, 6852.657367131723, 6906.689198986058, 6908.095252370773, 6921.757738479129, 6561.703403808724, 6574.539782215199, 6583.308752581006, 6626.171728533934, 6674.763954075439, 6806.489513286622, 6855.383015528626, 6855.628874225075, 6862.691178896862, 6910.239873613999, 6732.259451460238, 6767.458603311625, 6814.454843612598, 6825.761098361533, 6858.987492316851, 6540.0, 6580.276169621242, 6609.537332386687, 6655.966720166562, 6666.600003999775, 5062.265971434195, 5092.0, 5120.308758317579, 5155.896882062263, 5158.8968220636125, 6514.185726784152, 6607.3062328456745, 6742.966285168739, 6799.524033317818, 6910.792676219721, 6383.425491705769, 6611.239707433514, 6612.404883560503, 6670.39966403026, 6735.898961515483, 6613.677264547014, 6648.7340506379205, 6682.966585167043, 6699.430548403246, 6703.927371620517, 6348.904766428415, 6553.4101930826455, 6576.605403675795, 6577.835554111186, 6623.271440141677, 6605.649423966603, 6644.534882558174, 6717.798466046026, 6735.898961515679, 6745.494087943326, 6437.774677886251, 6445.25879523842, 6448.291202831159, 6497.693318871921, 6506.4469520091325], "value": 5162.268169044698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [907.0566610724838, 915.3272344826553, 927.2720914082447, 940.6331530703027, 954.3891909178125, 18481.63036739266, 19607.411777646692, 19614.803851961475, 19616.313429029986, 19654.312099076535, 18284.817151828476, 18565.164567594456, 18622.441326760185, 19211.32760353388, 19384.709229361535, 955.4219697083252, 963.0850691842743, 967.6468089147446, 969.2633598465146, 969.8448248280276, 960.6973803251988, 996.7109538233904, 998.8202123617746, 999.0708640963937, 999.1956475037592, 1039.1530902314628, 1054.2146101154613, 1054.2725519391595, 1054.4833031814394, 1054.488573042074, 1027.748201690583, 1032.1226957086417, 1034.9793004139913, 1035.3529044347283, 1036.6475398364555, 723.2767232767233, 746.7237122264743, 746.8543633991374, 752.9887051694229, 766.5477368352699, 20159.697604535944, 20372.490687732778, 20376.28682996088, 20422.69365959497, 20455.0, 21635.567288654296, 21705.457363566038, 22824.657630135396, 22959.311220663407, 22966.54066918669, 17343.13284335778, 17665.470035898943, 17700.734488982675, 17840.107994600217, 17872.463826085237, 3811.3330167220624, 3835.9808200959096, 3837.827297771607, 3840.0975770693863, 3840.443135745329, 137444.0, 139087.0, 140533.0, 141821.29089354488, 143125.2843735785, 16965.91517042407, 17043.573910652332, 17231.3969011084, 17340.739888901677, 17365.82634173642, 31268.84365578203, 31612.683873161433, 31814.840925795223, 31870.0, 31890.0, 8545.786355341166, 8559.101294364127, 8568.443051201652, 8626.051134375213, 8677.219050285505, 4092.7339722917914, 4187.623113919701, 4245.0448649053715, 4253.404523366731, 4313.180495705806, 5368.812091576776, 5466.671999680032, 5473.17902314648, 5487.835364939058, 5494.5054945055135, 982.4350998176077, 999.4003597841237, 1014.0569270578433, 1014.6448742939912, 1016.6695823857128, 680.550836447942, 687.1445050911548, 696.7178292791427, 712.1205311440367, 714.0538786108324, 11277.605283815192, 11959.222650527689, 12182.512699491921, 12696.555620553236, 12726.80909786354, 628.827072555051, 632.914556534871, 664.5945972956492, 670.1054092786185, 678.7658257901016, 5697.544196464273, 5700.258966334433, 5734.655920644691, 5757.366689664133, 5762.827115186551, 115468.42265788617, 116524.0, 117993.410032951, 121705.39147304384, 121850.0, 104614.47692761487, 105543.0, 107430.46284768682, 107750.0, 108076.0, 94372.52813735888, 94915.52542237383, 97801.51099244459, 98436.50781746046, 98740.99999999856, 10688.893111069101, 10775.137988960707, 10840.837387439036, 10916.50875710579, 11153.888461115284, 46156.307655384524, 46162.769186153855, 46394.30408543807, 47095.764521177174, 47418.288725668455, 59587.0, 59630.70184649049, 59928.400715992284, 60567.39432605617, 60942.69528652506, 15308.158051307286, 15636.140012299433, 15778.289976950835, 15859.762103568224, 15868.206589670239, 17329.56676083108, 17449.56376090608, 17554.21006054705, 17625.73561396606, 17684.204210810803, 15503.0, 15714.371425142866, 15754.921225394259, 15887.761683574525, 15898.125603091941, 14895.255237237878, 15026.849731502545, 15158.848411515744, 15160.772588410962, 15197.164155971528, 14555.781663274847, 14618.926905365404, 14664.413423462942, 14697.632559185678, 14774.039687420283, 12015.158938874194, 12333.198342107735, 12531.812022819482, 12542.372881356077, 12617.81073283883, 11090.500927458123, 11135.164862635496, 11141.777164456827, 11350.886491134983, 11627.302361858316], "value": 8969.968214422786, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 106.0, 107.0, 108.0, 107.0, 108.0, 106.0, 107.0, 107.0], "value": 107.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 114.0, 148.0, 117.0, 120.0, 116.0, 117.0, 139.0], "value": 121.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 164.0, 162.0, 163.0, 163.0, 164.0, 169.0, 167.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 77.0, 75.0, 77.0, 75.0, 75.0, 77.0, 77.0], "value": 75.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 80.0, 78.0, 80.0, 79.0, 80.0, 81.0, 80.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0, 149.0, 149.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 59.0, 50.0, 55.0, 54.0, 55.0, 55.0, 55.0, 54.0, 56.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 39.0, 39.0, 39.0, 39.0, 39.0, 38.0, 39.0], "value": 38.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 74.0, 77.0, 79.0, 73.0, 76.0, 84.0, 74.0, 78.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 111.0, 119.0, 121.0, 125.0, 110.0, 116.0, 112.0, 113.0], "value": 115.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 175.0, 169.0, 171.0, 166.0, 175.0, 171.0, 170.0, 171.0, 170.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 66.0, 66.0, 65.0, 63.0, 63.0, 67.0, 68.0, 71.0], "value": 66.9, "unit": "score"}]}]} 07:32:49 INFO - Return code: 0 07:32:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:32:49 INFO - # TBPL SUCCESS # 07:32:49 INFO - Running post-action listener: _package_coverage_data 07:32:49 INFO - Running post-action listener: _resource_record_post_action 07:32:49 INFO - [mozharness: 2017-09-23 14:32:49.103875Z] Finished run-tests step (success) 07:32:49 INFO - Running post-run listener: _resource_record_post_run 07:32:49 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 345501696; Read time: 12; Write time: 406612 07:32:49 INFO - TinderboxPrint: CPU usage
13.1% 07:32:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:32:49 INFO - TinderboxPrint: I/O write bytes / time
345,501,696 / 406,612 07:32:49 INFO - TinderboxPrint: CPU idle
8,233.7 (86.8%) 07:32:49 INFO - TinderboxPrint: CPU user
1,194.4 (12.6%) 07:32:49 INFO - TinderboxPrint: Swap in / out
0 / 0 07:32:49 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10567680; Read time: 0; Write time: 720 07:32:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:32:49 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 334524416; Read time: 0; Write time: 405836 07:32:49 INFO - Running post-run listener: _upload_blobber_files 07:32:49 INFO - Blob upload gear active. 07:32:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:32:49 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 07:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:32:50 INFO - (blobuploader) - INFO - Open directory for files ... 07:32:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 07:32:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 07:32:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:51 INFO - (blobuploader) - INFO - Done attempting. 07:32:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 07:32:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 07:32:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:52 INFO - (blobuploader) - INFO - Done attempting. 07:32:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:32:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:32:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:59 INFO - (blobuploader) - INFO - Done attempting. 07:32:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:32:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:33:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:00 INFO - (blobuploader) - INFO - Done attempting. 07:33:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:33:00 INFO - Return code: 0 07:33:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:33:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:33:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4d9a8a019cfd6fd0ba27b9de51c7f100a52632d1d06f0d5fe1746269fc859d0f5729bd0e8f75da627299a7a213a9c433a2076a90f7c77a71c768d1549dcf467", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2115eb58efb74fc05773ce6465db7c9cb9a8216c01e202cfaf2e37dabb85124fcadabfca1a9fc59c8ee8d728daa0667bf2de637b6ae848cfdda0238ebada885f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43add00110872fe29cbf9bc1262dbb5359cfb1d06a8cd06ad9d0b23914c5747e1b618202202d9d30aafd72d733654ca355d2981dc1fedde56f1511e3c3332745", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0c13022b52a25ad743cc49eba4cd1457de073b5a21171bbb707068e6a31e67ddb466cd0fc1663781ac63fb0d051c8fb146e9363da8173b7cc65147f1c2b7778"} 07:33:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:33:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:33:00 INFO - Contents: 07:33:00 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4d9a8a019cfd6fd0ba27b9de51c7f100a52632d1d06f0d5fe1746269fc859d0f5729bd0e8f75da627299a7a213a9c433a2076a90f7c77a71c768d1549dcf467", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2115eb58efb74fc05773ce6465db7c9cb9a8216c01e202cfaf2e37dabb85124fcadabfca1a9fc59c8ee8d728daa0667bf2de637b6ae848cfdda0238ebada885f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43add00110872fe29cbf9bc1262dbb5359cfb1d06a8cd06ad9d0b23914c5747e1b618202202d9d30aafd72d733654ca355d2981dc1fedde56f1511e3c3332745", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0c13022b52a25ad743cc49eba4cd1457de073b5a21171bbb707068e6a31e67ddb466cd0fc1663781ac63fb0d051c8fb146e9363da8173b7cc65147f1c2b7778"} 07:33:00 INFO - Running post-run listener: copy_logs_to_upload_dir 07:33:00 INFO - Copying logs to upload dir... 07:33:00 INFO - mkdir: /builds/slave/test/build/upload/logs 07:33:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.681402 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-23 07:33:00.172042) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 07:33:00.176387) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4d9a8a019cfd6fd0ba27b9de51c7f100a52632d1d06f0d5fe1746269fc859d0f5729bd0e8f75da627299a7a213a9c433a2076a90f7c77a71c768d1549dcf467", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2115eb58efb74fc05773ce6465db7c9cb9a8216c01e202cfaf2e37dabb85124fcadabfca1a9fc59c8ee8d728daa0667bf2de637b6ae848cfdda0238ebada885f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43add00110872fe29cbf9bc1262dbb5359cfb1d06a8cd06ad9d0b23914c5747e1b618202202d9d30aafd72d733654ca355d2981dc1fedde56f1511e3c3332745", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0c13022b52a25ad743cc49eba4cd1457de073b5a21171bbb707068e6a31e67ddb466cd0fc1663781ac63fb0d051c8fb146e9363da8173b7cc65147f1c2b7778"} build_url:https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/RZ7fYPz7S4aFd-96ndeTBg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4d9a8a019cfd6fd0ba27b9de51c7f100a52632d1d06f0d5fe1746269fc859d0f5729bd0e8f75da627299a7a213a9c433a2076a90f7c77a71c768d1549dcf467", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2115eb58efb74fc05773ce6465db7c9cb9a8216c01e202cfaf2e37dabb85124fcadabfca1a9fc59c8ee8d728daa0667bf2de637b6ae848cfdda0238ebada885f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43add00110872fe29cbf9bc1262dbb5359cfb1d06a8cd06ad9d0b23914c5747e1b618202202d9d30aafd72d733654ca355d2981dc1fedde56f1511e3c3332745", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0c13022b52a25ad743cc49eba4cd1457de073b5a21171bbb707068e6a31e67ddb466cd0fc1663781ac63fb0d051c8fb146e9363da8173b7cc65147f1c2b7778"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 07:33:00.204859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:33:00.205224) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506174127.718864-1508902628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:33:00.290033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 07:33:00.290361) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 07:33:00.290708) ========= ========= Total master_lag: 0.23 =========