builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-084 starttime: 1506855618.56 results: success (0) revision: f90790f7a34616b1e878f3a6f536546e048e21e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:18.565143) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:18.565537) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:18.565801) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:18.583886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:18.584232) ========= 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=ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-01 04:00:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.8M=0s 2017-10-01 04:00:18 (54.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114142 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:18.715291) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:18.715603) ========= 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=ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017649 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:18.767557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:18.770902) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f90790f7a34616b1e878f3a6f536546e048e21e6 --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 f90790f7a34616b1e878f3a6f536546e048e21e6 --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=ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-01 04:00:18,798 truncating revision to first 12 chars 2017-10-01 04:00:18,798 Setting DEBUG logging. 2017-10-01 04:00:18,799 attempt 1/10 2017-10-01 04:00:18,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f90790f7a346?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-01 04:00:19,467 unpacking tar archive at: mozilla-central-f90790f7a346/testing/mozharness/ program finished with exit code 0 elapsedTime=0.951999 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:19.739649) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:19.742986) ========= script_repo_revision: f90790f7a34616b1e878f3a6f536546e048e21e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:19.743351) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:19.743609) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-01 04:00:19.762081) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-10-01 04:00:19.762435) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:00:19 INFO - MultiFileLogger online at 20171001 04:00:19 in /builds/slave/test 04:00:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:00:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:00:19 INFO - {'append_to_log': False, 04:00:19 INFO - 'base_work_dir': '/builds/slave/test', 04:00:19 INFO - 'blob_upload_branch': 'Firefox', 04:00:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:00:19 INFO - 'branch': 'Firefox', 04:00:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:00:19 INFO - 'code_coverage': False, 04:00:19 INFO - 'config_files': ('talos/linux_config.py',), 04:00:19 INFO - 'default_actions': ('clobber', 04:00:19 INFO - 'read-buildbot-config', 04:00:19 INFO - 'download-and-extract', 04:00:19 INFO - 'populate-webroot', 04:00:19 INFO - 'create-virtualenv', 04:00:19 INFO - 'install', 04:00:19 INFO - 'setup-mitmproxy', 04:00:19 INFO - 'run-tests'), 04:00:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:00:19 INFO - 'disable_ccov_upload': False, 04:00:19 INFO - 'disable_stylo': False, 04:00:19 INFO - 'download_minidump_stackwalk': True, 04:00:19 INFO - 'download_symbols': 'ondemand', 04:00:19 INFO - 'enable_stylo': False, 04:00:19 INFO - 'enable_webrender': False, 04:00:19 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:00:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:00:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:00:19 INFO - 'gecko_profile': False, 04:00:19 INFO - 'gecko_profile_interval': 0, 04:00:19 INFO - 'installer_path': 'installer.exe', 04:00:19 INFO - 'log_level': 'info', 04:00:19 INFO - 'log_name': 'talos', 04:00:19 INFO - 'log_to_console': True, 04:00:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:00:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:00:19 INFO - 'opt_config_files': (), 04:00:19 INFO - 'pip_index': False, 04:00:19 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:00:19 INFO - 'system_bits': '32', 04:00:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:00:19 INFO - 'title': 'talos-linux64-ix-084', 04:00:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:00:19 INFO - 'use_talos_json': True, 04:00:19 INFO - 'verify': 'False', 04:00:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:00:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:00:19 INFO - 'work_dir': 'build'} 04:00:19 INFO - [mozharness: 2017-10-01 11:00:19.927984Z] Running clobber step. 04:00:19 INFO - Running pre-action listener: _resource_record_pre_action 04:00:19 INFO - Running main action method: clobber 04:00:19 INFO - rmtree: /builds/slave/test/build 04:00:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:00:21 INFO - Running post-action listener: _resource_record_post_action 04:00:21 INFO - [mozharness: 2017-10-01 11:00:21.573717Z] Finished clobber step (success) 04:00:21 INFO - [mozharness: 2017-10-01 11:00:21.573815Z] Running read-buildbot-config step. 04:00:21 INFO - Running pre-action listener: _resource_record_pre_action 04:00:21 INFO - Running main action method: read_buildbot_config 04:00:21 INFO - Using buildbot properties: 04:00:21 INFO - { 04:00:21 INFO - "project": "", 04:00:21 INFO - "product": "firefox", 04:00:21 INFO - "who": "archaeopteryx@coole-files.de", 04:00:21 INFO - "installer_path": "public/build/target.tar.bz2", 04:00:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:00:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:00:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 04:00:21 INFO - "stage_platform": "linux64-pgo", 04:00:21 INFO - "basedir": "/builds/slave/test", 04:00:21 INFO - "buildnumber": 80, 04:00:21 INFO - "platform": "ubuntu64_hw", 04:00:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:00:21 INFO - "slavebuilddir": "test", 04:00:21 INFO - "taskId": "P1Lz4phyRMC42gM7rTrDZA", 04:00:21 INFO - "branch": "mozilla-central", 04:00:21 INFO - "script_repo_revision": "production", 04:00:21 INFO - "revision": "f90790f7a34616b1e878f3a6f536546e048e21e6", 04:00:21 INFO - "slavename": "talos-linux64-ix-084", 04:00:21 INFO - "repo_path": "mozilla-central" 04:00:21 INFO - } 04:00:21 INFO - Finding installer, test and symbols from parent task. 04:00:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P1Lz4phyRMC42gM7rTrDZA'}, attempt #1 04:00:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P1Lz4phyRMC42gM7rTrDZA'}, attempt #1 04:00:22 INFO - Task dependencies: LTVQZ2y-So2WoMe30iGkIw 04:00:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw'}, attempt #1 04:00:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.tar.bz2 04:00:22 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.test_packages.json 04:00:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.crashreporter-symbols.zip 04:00:22 INFO - Running post-action listener: _resource_record_post_action 04:00:22 INFO - [mozharness: 2017-10-01 11:00:22.892638Z] Finished read-buildbot-config step (success) 04:00:22 INFO - [mozharness: 2017-10-01 11:00:22.892856Z] Running download-and-extract step. 04:00:22 INFO - Running pre-action listener: _resource_record_pre_action 04:00:22 INFO - Running main action method: download_and_extract 04:00:22 INFO - mkdir: /builds/slave/test/build/tests 04:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:22 INFO - trying https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.test_packages.json 04:00:22 INFO - Downloading https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:00:23 INFO - Downloaded 989 bytes. 04:00:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:00:23 INFO - Using the following test package requirements: 04:00:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:00:23 INFO - u'common': [u'target.common.tests.zip'], 04:00:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:00:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:00:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:00:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:00:23 INFO - u'mozbase': [u'target.common.tests.zip'], 04:00:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:00:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:00:23 INFO - u'web-platform': [u'target.common.tests.zip', 04:00:23 INFO - u'target.web-platform.tests.tar.gz'], 04:00:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:00:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:00:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.common.tests.zip 04:00:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:00:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.common.tests.zip into memory 04:00:24 INFO - Content-Length response header: 55913831 04:00:24 INFO - Bytes received: 55913831 04:00:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.talos.tests.zip 04:00:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:00:35 INFO - Fetch https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.talos.tests.zip into memory 04:00:35 INFO - Content-Length response header: 14522385 04:00:36 INFO - Bytes received: 14522385 04:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:36 INFO - trying https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.tar.bz2 04:00:36 INFO - Downloading https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:00:37 INFO - Downloaded 62353704 bytes. 04:00:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.tar.bz2 04:00:37 INFO - mkdir: /builds/slave/test/properties 04:00:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:00:37 INFO - Writing to file /builds/slave/test/properties/build_url 04:00:37 INFO - Contents: 04:00:37 INFO - build_url:https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.tar.bz2 04:00:37 INFO - Running post-action listener: _resource_record_post_action 04:00:37 INFO - Running post-action listener: find_tests_for_verification 04:00:37 INFO - Running post-action listener: set_extra_try_arguments 04:00:37 INFO - [mozharness: 2017-10-01 11:00:37.834920Z] Finished download-and-extract step (success) 04:00:37 INFO - [mozharness: 2017-10-01 11:00:37.835150Z] Running populate-webroot step. 04:00:37 INFO - Running pre-action listener: _resource_record_pre_action 04:00:37 INFO - Running main action method: populate_webroot 04:00:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:00:37 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:37 INFO - 'tests': ['tresize', 04:00:37 INFO - 'tcanvasmark']}, 04:00:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:00:37 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:37 INFO - 'tests': ['dromaeo_css', 04:00:37 INFO - 'kraken']}, 04:00:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:00:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:37 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:00:37 INFO - 'talos_options': ['--disable-stylo'], 04:00:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:00:37 INFO - 'tests': ['damp', 'tps']}, 04:00:37 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:00:37 INFO - 'talos_options': ['--disable-stylo'], 04:00:37 INFO - 'tests': ['damp', 'tps']}, 04:00:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:00:37 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:37 INFO - 'tests': ['dromaeo_dom']}, 04:00:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:00:37 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:37 INFO - 'tests': ['basic_compositor_video', 04:00:37 INFO - 'glvideo']}, 04:00:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:00:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:00:37 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:00:37 INFO - 'talos_options': ['--disable-stylo'], 04:00:37 INFO - 'tests': ['ts_paint_webext', 04:00:37 INFO - 'tp5o_webext']}, 04:00:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:00:37 INFO - 'ts_paint', 04:00:37 INFO - 'tpaint', 04:00:37 INFO - 'sessionrestore', 04:00:37 INFO - 'sessionrestore_many_windows', 04:00:37 INFO - 'sessionrestore_no_auto_restore', 04:00:37 INFO - 'tabpaint', 04:00:37 INFO - 'cpstartup']}, 04:00:37 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:37 INFO - 'tests': ['a11yr', 04:00:37 INFO - 'ts_paint', 04:00:37 INFO - 'tpaint', 04:00:37 INFO - 'sessionrestore', 04:00:37 INFO - 'sessionrestore_many_windows', 04:00:37 INFO - 'sessionrestore_no_auto_restore', 04:00:37 INFO - 'tabpaint', 04:00:37 INFO - 'cpstartup']}, 04:00:37 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 04:00:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:00:37 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:37 INFO - 'tests': ['perf_reftest_singletons']}, 04:00:37 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:37 INFO - 'tests': ['perf_reftest']}, 04:00:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:00:37 INFO - 'tsvgr_opacity', 04:00:37 INFO - 'tart', 04:00:37 INFO - 'tscrollx', 04:00:37 INFO - 'tsvg_static']}, 04:00:37 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:37 INFO - 'tests': ['tsvgx', 04:00:37 INFO - 'tsvgr_opacity', 04:00:37 INFO - 'tart', 04:00:37 INFO - 'tscrollx', 04:00:37 INFO - 'tsvg_static']}, 04:00:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:00:37 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:00:37 INFO - 'talos_options': ['--disable-stylo'], 04:00:37 INFO - 'tests': ['tp5o']}, 04:00:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:00:37 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:00:37 INFO - 'talos_options': ['--mitmproxy', 04:00:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:00:37 INFO - '--firstNonBlankPaint'], 04:00:37 INFO - 'tests': ['tp6_google', 04:00:37 INFO - 'tp6_youtube', 04:00:37 INFO - 'tp6_amazon', 04:00:37 INFO - 'tp6_facebook']}, 04:00:37 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:00:37 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:00:37 INFO - 'talos_options': ['--disable-stylo', 04:00:37 INFO - '--mitmproxy', 04:00:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:00:37 INFO - '--firstNonBlankPaint'], 04:00:37 INFO - 'tests': ['tp6_google', 04:00:37 INFO - 'tp6_youtube', 04:00:37 INFO - 'tp6_amazon', 04:00:37 INFO - 'tp6_facebook']}, 04:00:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:00:37 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:00:37 INFO - 'talos_options': ['--stylo-threads=1', 04:00:37 INFO - '--mitmproxy', 04:00:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:00:37 INFO - '--firstNonBlankPaint'], 04:00:37 INFO - 'tests': ['tp6_google', 04:00:37 INFO - 'tp6_youtube', 04:00:37 INFO - 'tp6_amazon', 04:00:37 INFO - 'tp6_facebook']}, 04:00:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:00:37 INFO - 'talos_options': ['--xperf_path', 04:00:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:37 INFO - 'tests': ['tp5n']}, 04:00:37 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:00:37 INFO - 'talos_options': ['--disable-stylo', 04:00:37 INFO - '--xperf_path', 04:00:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:37 INFO - 'tests': ['tp5n']}}} 04:00:37 INFO - Running post-action listener: _resource_record_post_action 04:00:37 INFO - [mozharness: 2017-10-01 11:00:37.857636Z] Finished populate-webroot step (success) 04:00:37 INFO - [mozharness: 2017-10-01 11:00:37.857725Z] Running create-virtualenv step. 04:00:37 INFO - Running pre-action listener: _resource_record_pre_action 04:00:37 INFO - Running main action method: create_virtualenv 04:00:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:00:37 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:00:37 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:00:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:00:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:00:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:00:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:00:38 INFO - Installing pip...............done. 04:00:38 INFO - Return code: 0 04:00:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:00:38 INFO - Reading from file tmpfile_stdout 04:00:38 INFO - Output received: 04:00:38 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:00:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076d60>, '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 0x2077a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', '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 04:00:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:00:38 INFO - Using env: {'DISPLAY': ':0', 04:00:38 INFO - 'HOME': '/home/cltbld', 04:00:38 INFO - 'LANG': 'en_US.UTF-8', 04:00:38 INFO - 'LANGUAGE': 'en_US:en', 04:00:38 INFO - 'LOGNAME': 'cltbld', 04:00:38 INFO - 'MAIL': '/var/mail/cltbld', 04:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:38 INFO - 'MOZ_NO_REMOTE': '1', 04:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:38 INFO - 'NO_EM_RESTART': '1', 04:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:38 INFO - 'PWD': '/builds/slave/test', 04:00:38 INFO - 'SHELL': '/bin/bash', 04:00:38 INFO - 'SHLVL': '1', 04:00:38 INFO - 'TERM': 'linux', 04:00:38 INFO - 'TMOUT': '86400', 04:00:38 INFO - 'USER': 'cltbld', 04:00:38 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', 04:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:38 INFO - '_': '/tools/buildbot/bin/python'} 04:00:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:00:40 INFO - Downloading/unpacking pip>=1.5 04:00:40 INFO - Running setup.py egg_info for package pip 04:00:40 INFO - warning: no files found matching 'pip/cacert.pem' 04:00:40 INFO - warning: no files found matching '*.html' under directory 'docs' 04:00:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:00:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:00:40 INFO - Installing collected packages: pip 04:00:40 INFO - Found existing installation: pip 1.1 04:00:40 INFO - Uninstalling pip: 04:00:40 INFO - Successfully uninstalled pip 04:00:40 INFO - Running setup.py install for pip 04:00:40 INFO - warning: no files found matching 'pip/cacert.pem' 04:00:40 INFO - warning: no files found matching '*.html' under directory 'docs' 04:00:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:00:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:00:40 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:00:40 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:00:40 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:00:40 INFO - Successfully installed pip 04:00:40 INFO - Cleaning up... 04:00:40 INFO - Return code: 0 04:00:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00: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')]} 04:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00: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 0x1d0c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076d60>, '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 0x2077a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', '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 04:00: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 04:00: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 04:00:40 INFO - Using env: {'DISPLAY': ':0', 04:00:40 INFO - 'HOME': '/home/cltbld', 04:00:40 INFO - 'LANG': 'en_US.UTF-8', 04:00:40 INFO - 'LANGUAGE': 'en_US:en', 04:00:40 INFO - 'LOGNAME': 'cltbld', 04:00:40 INFO - 'MAIL': '/var/mail/cltbld', 04:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:40 INFO - 'MOZ_NO_REMOTE': '1', 04:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:40 INFO - 'NO_EM_RESTART': '1', 04:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:40 INFO - 'PWD': '/builds/slave/test', 04:00:40 INFO - 'SHELL': '/bin/bash', 04:00:40 INFO - 'SHLVL': '1', 04:00:40 INFO - 'TERM': 'linux', 04:00:40 INFO - 'TMOUT': '86400', 04:00:40 INFO - 'USER': 'cltbld', 04:00:40 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', 04:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:40 INFO - '_': '/tools/buildbot/bin/python'} 04:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:40 INFO - Downloading/unpacking psutil>=3.1.1 04:00: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 04:00: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 04:00: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 04:00: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 04:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:00:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:41 INFO - Installing collected packages: psutil 04:00:41 INFO - Running setup.py install for psutil 04:00:41 INFO - building 'psutil._psutil_linux' extension 04:00: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 04:00:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:00:41 INFO - building 'psutil._psutil_posix' extension 04:00:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:00:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:00:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:42 INFO - Successfully installed psutil 04:00:42 INFO - Cleaning up... 04:00:42 INFO - Return code: 0 04:00:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00: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')]} 04:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00: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 0x1d0c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076d60>, '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 0x2077a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', '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 04:00: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 04:00: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 04:00:42 INFO - Using env: {'DISPLAY': ':0', 04:00:42 INFO - 'HOME': '/home/cltbld', 04:00:42 INFO - 'LANG': 'en_US.UTF-8', 04:00:42 INFO - 'LANGUAGE': 'en_US:en', 04:00:42 INFO - 'LOGNAME': 'cltbld', 04:00:42 INFO - 'MAIL': '/var/mail/cltbld', 04:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:42 INFO - 'MOZ_NO_REMOTE': '1', 04:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:42 INFO - 'NO_EM_RESTART': '1', 04:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:42 INFO - 'PWD': '/builds/slave/test', 04:00:42 INFO - 'SHELL': '/bin/bash', 04:00:42 INFO - 'SHLVL': '1', 04:00:42 INFO - 'TERM': 'linux', 04:00:42 INFO - 'TMOUT': '86400', 04:00:42 INFO - 'USER': 'cltbld', 04:00:42 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', 04:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:42 INFO - '_': '/tools/buildbot/bin/python'} 04:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:00: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 04:00: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 04:00: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 04:00: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 04:00:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:00:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:00:43 INFO - Installing collected packages: mozsystemmonitor 04:00:43 INFO - Running setup.py install for mozsystemmonitor 04:00:43 INFO - Successfully installed mozsystemmonitor 04:00:43 INFO - Cleaning up... 04:00:44 INFO - Return code: 0 04:00:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00: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')]} 04:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00: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 0x1d0c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076d60>, '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 0x2077a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', '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 04:00: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 04:00: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 04:00:44 INFO - Using env: {'DISPLAY': ':0', 04:00:44 INFO - 'HOME': '/home/cltbld', 04:00:44 INFO - 'LANG': 'en_US.UTF-8', 04:00:44 INFO - 'LANGUAGE': 'en_US:en', 04:00:44 INFO - 'LOGNAME': 'cltbld', 04:00:44 INFO - 'MAIL': '/var/mail/cltbld', 04:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:44 INFO - 'MOZ_NO_REMOTE': '1', 04:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:44 INFO - 'NO_EM_RESTART': '1', 04:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:44 INFO - 'PWD': '/builds/slave/test', 04:00:44 INFO - 'SHELL': '/bin/bash', 04:00:44 INFO - 'SHLVL': '1', 04:00:44 INFO - 'TERM': 'linux', 04:00:44 INFO - 'TMOUT': '86400', 04:00:44 INFO - 'USER': 'cltbld', 04:00:44 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', 04:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:44 INFO - '_': '/tools/buildbot/bin/python'} 04:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:44 INFO - Downloading/unpacking jsonschema==2.5.1 04:00: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 04:00: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 04:00: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 04:00: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 04:00:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:00:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:46 INFO - Downloading functools32-3.2.3-2.tar.gz 04:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:00:46 INFO - warning: no files found matching '*.txt' 04:00:46 INFO - no previously-included directories found matching 'build' 04:00:46 INFO - no previously-included directories found matching 'dist' 04:00:46 INFO - no previously-included directories found matching '.git*' 04:00:46 INFO - Installing collected packages: jsonschema, functools32 04:00:46 INFO - Running setup.py install for functools32 04:00:46 INFO - warning: no files found matching '*.txt' 04:00:46 INFO - no previously-included directories found matching 'build' 04:00:46 INFO - no previously-included directories found matching 'dist' 04:00:46 INFO - no previously-included directories found matching '.git*' 04:00:46 INFO - Successfully installed jsonschema functools32 04:00:46 INFO - Cleaning up... 04:00:46 INFO - Return code: 0 04:00:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00: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')]} 04:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00: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 0x1d0c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076d60>, '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 0x2077a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', '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 04:00: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 04:00: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 04:00:46 INFO - Using env: {'DISPLAY': ':0', 04:00:46 INFO - 'HOME': '/home/cltbld', 04:00:46 INFO - 'LANG': 'en_US.UTF-8', 04:00:46 INFO - 'LANGUAGE': 'en_US:en', 04:00:46 INFO - 'LOGNAME': 'cltbld', 04:00:46 INFO - 'MAIL': '/var/mail/cltbld', 04:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:46 INFO - 'MOZ_NO_REMOTE': '1', 04:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:46 INFO - 'NO_EM_RESTART': '1', 04:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:46 INFO - 'PWD': '/builds/slave/test', 04:00:46 INFO - 'SHELL': '/bin/bash', 04:00:46 INFO - 'SHLVL': '1', 04:00:46 INFO - 'TERM': 'linux', 04:00:46 INFO - 'TMOUT': '86400', 04:00:46 INFO - 'USER': 'cltbld', 04:00:46 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', 04:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:46 INFO - '_': '/tools/buildbot/bin/python'} 04:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:00:46 INFO - Cleaning up... 04:00:46 INFO - Return code: 0 04:00:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00: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')]} 04:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00: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', '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 0x1d0c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076d60>, '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 0x2077a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', '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 04:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:00: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 blobuploader==1.2.4 04:00:46 INFO - Using env: {'DISPLAY': ':0', 04:00:46 INFO - 'HOME': '/home/cltbld', 04:00:46 INFO - 'LANG': 'en_US.UTF-8', 04:00:46 INFO - 'LANGUAGE': 'en_US:en', 04:00:46 INFO - 'LOGNAME': 'cltbld', 04:00:46 INFO - 'MAIL': '/var/mail/cltbld', 04:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:46 INFO - 'MOZ_NO_REMOTE': '1', 04:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:46 INFO - 'NO_EM_RESTART': '1', 04:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:46 INFO - 'PWD': '/builds/slave/test', 04:00:46 INFO - 'SHELL': '/bin/bash', 04:00:46 INFO - 'SHLVL': '1', 04:00:46 INFO - 'TERM': 'linux', 04:00:46 INFO - 'TMOUT': '86400', 04:00:46 INFO - 'USER': 'cltbld', 04:00:46 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', 04:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:46 INFO - '_': '/tools/buildbot/bin/python'} 04:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:47 INFO - Downloading/unpacking blobuploader==1.2.4 04:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:48 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:00:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:48 INFO - Downloading docopt-0.6.1.tar.gz 04:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:48 INFO - Running setup.py install for blobuploader 04:00:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:00:48 INFO - Running setup.py install for requests 04:00:49 INFO - Running setup.py install for docopt 04:00:49 INFO - Successfully installed blobuploader requests docopt 04:00:49 INFO - Cleaning up... 04:00:49 INFO - Return code: 0 04:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076d60>, '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 0x2077a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', '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 04:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:00:49 INFO - Using env: {'DISPLAY': ':0', 04:00:49 INFO - 'HOME': '/home/cltbld', 04:00:49 INFO - 'LANG': 'en_US.UTF-8', 04:00:49 INFO - 'LANGUAGE': 'en_US:en', 04:00:49 INFO - 'LOGNAME': 'cltbld', 04:00:49 INFO - 'MAIL': '/var/mail/cltbld', 04:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:49 INFO - 'MOZ_NO_REMOTE': '1', 04:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:49 INFO - 'NO_EM_RESTART': '1', 04:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:49 INFO - 'PWD': '/builds/slave/test', 04:00:49 INFO - 'SHELL': '/bin/bash', 04:00:49 INFO - 'SHLVL': '1', 04:00:49 INFO - 'TERM': 'linux', 04:00:49 INFO - 'TMOUT': '86400', 04:00:49 INFO - 'USER': 'cltbld', 04:00:49 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', 04:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:49 INFO - '_': '/tools/buildbot/bin/python'} 04:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:49 INFO - Running setup.py (path:/tmp/pip-ub4QWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:49 INFO - Running setup.py (path:/tmp/pip-zFPhfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:49 INFO - Running setup.py (path:/tmp/pip-WQGx9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:49 INFO - Running setup.py (path:/tmp/pip-fm6mvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:49 INFO - Running setup.py (path:/tmp/pip-Ns830m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:50 INFO - Running setup.py (path:/tmp/pip-8Em3b9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:50 INFO - Running setup.py (path:/tmp/pip-U5Fa_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:50 INFO - Running setup.py (path:/tmp/pip-o6O0qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:50 INFO - Running setup.py (path:/tmp/pip-ii3VbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:50 INFO - Running setup.py (path:/tmp/pip-Wep9L4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:50 INFO - Running setup.py (path:/tmp/pip-hhfh0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:50 INFO - Running setup.py (path:/tmp/pip-7RqMNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:50 INFO - Running setup.py (path:/tmp/pip-pfyihj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:50 INFO - Running setup.py (path:/tmp/pip-kcM9Ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:50 INFO - Running setup.py (path:/tmp/pip-D3NA1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:50 INFO - Running setup.py (path:/tmp/pip-MRAaXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:50 INFO - Running setup.py (path:/tmp/pip-HtPvcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:00:50 INFO - Running setup.py install for manifestparser 04:00:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:00:50 INFO - Running setup.py install for mozcrash 04:00:51 INFO - Running setup.py install for mozdebug 04:00:51 INFO - Running setup.py install for mozdevice 04:00:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Running setup.py install for mozfile 04:00:51 INFO - Running setup.py install for mozhttpd 04:00:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Running setup.py install for mozinfo 04:00:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Running setup.py install for mozInstall 04:00:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Running setup.py install for mozleak 04:00:51 INFO - Running setup.py install for mozlog 04:00:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Running setup.py install for moznetwork 04:00:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Running setup.py install for mozprocess 04:00:52 INFO - Running setup.py install for mozprofile 04:00:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Running setup.py install for mozrunner 04:00:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Running setup.py install for mozscreenshot 04:00:52 INFO - Running setup.py install for moztest 04:00:52 INFO - Running setup.py install for mozversion 04:00:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:00:52 INFO - Cleaning up... 04:00:52 INFO - Return code: 0 04:00:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:52 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 0x1d0c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076d60>, '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 0x2077a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', '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 04:00:52 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 04:00:52 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 04:00:52 INFO - Using env: {'DISPLAY': ':0', 04:00:52 INFO - 'HOME': '/home/cltbld', 04:00:52 INFO - 'LANG': 'en_US.UTF-8', 04:00:52 INFO - 'LANGUAGE': 'en_US:en', 04:00:52 INFO - 'LOGNAME': 'cltbld', 04:00:52 INFO - 'MAIL': '/var/mail/cltbld', 04:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:52 INFO - 'MOZ_NO_REMOTE': '1', 04:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:52 INFO - 'NO_EM_RESTART': '1', 04:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:52 INFO - 'PWD': '/builds/slave/test', 04:00:52 INFO - 'SHELL': '/bin/bash', 04:00:52 INFO - 'SHLVL': '1', 04:00:52 INFO - 'TERM': 'linux', 04:00:52 INFO - 'TMOUT': '86400', 04:00:52 INFO - 'USER': 'cltbld', 04:00:52 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', 04:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:52 INFO - '_': '/tools/buildbot/bin/python'} 04:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:52 INFO - Running setup.py (path:/tmp/pip-uPKQjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:52 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)) 04:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:52 INFO - Running setup.py (path:/tmp/pip-QuCEHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:52 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)) 04:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:52 INFO - Running setup.py (path:/tmp/pip-xrJyt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:53 INFO - Running setup.py (path:/tmp/pip-2r34nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:53 INFO - Running setup.py (path:/tmp/pip-_95Lpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:53 INFO - Running setup.py (path:/tmp/pip-bsrvZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:53 INFO - Running setup.py (path:/tmp/pip-lbBbTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:53 INFO - Running setup.py (path:/tmp/pip-ZV5HkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:53 INFO - Running setup.py (path:/tmp/pip-9azaQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:53 INFO - Running setup.py (path:/tmp/pip-F44xcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:53 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)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:53 INFO - Running setup.py (path:/tmp/pip-vqlfzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:53 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)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:53 INFO - Running setup.py (path:/tmp/pip-JqERXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:53 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)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:53 INFO - Running setup.py (path:/tmp/pip-9ZCwTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:53 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)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:53 INFO - Running setup.py (path:/tmp/pip-hChp4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:53 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)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:53 INFO - Running setup.py (path:/tmp/pip-WZEf8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:53 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)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:53 INFO - Running setup.py (path:/tmp/pip-C7FlAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:53 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)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:53 INFO - Running setup.py (path:/tmp/pip-Ma5X8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:00:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:55 INFO - Downloading blessings-1.6.tar.gz 04:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:00:55 INFO - Installing collected packages: blessings 04:00:55 INFO - Running setup.py install for blessings 04:00:55 INFO - Successfully installed blessings 04:00:55 INFO - Cleaning up... 04:00:55 INFO - Return code: 0 04:00:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:00:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:55 INFO - Reading from file tmpfile_stdout 04:00:55 INFO - Current package versions: 04:00:55 INFO - argparse == 1.2.1 04:00:55 INFO - blessings == 1.6 04:00:55 INFO - blobuploader == 1.2.4 04:00:55 INFO - docopt == 0.6.1 04:00:55 INFO - functools32 == 3.2.3-2 04:00:55 INFO - jsonschema == 2.5.1 04:00:55 INFO - manifestparser == 1.1 04:00:55 INFO - mozInstall == 1.13 04:00:55 INFO - mozcrash == 1.0 04:00:55 INFO - mozdebug == 0.1 04:00:55 INFO - mozdevice == 0.51 04:00:55 INFO - mozfile == 1.2 04:00:55 INFO - mozhttpd == 0.7 04:00:55 INFO - mozinfo == 0.10 04:00:55 INFO - mozleak == 0.1 04:00:55 INFO - mozlog == 3.5 04:00:55 INFO - moznetwork == 0.27 04:00:55 INFO - mozprocess == 0.25 04:00:55 INFO - mozprofile == 0.28 04:00:55 INFO - mozrunner == 6.13 04:00:55 INFO - mozscreenshot == 0.1 04:00:55 INFO - mozsystemmonitor == 0.3 04:00:55 INFO - moztest == 0.8 04:00:55 INFO - mozversion == 1.4 04:00:55 INFO - psutil == 3.1.1 04:00:55 INFO - requests == 1.2.3 04:00:55 INFO - wsgiref == 0.1.2 04:00:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:55 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 0x1d0c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076d60>, '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 0x2077a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', '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 04:00:55 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 04:00:55 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 04:00:55 INFO - Using env: {'DISPLAY': ':0', 04:00:55 INFO - 'HOME': '/home/cltbld', 04:00:55 INFO - 'LANG': 'en_US.UTF-8', 04:00:55 INFO - 'LANGUAGE': 'en_US:en', 04:00:55 INFO - 'LOGNAME': 'cltbld', 04:00:55 INFO - 'MAIL': '/var/mail/cltbld', 04:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:55 INFO - 'MOZ_NO_REMOTE': '1', 04:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:55 INFO - 'NO_EM_RESTART': '1', 04:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:55 INFO - 'PWD': '/builds/slave/test', 04:00:55 INFO - 'SHELL': '/bin/bash', 04:00:55 INFO - 'SHLVL': '1', 04:00:55 INFO - 'TERM': 'linux', 04:00:55 INFO - 'TMOUT': '86400', 04:00:55 INFO - 'USER': 'cltbld', 04:00:55 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', 04:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:55 INFO - '_': '/tools/buildbot/bin/python'} 04:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:55 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)) 04:00:55 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)) 04:00:55 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)) 04:00:55 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)) 04:00:55 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)) 04:00:55 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)) 04:00:55 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)) 04:00:55 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)) 04:00:55 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)) 04:00:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:00:57 INFO - Installing collected packages: simplejson 04:00:57 INFO - Running setup.py install for simplejson 04:00:57 INFO - building 'simplejson._speedups' extension 04:00:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 04:00:57 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 04:00:58 INFO - Successfully installed simplejson 04:00:58 INFO - Cleaning up... 04:00:58 INFO - Return code: 0 04:00:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076d60>, '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 0x2077a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', '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 04:00:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:00:58 INFO - Using env: {'DISPLAY': ':0', 04:00:58 INFO - 'HOME': '/home/cltbld', 04:00:58 INFO - 'LANG': 'en_US.UTF-8', 04:00:58 INFO - 'LANGUAGE': 'en_US:en', 04:00:58 INFO - 'LOGNAME': 'cltbld', 04:00:58 INFO - 'MAIL': '/var/mail/cltbld', 04:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:58 INFO - 'MOZ_NO_REMOTE': '1', 04:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:58 INFO - 'NO_EM_RESTART': '1', 04:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:58 INFO - 'PWD': '/builds/slave/test', 04:00:58 INFO - 'SHELL': '/bin/bash', 04:00:58 INFO - 'SHLVL': '1', 04:00:58 INFO - 'TERM': 'linux', 04:00:58 INFO - 'TMOUT': '86400', 04:00:58 INFO - 'USER': 'cltbld', 04:00:58 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', 04:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:58 INFO - '_': '/tools/buildbot/bin/python'} 04:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:00:58 INFO - Cleaning up... 04:00:58 INFO - Return code: 0 04:00:58 INFO - Running post-action listener: _resource_record_post_action 04:00:58 INFO - Running post-action listener: _start_resource_monitoring 04:00:58 INFO - Starting resource monitoring. 04:00:58 INFO - [mozharness: 2017-10-01 11:00:58.321212Z] Finished create-virtualenv step (success) 04:00:58 INFO - [mozharness: 2017-10-01 11:00:58.321797Z] Running install step. 04:00:58 INFO - Running pre-action listener: _resource_record_pre_action 04:00:58 INFO - Running main action method: install 04:00:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:58 INFO - Reading from file tmpfile_stdout 04:00:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:00:58 INFO - Reading from file tmpfile_stdout 04:00:58 INFO - Output received: 04:00:58 INFO - Usage: mozinstall [options] installer 04:00:58 INFO - Options: 04:00:58 INFO - -h, --help show this help message and exit 04:00:58 INFO - -d DEST, --destination=DEST 04:00:58 INFO - Directory to install application into. [default: 04:00:58 INFO - "/builds/slave/test"] 04:00:58 INFO - --app=APP Application being installed. [default: firefox] 04:00:58 INFO - mkdir: /builds/slave/test/build/application 04:00:58 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'] 04:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:01:16 INFO - Reading from file tmpfile_stdout 04:01:16 INFO - Output received: 04:01:16 INFO - /builds/slave/test/build/application/firefox/firefox 04:01:16 INFO - Running post-action listener: _resource_record_post_action 04:01:16 INFO - [mozharness: 2017-10-01 11:01:16.262513Z] Finished install step (success) 04:01:16 INFO - [mozharness: 2017-10-01 11:01:16.262766Z] Running setup-mitmproxy step. 04:01:16 INFO - Running pre-action listener: _resource_record_pre_action 04:01:16 INFO - Running main action method: setup_mitmproxy 04:01:16 INFO - Skipping: mitmproxy is not required 04:01:16 INFO - Running post-action listener: _resource_record_post_action 04:01:16 INFO - [mozharness: 2017-10-01 11:01:16.263919Z] Finished setup-mitmproxy step (success) 04:01:16 INFO - [mozharness: 2017-10-01 11:01:16.264144Z] Running run-tests step. 04:01:16 INFO - Running pre-action listener: _resource_record_pre_action 04:01:16 INFO - Running pre-action listener: _set_gcov_prefix 04:01:16 INFO - Running main action method: run_tests 04:01:16 WARNING - Try message not found. 04:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:01:16 INFO - Python 2.7.3 04:01:16 INFO - Return code: 0 04:01:16 INFO - grabbing minidump binary from tooltool 04:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076d60>, '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 0x2077a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:01:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:01:16 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:01:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:01:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:01:16 INFO - Return code: 0 04:01:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:01:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:01:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:01:16 INFO - ENV: RUST_BACKTRACE is now full 04:01:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:01:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 04:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --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 04:01:16 INFO - Using env: {'DISPLAY': ':0', 04:01:16 INFO - 'HOME': '/home/cltbld', 04:01:16 INFO - 'LANG': 'en_US.UTF-8', 04:01:16 INFO - 'LANGUAGE': 'en_US:en', 04:01:16 INFO - 'LOGNAME': 'cltbld', 04:01:16 INFO - 'MAIL': '/var/mail/cltbld', 04:01:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:16 INFO - 'MOZ_NO_REMOTE': '1', 04:01:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:16 INFO - 'NO_EM_RESTART': '1', 04:01:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:16 INFO - 'PWD': '/builds/slave/test', 04:01:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:16 INFO - 'RUST_BACKTRACE': 'full', 04:01:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:01:16 INFO - 'SHELL': '/bin/bash', 04:01:16 INFO - 'SHLVL': '1', 04:01:16 INFO - 'TERM': 'linux', 04:01:16 INFO - 'TMOUT': '86400', 04:01:16 INFO - 'USER': 'cltbld', 04:01:16 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', 04:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:16 INFO - '_': '/tools/buildbot/bin/python'} 04:01:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 04:01:16 INFO - mozversion application_buildid: 20171001093509 04:01:16 INFO - mozversion application_changeset: f90790f7a34616b1e878f3a6f536546e048e21e6 04:01:16 INFO - mozversion application_display_name: FirefoxNightly 04:01:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:01:16 INFO - mozversion application_name: Firefox 04:01:16 INFO - mozversion application_remotingname: firefox 04:01:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:01:16 INFO - mozversion application_vendor: Mozilla 04:01:16 INFO - mozversion application_version: 58.0a1 04:01:16 INFO - mozversion platform_buildid: 20171001093509 04:01:16 INFO - mozversion platform_changeset: f90790f7a34616b1e878f3a6f536546e048e21e6 04:01:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:01:16 INFO - mozversion platform_version: 58.0a1 04:01:16 INFO - using testdate: 1506855676 04:01:16 INFO - actual date: 1506855676 04:01:16 INFO - starting webserver on 'localhost:59063' 04:01:16 INFO - SUITE-START | Running 2 tests 04:01:16 INFO - TEST-START | dromaeo_css 04:01:16 INFO - Initialising browser for dromaeo_css test... 04:01:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59063/getInfo.html -profile /tmp/tmpkw2BR2/profile 04:01:16 INFO - TEST-INFO | started process 2876 (/builds/slave/test/build/application/firefox/firefox http://localhost:59063/getInfo.html) 04:01:22 INFO - TEST-INFO | 2876: exit 0 04:01:22 INFO - Browser initialized. 04:01:22 INFO - Running cycle 1/1 for dromaeo_css test... 04:01:22 INFO - Using env: {'DISPLAY': ':0', 04:01:22 INFO - 'HOME': '/home/cltbld', 04:01:22 INFO - 'JSGC_DISABLE_POISONING': '1', 04:01:22 INFO - 'LANG': 'en_US.UTF-8', 04:01:22 INFO - 'LANGUAGE': 'en_US:en', 04:01:22 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:01:22 INFO - 'LOGNAME': 'cltbld', 04:01:22 INFO - 'MAIL': '/var/mail/cltbld', 04:01:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:01:22 INFO - 'MOZ_CRASHREPORTER': '1', 04:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:22 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:01:22 INFO - 'MOZ_NO_REMOTE': '1', 04:01:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:22 INFO - 'NO_EM_RESTART': '1', 04:01:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:22 INFO - 'PWD': '/builds/slave/test', 04:01:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:22 INFO - 'RUST_BACKTRACE': 'full', 04:01:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:01:22 INFO - 'SHELL': '/bin/bash', 04:01:22 INFO - 'SHLVL': '1', 04:01:22 INFO - 'STYLO_FORCE_DISABLED': '1', 04:01:22 INFO - 'TERM': 'linux', 04:01:22 INFO - 'TMOUT': '86400', 04:01:22 INFO - 'USER': 'cltbld', 04:01:22 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', 04:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:22 INFO - '_': '/tools/buildbot/bin/python'} 04:01:22 INFO - TEST-INFO | started process 3220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkw2BR2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:23 INFO - PID 3220 | 04:01:23 INFO - PID 3220 | (/builds/slave/test/build/application/firefox/firefox:3271): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:01:23 INFO - PID 3220 | 04:01:33 INFO - PID 3220 | RSS: Main: 144584704 04:01:33 INFO - PID 3220 | 04:04:31 INFO - PID 3220 | Cycle 1(1): loaded http://localhost:59063/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59063/tests/dromaeo/cssquery-ext.html) 04:04:32 INFO - PID 3220 | RSS: Main: 143245312 04:04:32 INFO - PID 3220 | 04:07:33 INFO - PID 3220 | Cycle 1(1): loaded http://localhost:59063/tests/dromaeo/cssquery-ext.html (next: http://localhost:59063/tests/dromaeo/cssquery-jquery.html) 04:07:34 INFO - PID 3220 | RSS: Main: 143835136 04:07:34 INFO - PID 3220 | 04:10:36 INFO - PID 3220 | Cycle 1(1): loaded http://localhost:59063/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59063/tests/dromaeo/cssquery-mootools.html) 04:10:36 INFO - PID 3220 | RSS: Main: 144564224 04:10:36 INFO - PID 3220 | 04:13:38 INFO - PID 3220 | Cycle 1(1): loaded http://localhost:59063/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59063/tests/dromaeo/cssquery-prototype.html) 04:13:38 INFO - PID 3220 | RSS: Main: 144814080 04:13:38 INFO - PID 3220 | 04:16:41 INFO - PID 3220 | Cycle 1(1): loaded http://localhost:59063/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59063/tests/dromaeo/cssquery-yui.html) 04:16:42 INFO - PID 3220 | RSS: Main: 147791872 04:16:42 INFO - PID 3220 | 04:19:43 INFO - PID 3220 | Cycle 1(1): loaded http://localhost:59063/tests/dromaeo/cssquery-yui.html (next: http://localhost:59063/tests/dromaeo/cssquery-dojo.html) 04:19:44 INFO - PID 3220 | RSS: Main: 148729856 04:19:44 INFO - PID 3220 | 04:19:44 INFO - PID 3220 | __start_tp_report 04:19:44 INFO - PID 3220 | _x_x_mozilla_page_load 04:19:44 INFO - PID 3220 | _x_x_mozilla_page_load_details 04:19:44 INFO - PID 3220 | |i|pagename|runs| 04:19:44 INFO - PID 3220 | |0;dojo.html;3853.2293541291738;3862.1117143057095;3873.7675739455626;3879.941800872986;3911.217756448709;6099.481544068748;6186.721597528111;6207.255129384469;6229.408206220413;6282.183316168897;6156;6172.598781079238;6197.783077592285;6211.565190436671;6213.34759850216;5511.5039646431815;5515.255440515539;5577.944220557783;5611.102223644218;5618.803341883015;5542.944570554303;5605.075162598187;5625.915611265835;5641.407652196522;5718.7426565804435;5463.699496527689;5568.777248910039;5597.328320601534;5612.186232996233;5730.226419433365;5532.3637781655225;5601.467860553241;5622.606417550773;5629.746661400206;5633.549316054706;5544.6118771686;5564.610477266593;5572.888542229173;5630.605857589971;5644.4073372295725;6214.596051256699;6234.438900498977;6235.314115447297;6245.718942647592;6264.7807326743805;6800.387965083166;6829.521933464659;6834.624095674736;6844.349786770249;6852.760153394607;6788.151481064867;6815.454763618898;6820.215675197366;6888.862222755567;6915.619640919747;6195.132681424604;6281.434670879597;6285.8742825143245;6292.339304373067;6413.29453760086;7024.192217894905;7047.54190977595;7059.8235044123285;7126.2161162272105;7151.928480715126;6635.137432133888;6681.832954176088;6736.292689267556;6741.3932746052105;6814.48891333152;6799.286074962157;6845.794626161223;6866.141732283465;6873.450123990069;6900.03399524067;6711.395974362234;6734;6796.626185559841;6809.216940051859;6812.795616131524;6745.291744366869;6749.291324410964;6816.931830681629;6826.931730682729;6840.144981877265;4920.3111564381015;4921.237208232729;4922.433920099163;5003.224500202475;5078.949210507848;4559.407277054028;4561;4588.082383523309;4596.563326483979;4608.654350923694;6182.010878259457;6183.319834818167;6191.102290167901;6257.812265632038;6276.497880169575;6641.335866413417;6731.49513786468;6743.9325606743305;6807.761728339485;6828.931710682829;6245.0320200368105;6245.156903818017;6248.28144763349;6261.655608941552;6270.655113968775;5451.48210919962;5452.454754524595;5513.9448605514235;5526.834194974157;5546.306711661043;7025.789226323219;7026.859462810818;7097.7160913562875;7134.964325178445;7138;6643.701033453506;6758.763443279461;6765.661716914233;6837.2820853809635;6845.4865885057825;7031.261717519586;7057.258987806206;7137.857242855218;7148.249433809375;7148.28517148281;6709.93290067093;6758.459323254227;6799;6817.522773405814;6838.623875686885;6714.093597364294;6816.591004539743;6826.931730682828;6834.2482326943;6835.658217089026;6522.902156467562;6524.5759025665075;6530.706118224596;6607.3062328456745;6617.503687223381;6473.8705225896165;6638.634875081917;6658.7336506539195;6658.83352916181;6660.500462465237;6334.841628959313;6384.042393640991;6429.903551446639;6451.903221451776;6459.483241340776;6614.503912206507;6668.866622667617;6689.665516724047;6710.731570737116;6717.1267735194115;6310.5267104968225;6362.363763623601;6415.58298710601;6442.710078046593;6519.315471875385 04:19:44 INFO - PID 3220 | |1;ext.html;957.4446820843912;972.8346181149204;991.880974283086;1017.5217647705575;1022.9028242316978;44003.339949900736;44880.102397952105;44891.775541122246;44915.326270105936;45099.32351014733;47142.76428617852;47838.521614783844;47869.52130478694;47880.28179577309;47949.52050479494;8598.699045533407;8650.697225597105;8712.0416754157;8725.083866194022;8726.432781869158;8567.528785916773;8650.870236946419;8670.13298670131;8710.12898710127;8720.781980450507;8728.432651877607;8764.079771623983;8787.077356877531;8807.64769409226;8815.77960550985;8650.697225597138;8688.956555217215;8712.215900568915;8715.869261961076;8727.127287271254;8579.785505362353;8654.87017694735;8655.523946182957;8657.740267791976;8658.956705216433;41409.58590414088;41490;41617;41646.58353416457;41659.37510937338;3823.1206822430718;3853.075261937115;3854.5181852268465;3856.3444214483607;3860.7297489175767;33910.49134262988;33944.49083263728;34086.82956585226;34154.975350739514;34171.14572135716;5365.517103460668;5423.810166644188;5429.701366424845;5445.428230035829;5624.943750562483;208701;210041;210087.94956025275;210151;210825;51326.23010654843;51677.22484162741;51737.482625174016;51769;51951.48048519542;60574;61429.69285153635;61458.69270653618;61496.38503614996;61545;16344.101074440781;17676.292948281924;17809.643807123786;17819.10904454772;17867.28530858751;13118.147320424141;13191;13209.471621135239;13223.272720000492;13241.536546220836;16360.918195408947;16370.918145409434;16505.17474126289;16528.25622846975;16531.173441327886;5916.349201587822;6178;6195.473384762256;6230.6573138476915;6232.875342493125;1093.6117678224116;1097.6377795327683;1111.5498223219608;1119.994400028011;1122.663201039701;26415.735842641712;26460.470790584466;26581.202563923114;26589.601155982677;26651.200463985722;1220.9694757630953;1230.4585982167816;1236.8763123687738;1246.389269258075;1248.0078337721534;13884.791728123884;13984.370703318375;14011.509597164051;14045.01684882069;14246.074005189837;278293;279761;280309;280815;281799;52057.7397113012;52984.47015529795;58886.41113588895;59575.70212148998;60362.69818650879;1554.7512398016263;1559.8830087743238;1566.0290619815787;1566.5691934717815;1574.5355120239558;30810.665230272625;30878.53682194724;31128.377432451678;31313.53029704511;31662;41907.580924191585;42075.57924420839;42102.36846447244;42116;42330.36504452497;243917;245628;245723;246393;246879;37056.44415333826;38022.61977380191;38488;38523.22953540857;39034;47864;49505.752471237414;49557.50442495673;50012.49987500079;50139.74930125326;35442.64557354394;35771;35836.64163358333;36248.456273155396;36703;35823.28353432969;36110.45834312435;36190.4571431434;36201.637983619825;36222.63777362193;40323.3951490722;42078.158436831705;42103.15793684171;42137.57862421337;42422.575774241865;34814.303713926085;35202.29595408026;35325.646743532234;35635.28729425345;35950.46074308835;26037.6094358581;26251.162418630513;26306;26408.471830562896;26852.59721104146 04:19:44 INFO - PID 3220 | |2;jquery.html;613.5398451161628;630.9085282461342;635.8473966248096;641.1184621145925;642.8457170279135;23755.75657484421;24261.39346516338;24398.75601243987;25156.622650660232;25256.11603593872;21753.12987480499;21840.672389914165;21872.781272187272;21980.450488737788;22064.117435302607;6331.905021424683;6468.902966455507;6506.251781045169;6508.479321654257;6512.023196520512;6364.745410183587;6435.549511534195;6616.305287944769;6692.564983276072;6707.798766037003;6617.867642647144;6646.9667651661675;6653.767118150866;6664.300248473914;6688.498362622799;6502.577332473397;6675.532712710088;6786.253512113663;6799.252082270947;6805.251422343538;6335.461485773715;6346.42882140605;6369.076483909807;6380.106785050097;6393.264774550893;31203.687963120534;31427.37145257082;31654;31685;31723.84138079318;2284.6001949658744;2342.1802369170823;2364.408897775556;2367.0413482539598;2372.027468737809;19683.803161968484;20565.177392904265;20580.176792928265;20581.279655212147;20582.176712931614;2616.2674451153707;2625.934351641205;2670.7462791034823;2679.3837417394107;2682.383051898055;139977.3001134998;148002.25998869937;156852;162708;163949;15616.843831561766;16702.49892503227;16796.58008549796;16864.32542698303;16997.49007529776;26865.328366790985;26943.326416839343;26979.460410791675;27006.864965675046;27012.594811077848;10105.545250463747;10497.475126243657;10533.9473302633;10538.473076346152;10551.577936882439;9112.179903808688;9253;9261.212796912203;9265.073492650681;9330.58012389444;9936.950315248378;10070.07267165806;10141.797164056825;10213.693589192337;10272.229582781321;2942.264433891527;2978.27032377069;3042.239440139965;3049.8322592257196;3085.105319457377;1060.1783617696192;1071.8660167479065;1080.3140006096185;1084.2572837606265;1098.23123813331;21613.783862161177;22097.563658362156;22205;22236.666450003264;22297.777022229893;1101.3502033799937;1106.9059129974041;1118.2675347647305;1122.057471723756;1123.3596849795701;11659.591914282959;11994.340311282964;12056.397180140957;12072.818907716392;12076.094292928066;560647;570940;574534;583093;584054;136469.31765341308;140354;140545;141395;143061;1224.9203801752858;1266.094742259289;1272.5291642092484;1274.859765425784;1275.661949583361;18921.526961826065;19036.524086897938;19121.202302918857;19464.513387165433;19731.210751569775;63013.05480417889;65182.67408662926;65630;66176;66346.33653663401;79924.60037700007;79998.6000069996;81951;82471.58764206141;83203.16796831954;15489.84510154884;15882;15913.602159946095;15966.042037477788;15997.680046398775;23504.6474302889;23762.40593985095;23847.165349212693;24094.87952560226;24267.757322427256;19606.411807645793;19609;19736.30922917691;19803;20114.19543218255;17266.395676151275;17507.649847002733;17976;18067.18697658635;18133.818661813213;20226.089825958163;20381.79618203799;20396.694049589565;20569.48576285605;20643.793562064788;15562.066276023475;15644.530664080095;15669.608259793597;15682.529524114294;15692.372305107669;19111;19383.321583744502;19549.804501954797;19704.11331490115;19709.211631535152 04:19:44 INFO - PID 3220 | |3;mootools.html;1446;1502.8046353973982;1506.4275575281392;1507.4045751927995;1521.7489114296138;16649.833501664994;17311.307547698092;17351.21919513622;17362.91318543407;17400.129993500337;16705.83294167058;16729.07990060549;16817;16842.83157168428;16851.157442127875;2742.931426714333;2778.305423644089;2779.791515636325;2786.0248912880534;2786.8049236553447;2580.8838602262945;2670.7195744446844;2674.318048897538;2675.291047872315;2676.933076673079;2706.688730795954;2777.9444411111867;2886.163012726307;2907.7092290770966;2909.534474484083;2836.5177919753487;2840.7585355244623;2841.786865985049;2857.8571071446345;2871.870765815543;2681.1554360376417;2707.3367025078783;2740.9588856167175;2855.6715977662625;2855.700151484106;17226.655466890592;17339.21973511195;17366.65266694659;17397.39109131187;17410.651786964318;8658.134186581354;8873.778155546099;8938.1508756668;8941.195292423648;8951.14964078418;5151.819686310999;5367.114426119686;5400.459954004607;5419.756110975016;5500.064988951848;2070.492729281336;2095.5389814240843;2101.443117573844;2129.4782778219283;2141.2719675310314;31061.22346941322;31428.528572071667;31506;31512.684873151433;31603.20991975196;7154.248803875518;7291.4531410144455;7361.705531778776;7425.108986921604;7705.383569314441;20127.597448050958;20357.083931222835;20428.285010024578;20428.285010024578;20729.481762956046;8428.536430496382;8641.049484556694;8657.307415406753;8681.04508504064;8687.000994885542;7822.882656760153;7836;7902.565358905201;8068.354531637455;8082.797930051795;5707.172459993278;5831.970840145772;5843.5325173985975;5858.941410585925;5911.467967882825;1664.7586100015671;1684.7051765941158;1691.4080071974956;1699.5751062234442;1704.9659006819795;999.3454287441738;1017.2980643356061;1021.6832781837505;1036.5387402605768;1040.7814358984547;8611.354148438892;8617.655293788304;8757.956210218908;8783.604737786814;8826.602802873886;763.4045444553146;763.6334559411403;766.6320166320086;770.1605250277224;772.5982489105634;5560.304961879765;5562.360328562268;5859.267591551056;6308.337624549356;6342.016987366966;25012.87493562557;25034.248972530488;26024.609630855553;26222.606660900103;26467.735322646527;24920.750792492207;26238;26282.211533654023;26348.47303053928;26374.076907308536;12703.809442858364;12928.353582320846;13130.34348282582;13185.472581096841;13212.603621891358;9411.43531388119;9575.425474471554;9611.711648650551;9702.078302561527;9962.501874906371;21523.031463583862;21603.891980539996;22191;22226.222082227043;22349.441263968532;22107.557848843255;22361.888190558944;22619.208327708453;22918.427039323484;23045.423864403525;12855.29295888735;13016.414261358072;13080.476780928657;13086.08397412172;13086.214827110403;15452.690946180788;15767.369305228121;15797.763033554736;15830.683386331979;15861.682766344378;12675.619731408073;12712.491500339884;12793.680157996125;13017.479300827861;13273.800892986807;11942.761144777229;11964.58123965657;12142;12196;12384.256944583354;11034.117270618492;11247.66257012291;11260.7747845041;11373.14701397382;11388.943055285003;8602.827943441222;8655.134486551295;8666.220040196413;8761.693340733043;8790.824183516423;8638.35212359063;8690.652373905226;8695.913040869511;8706.738797836075;8812 04:19:44 INFO - PID 3220 | |4;prototype.html;538.1873371209474;548.1394211088592;548.3611592494747;576.4091805898953;580.1761498671885;6230.31466538681;6235.59468634539;6236.407541283571;6289.49684025278;6376.202974628171;6097;6204.968975155118;6224.221972253468;6232.220972378453;6238.220222472191;4997.151623574564;5056.671316364434;5059.595232381401;5071.543561079502;5081.2886195932415;4952.777125029383;5040.571551418134;5077.822276220333;5081.110805609003;5124.692518448905;5009.398872135349;5015.874603134915;5060.39275286966;5071.31537242473;5071.670341427795;5013.248012798073;5030.446650868402;5031.547160755549;5033.798648054073;5073.467285934998;4583.8166473341025;4632;4653.208954477747;4660.5106463821485;4682.2508398656055;6184.721687524072;6228.190335256433;6252.2809876864285;6268.341824108448;6270.905936410957;5866.237389139427;5903.49820265278;5966.850828729273;5988.161657367972;5995.790147344822;6723.865522689568;6740.93259067408;6753.088333075021;6767.526273160832;6768.357006084414;5138.794448222066;5141.460146684582;5155.072087024334;5158.226266060084;5172.948270517322;7039.612821294827;7052.858942821114;7082.964585177093;7086.574805511686;7123.109611298588;5274.709890955957;5326.307580014651;5329.413764485904;5332;5333.146696528537;5342.839714808562;5408.59435542328;5428.502888671255;5429.918551221735;5453.10023846061;5857.941420585739;5877.735501902339;5921.12825279739;5927.73325200367;5960.850978725566;6471.546991710535;6626.801195964129;6635.6350400728425;6753.49348798842;6781.118454600969;1737.956551086233;1844.2899483698604;1847.7320788485595;1853.7219417087274;1858.9163487643089;1306.6014865465934;1314.2180402660401;1329.4283458113105;1338.6987927716382;1352.3576301256824;6036.5170786336985;6141.170941922873;6154.261488621394;6157.168782214344;6165.2971001824035;6724.462043036546;6777.864442711217;6812.14848143982;6848.589084654936;6850.177978642595;6244.812655620339;6269;6287.402696743802;6301.558890877594;6371.39471750183;3554.9466757998653;3576.7496275260482;3579.6599323064265;3615.6745892869767;3658.2683463307444;6996.615186164708;7091.82270443243;7209.125627336825;7211.295764088467;7234.982067394619;6866.416354609914;6916.930830691729;6919.6540172991145;6997.300269972962;7054.788356349318;7038.824029399204;7062.223155452896;7110.146782386043;7122.394596459359;7123.893141602984;6588.5058620604605;6731.461483081243;6731.629760363227;6779.932200678128;6864.38220560152;6719.328067193242;6757.783598952039;6794.59232446035;6815.727370905108;6845.452363810784;6984.7206111757;7031.648417579203;7049.859002820018;7070.964645176741;7170.749023784142;5325;5329.467053294795;5346.438623944586;5347.919781203363;5378.489043540857;6661.400473957173;6822.249552549315;6897;6913.10129683138;6934.965325173342;6414.775482858077;6583.374579415139;6620.966895165686;6626.057495789997;6684.364985326386;6556.311587283267;6571.211454625475;6578.572392794453;6580.177477815273;6616.66916654175;6332.430081292706;6411.198600174978;6413.16628838248;6418.29398766126;6471.320511346241;6454.354564543508;6506.869862602627;6556.311587283267;6648.867022659617;6661.733530658719;6477.821804935884;6520.282768895323;6521.597921403129;6527.869442611026;6578.736850525926 04:19:44 INFO - PID 3220 | |5;yui.html;976.8974257702945;998.8263790046695;1023.4422239879265;1024.7335692719896;1027.0038063078812;21421;21833.563328733417;21855.344339669795;21864.23475178371;21868.23461178859;19690;20143.29498467554;20353.796462035374;20555.075021624027;20570.0743466544;1069.7699994501181;1089.4389389464432;1091.8635170603695;1092.3009274064605;1092.4865313302735;1052.6000119954444;1085.5332207150923;1085.696005118568;1087.7117563845586;1095.4194277033184;1151.222924525946;1158.519214525975;1158.768246350729;1164.3537836500739;1165.3357586175882;1146.8337091121823;1151.5393842462997;1152.0265375757472;1155.3068159104555;1157.2477889371933;845.0366582096415;849.5667209723024;851.5529347092764;853.6670698427619;854.6196942360652;21593.784062159335;22271.665925011137;22329.77670223293;22540;22808.65787013196;22603.208887688852;23259.534809303717;23855;23912.28263152108;24142.637860432107;16592.917035414746;16634;16642.50072497827;16712.997220166708;16727.247273872705;3827.8660246891504;3880.5149356330458;3900.4734360861203;3904.2777086238852;3904.882853514399;168570;171271;171788.99999999875;173965;174267;17184.91407542979;18004.189811458516;18289.634207316045;18290.54273643143;18323.81676183221;35120;35810.820945895626;35871.82064089715;35888.28223435517;35995.28009439797;9307.72076837696;9596.23230141587;9662.951685241529;9666.661666841768;9794.706158815246;4866.902661946741;4929.014197160583;4953.7523123844385;4960.776765045582;4963.305137280783;6054.51563874889;6081.543884208702;6118.479929206067;6168.938310616836;6178.969105154445;1161.2103769436865;1188.9108316876268;1203.1277323940249;1207.2696018908434;1208.0637505932796;738.593773424625;741.4068745003975;749.8950146979428;760.5930827007635;769.3037800790294;11880.40597970098;11911;12059.638210853689;12172.208806427554;12317.815232771516;692.840646651263;692.9549579277331;697.5779653309776;699.9440044796404;711.1040089487283;6064.332923378425;6127.662978536134;6181.350958149419;6217.502599792006;6217.937820621736;159121;162899;163186;163562;166697;139756.30121849326;146497;146789.53210467973;152225;154018;122778.12476578273;124700.37649811874;126569;132250;135257;13026.609201723963;13538.932305338803;13726.65683357924;14104.365303561159;14310.284485775877;57752.42247577639;59224.407755921886;59875;60641.393586063576;61664.38335616586;73817.63091184724;74054.62972685102;74124.62937685277;75978.6201068991;76339.23660763321;19417.611647767248;20077.196912123352;20248.59502809965;20489.795102049386;20506.17975280972;20606.381808545768;20862;20905.686414703487;21117.47206319793;21188.576228475653;20192.39422817318;20709.378718638465;20718.689219661417;20816.479588009814;21013.579728405042;18321.175547100145;18486.537836554195;18553.072346382898;18582.070896455392;18649;19436.61126777485;19501.804981950565;19508.414747557596;19571.412857614294;19633.11650975681;14842.332095055532;15124.848751512343;15225.16261605578;15333.463328783886;15369.615759606098;15086.54740357791;15139.394424222908;15200.847991519944;15426;15458.149801761012 04:19:44 INFO - PID 3220 | __end_tp_report 04:19:44 INFO - PID 3220 | __start_cc_report 04:19:44 INFO - PID 3220 | _x_x_mozilla_cycle_collect,268 04:19:44 INFO - PID 3220 | __end_cc_report 04:19:44 INFO - PID 3220 | __startTimestamp1506856784203__endTimestamp 04:19:44 INFO - PID 3220 | 04:19:44 INFO - PID 3220 | ------- Summary: start ------- 04:19:44 INFO - PID 3220 | Number of tests: 6 04:19:44 INFO - PID 3220 | 04:19:44 INFO - PID 3220 | [#0] dojo.html Cycles:165 Average:6248.32 Median:6451.90 stddev:749.11 (11.6%) stddev-sans-first:727.46 04:19:44 INFO - PID 3220 | Values: 3853.2 3862.1 3873.8 3879.9 3911.2 6099.5 6186.7 6207.3 6229.4 6282.2 6156.0 6172.6 6197.8 6211.6 6213.3 5511.5 5515.3 5577.9 5611.1 5618.8 5542.9 5605.1 5625.9 5641.4 5718.7 5463.7 5568.8 5597.3 5612.2 5730.2 5532.4 5601.5 5622.6 5629.7 5633.5 5544.6 5564.6 5572.9 5630.6 5644.4 6214.6 6234.4 6235.3 6245.7 6264.8 6800.4 6829.5 6834.6 6844.3 6852.8 6788.2 6815.5 6820.2 6888.9 6915.6 6195.1 6281.4 6285.9 6292.3 6413.3 7024.2 7047.5 7059.8 7126.2 7151.9 6635.1 6681.8 6736.3 6741.4 6814.5 6799.3 6845.8 6866.1 6873.5 6900.0 6711.4 6734.0 6796.6 6809.2 6812.8 6745.3 6749.3 6816.9 6826.9 6840.1 4920.3 4921.2 4922.4 5003.2 5078.9 4559.4 4561.0 4588.1 4596.6 4608.7 6182.0 6183.3 6191.1 6257.8 6276.5 6641.3 6731.5 6743.9 6807.8 6828.9 6245.0 6245.2 6248.3 6261.7 6270.7 5451.5 5452.5 5513.9 5526.8 5546.3 7025.8 7026.9 7097.7 7135.0 7138.0 6643.7 6758.8 6765.7 6837.3 6845.5 7031.3 7057.3 7137.9 7148.2 7148.3 6709.9 6758.5 6799.0 6817.5 6838.6 6714.1 6816.6 6826.9 6834.2 6835.7 6522.9 6524.6 6530.7 6607.3 6617.5 6473.9 6638.6 6658.7 6658.8 6660.5 6334.8 6384.0 6429.9 6451.9 6459.5 6614.5 6668.9 6689.7 6710.7 6717.1 6310.5 6362.4 6415.6 6442.7 6519.3 04:19:44 INFO - PID 3220 | 04:19:44 INFO - PID 3220 | [#1] ext.html Cycles:180 Average:43385.84 Median:38505.61 stddev:64101.94 (166.5%) stddev-sans-first:64202.59 04:19:44 INFO - PID 3220 | Values: 957.4 972.8 991.9 1017.5 1022.9 44003.3 44880.1 44891.8 44915.3 45099.3 47142.8 47838.5 47869.5 47880.3 47949.5 8598.7 8650.7 8712.0 8725.1 8726.4 8567.5 8650.9 8670.1 8710.1 8720.8 8728.4 8764.1 8787.1 8807.6 8815.8 8650.7 8689.0 8712.2 8715.9 8727.1 8579.8 8654.9 8655.5 8657.7 8659.0 41409.6 41490.0 41617.0 41646.6 41659.4 3823.1 3853.1 3854.5 3856.3 3860.7 33910.5 33944.5 34086.8 34155.0 34171.1 5365.5 5423.8 5429.7 5445.4 5624.9 208701.0 210041.0 210087.9 210151.0 210825.0 51326.2 51677.2 51737.5 51769.0 51951.5 60574.0 61429.7 61458.7 61496.4 61545.0 16344.1 17676.3 17809.6 17819.1 17867.3 13118.1 13191.0 13209.5 13223.3 13241.5 16360.9 16370.9 16505.2 16528.3 16531.2 5916.3 6178.0 6195.5 6230.7 6232.9 1093.6 1097.6 1111.5 1120.0 1122.7 26415.7 26460.5 26581.2 26589.6 26651.2 1221.0 1230.5 1236.9 1246.4 1248.0 13884.8 13984.4 14011.5 14045.0 14246.1 278293.0 279761.0 280309.0 280815.0 281799.0 52057.7 52984.5 58886.4 59575.7 60362.7 1554.8 1559.9 1566.0 1566.6 1574.5 30810.7 30878.5 31128.4 31313.5 31662.0 41907.6 42075.6 42102.4 42116.0 42330.4 243917.0 245628.0 245723.0 246393.0 246879.0 37056.4 38022.6 38488.0 38523.2 39034.0 47864.0 49505.8 49557.5 50012.5 50139.7 35442.6 35771.0 35836.6 36248.5 36703.0 35823.3 36110.5 36190.5 36201.6 36222.6 40323.4 42078.2 42103.2 42137.6 42422.6 34814.3 35202.3 35325.6 35635.3 35950.5 26037.6 26251.2 26306.0 26408.5 26852.6 04:19:44 INFO - PID 3220 | 04:19:44 INFO - PID 3220 | [#2] jquery.html Cycles:180 Average:39415.49 Median:22151.28 stddev:96948.83 (437.7%) stddev-sans-first:97177.02 04:19:44 INFO - PID 3220 | Values: 613.5 630.9 635.8 641.1 642.8 23755.8 24261.4 24398.8 25156.6 25256.1 21753.1 21840.7 21872.8 21980.5 22064.1 6331.9 6468.9 6506.3 6508.5 6512.0 6364.7 6435.5 6616.3 6692.6 6707.8 6617.9 6647.0 6653.8 6664.3 6688.5 6502.6 6675.5 6786.3 6799.3 6805.3 6335.5 6346.4 6369.1 6380.1 6393.3 31203.7 31427.4 31654.0 31685.0 31723.8 2284.6 2342.2 2364.4 2367.0 2372.0 19683.8 20565.2 20580.2 20581.3 20582.2 2616.3 2625.9 2670.7 2679.4 2682.4 139977.3 148002.3 156852.0 162708.0 163949.0 15616.8 16702.5 16796.6 16864.3 16997.5 26865.3 26943.3 26979.5 27006.9 27012.6 10105.5 10497.5 10533.9 10538.5 10551.6 9112.2 9253.0 9261.2 9265.1 9330.6 9937.0 10070.1 10141.8 10213.7 10272.2 2942.3 2978.3 3042.2 3049.8 3085.1 1060.2 1071.9 1080.3 1084.3 1098.2 21613.8 22097.6 22205.0 22236.7 22297.8 1101.4 1106.9 1118.3 1122.1 1123.4 11659.6 11994.3 12056.4 12072.8 12076.1 560647.0 570940.0 574534.0 583093.0 584054.0 136469.3 140354.0 140545.0 141395.0 143061.0 1224.9 1266.1 1272.5 1274.9 1275.7 18921.5 19036.5 19121.2 19464.5 19731.2 63013.1 65182.7 65630.0 66176.0 66346.3 79924.6 79998.6 81951.0 82471.6 83203.2 15489.8 15882.0 15913.6 15966.0 15997.7 23504.6 23762.4 23847.2 24094.9 24267.8 19606.4 19609.0 19736.3 19803.0 20114.2 17266.4 17507.6 17976.0 18067.2 18133.8 20226.1 20381.8 20396.7 20569.5 20643.8 15562.1 15644.5 15669.6 15682.5 15692.4 19111.0 19383.3 19549.8 19704.1 19709.2 04:19:44 INFO - PID 3220 | 04:19:44 INFO - PID 3220 | [#3] mootools.html Cycles:180 Average:10676.01 Median:2672.52 stddev:7986.09 (298.8%) stddev-sans-first:7978.39 04:19:44 INFO - PID 3220 | Values: 1446.0 1502.8 1506.4 1507.4 1521.7 16649.8 17311.3 17351.2 17362.9 17400.1 16705.8 16729.1 16817.0 16842.8 16851.2 2742.9 2778.3 2779.8 2786.0 2786.8 2580.9 2670.7 2674.3 2675.3 2676.9 2706.7 2777.9 2886.2 2907.7 2909.5 2836.5 2840.8 2841.8 2857.9 2871.9 2681.2 2707.3 2741.0 2855.7 2855.7 17226.7 17339.2 17366.7 17397.4 17410.7 8658.1 8873.8 8938.2 8941.2 8951.1 5151.8 5367.1 5400.5 5419.8 5500.1 2070.5 2095.5 2101.4 2129.5 2141.3 31061.2 31428.5 31506.0 31512.7 31603.2 7154.2 7291.5 7361.7 7425.1 7705.4 20127.6 20357.1 20428.3 20428.3 20729.5 8428.5 8641.0 8657.3 8681.0 8687.0 7822.9 7836.0 7902.6 8068.4 8082.8 5707.2 5832.0 5843.5 5858.9 5911.5 1664.8 1684.7 1691.4 1699.6 1705.0 999.3 1017.3 1021.7 1036.5 1040.8 8611.4 8617.7 8758.0 8783.6 8826.6 763.4 763.6 766.6 770.2 772.6 5560.3 5562.4 5859.3 6308.3 6342.0 25012.9 25034.2 26024.6 26222.6 26467.7 24920.8 26238.0 26282.2 26348.5 26374.1 12703.8 12928.4 13130.3 13185.5 13212.6 9411.4 9575.4 9611.7 9702.1 9962.5 21523.0 21603.9 22191.0 22226.2 22349.4 22107.6 22361.9 22619.2 22918.4 23045.4 12855.3 13016.4 13080.5 13086.1 13086.2 15452.7 15767.4 15797.8 15830.7 15861.7 12675.6 12712.5 12793.7 13017.5 13273.8 11942.8 11964.6 12142.0 12196.0 12384.3 11034.1 11247.7 11260.8 11373.1 11388.9 8602.8 8655.1 8666.2 8761.7 8790.8 8638.4 8690.7 8695.9 8706.7 8812.0 04:19:44 INFO - PID 3220 | 04:19:44 INFO - PID 3220 | [#4] prototype.html Cycles:180 Average:5692.88 Median:6248.55 stddev:1582.83 (25.3%) stddev-sans-first:1539.25 04:19:44 INFO - PID 3220 | Values: 538.2 548.1 548.4 576.4 580.2 6230.3 6235.6 6236.4 6289.5 6376.2 6097.0 6205.0 6224.2 6232.2 6238.2 4997.2 5056.7 5059.6 5071.5 5081.3 4952.8 5040.6 5077.8 5081.1 5124.7 5009.4 5015.9 5060.4 5071.3 5071.7 5013.2 5030.4 5031.5 5033.8 5073.5 4583.8 4632.0 4653.2 4660.5 4682.3 6184.7 6228.2 6252.3 6268.3 6270.9 5866.2 5903.5 5966.9 5988.2 5995.8 6723.9 6740.9 6753.1 6767.5 6768.4 5138.8 5141.5 5155.1 5158.2 5172.9 7039.6 7052.9 7083.0 7086.6 7123.1 5274.7 5326.3 5329.4 5332.0 5333.1 5342.8 5408.6 5428.5 5429.9 5453.1 5857.9 5877.7 5921.1 5927.7 5960.9 6471.5 6626.8 6635.6 6753.5 6781.1 1738.0 1844.3 1847.7 1853.7 1858.9 1306.6 1314.2 1329.4 1338.7 1352.4 6036.5 6141.2 6154.3 6157.2 6165.3 6724.5 6777.9 6812.1 6848.6 6850.2 6244.8 6269.0 6287.4 6301.6 6371.4 3554.9 3576.7 3579.7 3615.7 3658.3 6996.6 7091.8 7209.1 7211.3 7235.0 6866.4 6916.9 6919.7 6997.3 7054.8 7038.8 7062.2 7110.1 7122.4 7123.9 6588.5 6731.5 6731.6 6779.9 6864.4 6719.3 6757.8 6794.6 6815.7 6845.5 6984.7 7031.6 7049.9 7071.0 7170.7 5325.0 5329.5 5346.4 5347.9 5378.5 6661.4 6822.2 6897.0 6913.1 6935.0 6414.8 6583.4 6621.0 6626.1 6684.4 6556.3 6571.2 6578.6 6580.2 6616.7 6332.4 6411.2 6413.2 6418.3 6471.3 6454.4 6506.9 6556.3 6648.9 6661.7 6477.8 6520.3 6521.6 6527.9 6578.7 04:19:44 INFO - PID 3220 | 04:19:44 INFO - PID 3220 | [#5] yui.html Cycles:180 Average:30555.73 Median:20110.25 stddev:46365.38 (230.6%) stddev-sans-first:46442.25 04:19:44 INFO - PID 3220 | Values: 976.9 998.8 1023.4 1024.7 1027.0 21421.0 21833.6 21855.3 21864.2 21868.2 19690.0 20143.3 20353.8 20555.1 20570.1 1069.8 1089.4 1091.9 1092.3 1092.5 1052.6 1085.5 1085.7 1087.7 1095.4 1151.2 1158.5 1158.8 1164.4 1165.3 1146.8 1151.5 1152.0 1155.3 1157.2 845.0 849.6 851.6 853.7 854.6 21593.8 22271.7 22329.8 22540.0 22808.7 22603.2 23259.5 23855.0 23912.3 24142.6 16592.9 16634.0 16642.5 16713.0 16727.2 3827.9 3880.5 3900.5 3904.3 3904.9 168570.0 171271.0 171789.0 173965.0 174267.0 17184.9 18004.2 18289.6 18290.5 18323.8 35120.0 35810.8 35871.8 35888.3 35995.3 9307.7 9596.2 9663.0 9666.7 9794.7 4866.9 4929.0 4953.8 4960.8 4963.3 6054.5 6081.5 6118.5 6168.9 6179.0 1161.2 1188.9 1203.1 1207.3 1208.1 738.6 741.4 749.9 760.6 769.3 11880.4 11911.0 12059.6 12172.2 12317.8 692.8 693.0 697.6 699.9 711.1 6064.3 6127.7 6181.4 6217.5 6217.9 159121.0 162899.0 163186.0 163562.0 166697.0 139756.3 146497.0 146789.5 152225.0 154018.0 122778.1 124700.4 126569.0 132250.0 135257.0 13026.6 13538.9 13726.7 14104.4 14310.3 57752.4 59224.4 59875.0 60641.4 61664.4 73817.6 74054.6 74124.6 75978.6 76339.2 19417.6 20077.2 20248.6 20489.8 20506.2 20606.4 20862.0 20905.7 21117.5 21188.6 20192.4 20709.4 20718.7 20816.5 21013.6 18321.2 18486.5 18553.1 18582.1 18649.0 19436.6 19501.8 19508.4 19571.4 19633.1 14842.3 15124.8 15225.2 15333.5 15369.6 15086.5 15139.4 15200.8 15426.0 15458.1 04:19:44 INFO - PID 3220 | -------- Summary: end -------- 04:19:44 INFO - PID 3220 | 04:19:44 INFO - TEST-INFO | 3220: exit 0 04:19:44 INFO - TEST-OK | dromaeo_css | took 1108358ms 04:19:44 INFO - TEST-START | kraken 04:19:44 INFO - Initialising browser for kraken test... 04:19:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59063/getInfo.html -profile /tmp/tmp65WHVM/profile 04:19:45 INFO - TEST-INFO | started process 3581 (/builds/slave/test/build/application/firefox/firefox http://localhost:59063/getInfo.html) 04:19:50 INFO - TEST-INFO | 3581: exit 0 04:19:50 INFO - Browser initialized. 04:19:50 INFO - Running cycle 1/1 for kraken test... 04:19:50 INFO - Using env: {'DISPLAY': ':0', 04:19:50 INFO - 'HOME': '/home/cltbld', 04:19:50 INFO - 'JSGC_DISABLE_POISONING': '1', 04:19:50 INFO - 'LANG': 'en_US.UTF-8', 04:19:50 INFO - 'LANGUAGE': 'en_US:en', 04:19:50 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:19:50 INFO - 'LOGNAME': 'cltbld', 04:19:50 INFO - 'MAIL': '/var/mail/cltbld', 04:19:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:19:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:19:50 INFO - 'MOZ_CRASHREPORTER': '1', 04:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:50 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:19:50 INFO - 'MOZ_NO_REMOTE': '1', 04:19:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:50 INFO - 'NO_EM_RESTART': '1', 04:19:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:50 INFO - 'PWD': '/builds/slave/test', 04:19:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:19:50 INFO - 'RUST_BACKTRACE': 'full', 04:19:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:19:50 INFO - 'SHELL': '/bin/bash', 04:19:50 INFO - 'SHLVL': '1', 04:19:50 INFO - 'STYLO_FORCE_DISABLED': '1', 04:19:50 INFO - 'TERM': 'linux', 04:19:50 INFO - 'TMOUT': '86400', 04:19:50 INFO - 'USER': 'cltbld', 04:19:50 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733', 04:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:50 INFO - '_': '/tools/buildbot/bin/python'} 04:19:50 INFO - TEST-INFO | started process 3819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65WHVM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:51 INFO - PID 3819 | 04:19:51 INFO - PID 3819 | (/builds/slave/test/build/application/firefox/firefox:3870): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:19:51 INFO - PID 3819 | 04:20:01 INFO - PID 3819 | RSS: Main: 144695296 04:20:01 INFO - PID 3819 | 04:20:04 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59063/tests/kraken/driver.html?testName=audio-beat-detection) 04:20:05 INFO - PID 3819 | RSS: Main: 150962176 04:20:05 INFO - PID 3819 | 04:20:07 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59063/tests/kraken/driver.html?testName=audio-dft) 04:20:08 INFO - PID 3819 | RSS: Main: 151076864 04:20:08 INFO - PID 3819 | 04:20:11 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59063/tests/kraken/driver.html?testName=audio-fft) 04:20:11 INFO - PID 3819 | RSS: Main: 147353600 04:20:11 INFO - PID 3819 | 04:20:13 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59063/tests/kraken/driver.html?testName=audio-oscillator) 04:20:14 INFO - PID 3819 | RSS: Main: 148393984 04:20:14 INFO - PID 3819 | 04:20:16 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59063/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:20:16 INFO - PID 3819 | RSS: Main: 148619264 04:20:16 INFO - PID 3819 | 04:20:20 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59063/tests/kraken/driver.html?testName=imaging-darkroom) 04:20:20 INFO - PID 3819 | RSS: Main: 148738048 04:20:20 INFO - PID 3819 | 04:20:24 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59063/tests/kraken/driver.html?testName=imaging-desaturate) 04:20:24 INFO - PID 3819 | RSS: Main: 149909504 04:20:24 INFO - PID 3819 | 04:20:27 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59063/tests/kraken/driver.html?testName=json-parse-financial) 04:20:28 INFO - PID 3819 | RSS: Main: 151441408 04:20:28 INFO - PID 3819 | 04:20:29 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59063/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:20:30 INFO - PID 3819 | RSS: Main: 151552000 04:20:30 INFO - PID 3819 | 04:20:31 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59063/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:20:32 INFO - PID 3819 | RSS: Main: 151474176 04:20:32 INFO - PID 3819 | 04:20:34 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59063/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:20:35 INFO - PID 3819 | RSS: Main: 148344832 04:20:35 INFO - PID 3819 | 04:20:37 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:20:38 INFO - PID 3819 | RSS: Main: 148377600 04:20:38 INFO - PID 3819 | 04:20:40 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:20:41 INFO - PID 3819 | RSS: Main: 149458944 04:20:41 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:59063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59063/tests/kraken/driver.html?testName=ai-astar) 04:20:43 INFO - PID 3819 | RSS: Main: 150200320 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | __start_tp_report 04:20:43 INFO - PID 3819 | _x_x_mozilla_page_load 04:20:43 INFO - PID 3819 | _x_x_mozilla_page_load_details 04:20:43 INFO - PID 3819 | |i|pagename|runs| 04:20:43 INFO - PID 3819 | |0;ai-astar;106;107;106;105;105;110;101;107;106;107 04:20:43 INFO - PID 3819 | |1;audio-beat-detection;116;116;117;113;113;113;114;114;113;117 04:20:43 INFO - PID 3819 | |2;audio-dft;163;162;162;161;160;163;163;161;165;165 04:20:43 INFO - PID 3819 | |3;audio-fft;74;73;72;72;73;73;73;73;74;73 04:20:43 INFO - PID 3819 | |4;audio-oscillator;79;79;78;78;77;87;78;80;80;86 04:20:43 INFO - PID 3819 | |5;imaging-gaussian-blur;112;112;112;113;112;112;111;113;112;112 04:20:43 INFO - PID 3819 | |6;imaging-darkroom;149;151;151;149;150;150;149;150;149;150 04:20:43 INFO - PID 3819 | |7;imaging-desaturate;94;95;94;95;94;94;94;95;95;94 04:20:43 INFO - PID 3819 | |8;json-parse-financial;44;45;45;44;45;45;44;52;45;46 04:20:43 INFO - PID 3819 | |9;json-stringify-tinderbox;36;36;37;38;36;36;36;35;36;36 04:20:43 INFO - PID 3819 | |10;stanford-crypto-aes;73;73;71;73;73;76;72;79;74;75 04:20:43 INFO - PID 3819 | |11;stanford-crypto-ccm;101;104;106;113;108;113;104;102;106;103 04:20:43 INFO - PID 3819 | |12;stanford-crypto-pbkdf2;147;146;159;146;148;143;150;150;148;147 04:20:43 INFO - PID 3819 | |13;stanford-crypto-sha256-iterative;71;64;57;57;58;59;59;66;57;58 04:20:43 INFO - PID 3819 | __end_tp_report 04:20:43 INFO - PID 3819 | __start_cc_report 04:20:43 INFO - PID 3819 | _x_x_mozilla_cycle_collect,705 04:20:43 INFO - PID 3819 | __end_cc_report 04:20:43 INFO - PID 3819 | __startTimestamp1506856843451__endTimestamp 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | ------- Summary: start ------- 04:20:43 INFO - PID 3819 | Number of tests: 14 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#0] ai-astar Cycles:10 Average:106.00 Median:106.50 stddev:2.26 (2.1%) stddev-sans-first:2.40 04:20:43 INFO - PID 3819 | Values: 106.0 107.0 106.0 105.0 105.0 110.0 101.0 107.0 106.0 107.0 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#1] audio-beat-detection Cycles:10 Average:114.60 Median:115.00 stddev:1.71 (1.5%) stddev-sans-first:1.74 04:20:43 INFO - PID 3819 | Values: 116.0 116.0 117.0 113.0 113.0 113.0 114.0 114.0 113.0 117.0 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 04:20:43 INFO - PID 3819 | Values: 163.0 162.0 162.0 161.0 160.0 163.0 163.0 161.0 165.0 165.0 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#3] audio-fft Cycles:10 Average:73.00 Median:73.00 stddev:0.67 (0.9%) stddev-sans-first:0.60 04:20:43 INFO - PID 3819 | Values: 74.0 73.0 72.0 72.0 73.0 73.0 73.0 73.0 74.0 73.0 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:79.50 stddev:3.46 (4.3%) stddev-sans-first:3.64 04:20:43 INFO - PID 3819 | Values: 79.0 79.0 78.0 78.0 77.0 87.0 78.0 80.0 80.0 86.0 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#5] imaging-gaussian-blur Cycles:10 Average:112.10 Median:112.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:20:43 INFO - PID 3819 | Values: 112.0 112.0 112.0 113.0 112.0 112.0 111.0 113.0 112.0 112.0 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 04:20:43 INFO - PID 3819 | Values: 149.0 151.0 151.0 149.0 150.0 150.0 149.0 150.0 149.0 150.0 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:20:43 INFO - PID 3819 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#8] json-parse-financial Cycles:10 Average:45.50 Median:45.00 stddev:2.37 (5.3%) stddev-sans-first:2.45 04:20:43 INFO - PID 3819 | Values: 44.0 45.0 45.0 44.0 45.0 45.0 44.0 52.0 45.0 46.0 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#9] json-stringify-tinderbox Cycles:10 Average:36.20 Median:36.00 stddev:0.79 (2.2%) stddev-sans-first:0.83 04:20:43 INFO - PID 3819 | Values: 36.0 36.0 37.0 38.0 36.0 36.0 36.0 35.0 36.0 36.0 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.50 stddev:2.28 (3.1%) stddev-sans-first:2.40 04:20:43 INFO - PID 3819 | Values: 73.0 73.0 71.0 73.0 73.0 76.0 72.0 79.0 74.0 75.0 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#11] stanford-crypto-ccm Cycles:10 Average:106.00 Median:106.00 stddev:4.22 (4.0%) stddev-sans-first:4.07 04:20:43 INFO - PID 3819 | Values: 101.0 104.0 106.0 113.0 108.0 113.0 104.0 102.0 106.0 103.0 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:148.00 stddev:4.25 (2.9%) stddev-sans-first:4.48 04:20:43 INFO - PID 3819 | Values: 147.0 146.0 159.0 146.0 148.0 143.0 150.0 150.0 148.0 147.0 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:59.00 stddev:4.79 (8.1%) stddev-sans-first:3.28 04:20:43 INFO - PID 3819 | Values: 71.0 64.0 57.0 57.0 58.0 59.0 59.0 66.0 57.0 58.0 04:20:43 INFO - PID 3819 | -------- Summary: end -------- 04:20:43 INFO - PID 3819 | 04:20:43 INFO - PID 3819 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:20:44 INFO - TEST-INFO | 3819: exit 0 04:20:44 INFO - TEST-OK | kraken | took 59316ms 04:20:44 INFO - SUITE-END | took 1167s 04:20:44 INFO - Completed test suite (00:19:27) 04:20:44 INFO - javascript benchmark 04:20:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9237.089543503203, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3853.2293541291738, 3862.1117143057095, 3873.7675739455626, 3879.941800872986, 3911.217756448709, 6099.481544068748, 6186.721597528111, 6207.255129384469, 6229.408206220413, 6282.183316168897, 6156.0, 6172.598781079238, 6197.783077592285, 6211.565190436671, 6213.34759850216, 5511.5039646431815, 5515.255440515539, 5577.944220557783, 5611.102223644218, 5618.803341883015, 5542.944570554303, 5605.075162598187, 5625.915611265835, 5641.407652196522, 5718.7426565804435, 5463.699496527689, 5568.777248910039, 5597.328320601534, 5612.186232996233, 5730.226419433365, 5532.3637781655225, 5601.467860553241, 5622.606417550773, 5629.746661400206, 5633.549316054706, 5544.6118771686, 5564.610477266593, 5572.888542229173, 5630.605857589971, 5644.4073372295725, 6214.596051256699, 6234.438900498977, 6235.314115447297, 6245.718942647592, 6264.7807326743805, 6800.387965083166, 6829.521933464659, 6834.624095674736, 6844.349786770249, 6852.760153394607, 6788.151481064867, 6815.454763618898, 6820.215675197366, 6888.862222755567, 6915.619640919747, 6195.132681424604, 6281.434670879597, 6285.8742825143245, 6292.339304373067, 6413.29453760086, 7024.192217894905, 7047.54190977595, 7059.8235044123285, 7126.2161162272105, 7151.928480715126, 6635.137432133888, 6681.832954176088, 6736.292689267556, 6741.3932746052105, 6814.48891333152, 6799.286074962157, 6845.794626161223, 6866.141732283465, 6873.450123990069, 6900.03399524067, 6711.395974362234, 6734.0, 6796.626185559841, 6809.216940051859, 6812.795616131524, 6745.291744366869, 6749.291324410964, 6816.931830681629, 6826.931730682729, 6840.144981877265, 4920.3111564381015, 4921.237208232729, 4922.433920099163, 5003.224500202475, 5078.949210507848, 4559.407277054028, 4561.0, 4588.082383523309, 4596.563326483979, 4608.654350923694, 6182.010878259457, 6183.319834818167, 6191.102290167901, 6257.812265632038, 6276.497880169575, 6641.335866413417, 6731.49513786468, 6743.9325606743305, 6807.761728339485, 6828.931710682829, 6245.0320200368105, 6245.156903818017, 6248.28144763349, 6261.655608941552, 6270.655113968775, 5451.48210919962, 5452.454754524595, 5513.9448605514235, 5526.834194974157, 5546.306711661043, 7025.789226323219, 7026.859462810818, 7097.7160913562875, 7134.964325178445, 7138.0, 6643.701033453506, 6758.763443279461, 6765.661716914233, 6837.2820853809635, 6845.4865885057825, 7031.261717519586, 7057.258987806206, 7137.857242855218, 7148.249433809375, 7148.28517148281, 6709.93290067093, 6758.459323254227, 6799.0, 6817.522773405814, 6838.623875686885, 6714.093597364294, 6816.591004539743, 6826.931730682828, 6834.2482326943, 6835.658217089026, 6522.902156467562, 6524.5759025665075, 6530.706118224596, 6607.3062328456745, 6617.503687223381, 6473.8705225896165, 6638.634875081917, 6658.7336506539195, 6658.83352916181, 6660.500462465237, 6334.841628959313, 6384.042393640991, 6429.903551446639, 6451.903221451776, 6459.483241340776, 6614.503912206507, 6668.866622667617, 6689.665516724047, 6710.731570737116, 6717.1267735194115, 6310.5267104968225, 6362.363763623601, 6415.58298710601, 6442.710078046593, 6519.315471875385], "value": 6197.435052956726, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [957.4446820843912, 972.8346181149204, 991.880974283086, 1017.5217647705575, 1022.9028242316978, 44003.339949900736, 44880.102397952105, 44891.775541122246, 44915.326270105936, 45099.32351014733, 47142.76428617852, 47838.521614783844, 47869.52130478694, 47880.28179577309, 47949.52050479494, 8598.699045533407, 8650.697225597105, 8712.0416754157, 8725.083866194022, 8726.432781869158, 8567.528785916773, 8650.870236946419, 8670.13298670131, 8710.12898710127, 8720.781980450507, 8728.432651877607, 8764.079771623983, 8787.077356877531, 8807.64769409226, 8815.77960550985, 8650.697225597138, 8688.956555217215, 8712.215900568915, 8715.869261961076, 8727.127287271254, 8579.785505362353, 8654.87017694735, 8655.523946182957, 8657.740267791976, 8658.956705216433, 41409.58590414088, 41490.0, 41617.0, 41646.58353416457, 41659.37510937338, 3823.1206822430718, 3853.075261937115, 3854.5181852268465, 3856.3444214483607, 3860.7297489175767, 33910.49134262988, 33944.49083263728, 34086.82956585226, 34154.975350739514, 34171.14572135716, 5365.517103460668, 5423.810166644188, 5429.701366424845, 5445.428230035829, 5624.943750562483, 208701.0, 210041.0, 210087.94956025275, 210151.0, 210825.0, 51326.23010654843, 51677.22484162741, 51737.482625174016, 51769.0, 51951.48048519542, 60574.0, 61429.69285153635, 61458.69270653618, 61496.38503614996, 61545.0, 16344.101074440781, 17676.292948281924, 17809.643807123786, 17819.10904454772, 17867.28530858751, 13118.147320424141, 13191.0, 13209.471621135239, 13223.272720000492, 13241.536546220836, 16360.918195408947, 16370.918145409434, 16505.17474126289, 16528.25622846975, 16531.173441327886, 5916.349201587822, 6178.0, 6195.473384762256, 6230.6573138476915, 6232.875342493125, 1093.6117678224116, 1097.6377795327683, 1111.5498223219608, 1119.994400028011, 1122.663201039701, 26415.735842641712, 26460.470790584466, 26581.202563923114, 26589.601155982677, 26651.200463985722, 1220.9694757630953, 1230.4585982167816, 1236.8763123687738, 1246.389269258075, 1248.0078337721534, 13884.791728123884, 13984.370703318375, 14011.509597164051, 14045.01684882069, 14246.074005189837, 278293.0, 279761.0, 280309.0, 280815.0, 281799.0, 52057.7397113012, 52984.47015529795, 58886.41113588895, 59575.70212148998, 60362.69818650879, 1554.7512398016263, 1559.8830087743238, 1566.0290619815787, 1566.5691934717815, 1574.5355120239558, 30810.665230272625, 30878.53682194724, 31128.377432451678, 31313.53029704511, 31662.0, 41907.580924191585, 42075.57924420839, 42102.36846447244, 42116.0, 42330.36504452497, 243917.0, 245628.0, 245723.0, 246393.0, 246879.0, 37056.44415333826, 38022.61977380191, 38488.0, 38523.22953540857, 39034.0, 47864.0, 49505.752471237414, 49557.50442495673, 50012.49987500079, 50139.74930125326, 35442.64557354394, 35771.0, 35836.64163358333, 36248.456273155396, 36703.0, 35823.28353432969, 36110.45834312435, 36190.4571431434, 36201.637983619825, 36222.63777362193, 40323.3951490722, 42078.158436831705, 42103.15793684171, 42137.57862421337, 42422.575774241865, 34814.303713926085, 35202.29595408026, 35325.646743532234, 35635.28729425345, 35950.46074308835, 26037.6094358581, 26251.162418630513, 26306.0, 26408.471830562896, 26852.59721104146], "value": 19303.738144575385, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.5398451161628, 630.9085282461342, 635.8473966248096, 641.1184621145925, 642.8457170279135, 23755.75657484421, 24261.39346516338, 24398.75601243987, 25156.622650660232, 25256.11603593872, 21753.12987480499, 21840.672389914165, 21872.781272187272, 21980.450488737788, 22064.117435302607, 6331.905021424683, 6468.902966455507, 6506.251781045169, 6508.479321654257, 6512.023196520512, 6364.745410183587, 6435.549511534195, 6616.305287944769, 6692.564983276072, 6707.798766037003, 6617.867642647144, 6646.9667651661675, 6653.767118150866, 6664.300248473914, 6688.498362622799, 6502.577332473397, 6675.532712710088, 6786.253512113663, 6799.252082270947, 6805.251422343538, 6335.461485773715, 6346.42882140605, 6369.076483909807, 6380.106785050097, 6393.264774550893, 31203.687963120534, 31427.37145257082, 31654.0, 31685.0, 31723.84138079318, 2284.6001949658744, 2342.1802369170823, 2364.408897775556, 2367.0413482539598, 2372.027468737809, 19683.803161968484, 20565.177392904265, 20580.176792928265, 20581.279655212147, 20582.176712931614, 2616.2674451153707, 2625.934351641205, 2670.7462791034823, 2679.3837417394107, 2682.383051898055, 139977.3001134998, 148002.25998869937, 156852.0, 162708.0, 163949.0, 15616.843831561766, 16702.49892503227, 16796.58008549796, 16864.32542698303, 16997.49007529776, 26865.328366790985, 26943.326416839343, 26979.460410791675, 27006.864965675046, 27012.594811077848, 10105.545250463747, 10497.475126243657, 10533.9473302633, 10538.473076346152, 10551.577936882439, 9112.179903808688, 9253.0, 9261.212796912203, 9265.073492650681, 9330.58012389444, 9936.950315248378, 10070.07267165806, 10141.797164056825, 10213.693589192337, 10272.229582781321, 2942.264433891527, 2978.27032377069, 3042.239440139965, 3049.8322592257196, 3085.105319457377, 1060.1783617696192, 1071.8660167479065, 1080.3140006096185, 1084.2572837606265, 1098.23123813331, 21613.783862161177, 22097.563658362156, 22205.0, 22236.666450003264, 22297.777022229893, 1101.3502033799937, 1106.9059129974041, 1118.2675347647305, 1122.057471723756, 1123.3596849795701, 11659.591914282959, 11994.340311282964, 12056.397180140957, 12072.818907716392, 12076.094292928066, 560647.0, 570940.0, 574534.0, 583093.0, 584054.0, 136469.31765341308, 140354.0, 140545.0, 141395.0, 143061.0, 1224.9203801752858, 1266.094742259289, 1272.5291642092484, 1274.859765425784, 1275.661949583361, 18921.526961826065, 19036.524086897938, 19121.202302918857, 19464.513387165433, 19731.210751569775, 63013.05480417889, 65182.67408662926, 65630.0, 66176.0, 66346.33653663401, 79924.60037700007, 79998.6000069996, 81951.0, 82471.58764206141, 83203.16796831954, 15489.84510154884, 15882.0, 15913.602159946095, 15966.042037477788, 15997.680046398775, 23504.6474302889, 23762.40593985095, 23847.165349212693, 24094.87952560226, 24267.757322427256, 19606.411807645793, 19609.0, 19736.30922917691, 19803.0, 20114.19543218255, 17266.395676151275, 17507.649847002733, 17976.0, 18067.18697658635, 18133.818661813213, 20226.089825958163, 20381.79618203799, 20396.694049589565, 20569.48576285605, 20643.793562064788, 15562.066276023475, 15644.530664080095, 15669.608259793597, 15682.529524114294, 15692.372305107669, 19111.0, 19383.321583744502, 19549.804501954797, 19704.11331490115, 19709.211631535152], "value": 12889.261004496999, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.0, 1502.8046353973982, 1506.4275575281392, 1507.4045751927995, 1521.7489114296138, 16649.833501664994, 17311.307547698092, 17351.21919513622, 17362.91318543407, 17400.129993500337, 16705.83294167058, 16729.07990060549, 16817.0, 16842.83157168428, 16851.157442127875, 2742.931426714333, 2778.305423644089, 2779.791515636325, 2786.0248912880534, 2786.8049236553447, 2580.8838602262945, 2670.7195744446844, 2674.318048897538, 2675.291047872315, 2676.933076673079, 2706.688730795954, 2777.9444411111867, 2886.163012726307, 2907.7092290770966, 2909.534474484083, 2836.5177919753487, 2840.7585355244623, 2841.786865985049, 2857.8571071446345, 2871.870765815543, 2681.1554360376417, 2707.3367025078783, 2740.9588856167175, 2855.6715977662625, 2855.700151484106, 17226.655466890592, 17339.21973511195, 17366.65266694659, 17397.39109131187, 17410.651786964318, 8658.134186581354, 8873.778155546099, 8938.1508756668, 8941.195292423648, 8951.14964078418, 5151.819686310999, 5367.114426119686, 5400.459954004607, 5419.756110975016, 5500.064988951848, 2070.492729281336, 2095.5389814240843, 2101.443117573844, 2129.4782778219283, 2141.2719675310314, 31061.22346941322, 31428.528572071667, 31506.0, 31512.684873151433, 31603.20991975196, 7154.248803875518, 7291.4531410144455, 7361.705531778776, 7425.108986921604, 7705.383569314441, 20127.597448050958, 20357.083931222835, 20428.285010024578, 20428.285010024578, 20729.481762956046, 8428.536430496382, 8641.049484556694, 8657.307415406753, 8681.04508504064, 8687.000994885542, 7822.882656760153, 7836.0, 7902.565358905201, 8068.354531637455, 8082.797930051795, 5707.172459993278, 5831.970840145772, 5843.5325173985975, 5858.941410585925, 5911.467967882825, 1664.7586100015671, 1684.7051765941158, 1691.4080071974956, 1699.5751062234442, 1704.9659006819795, 999.3454287441738, 1017.2980643356061, 1021.6832781837505, 1036.5387402605768, 1040.7814358984547, 8611.354148438892, 8617.655293788304, 8757.956210218908, 8783.604737786814, 8826.602802873886, 763.4045444553146, 763.6334559411403, 766.6320166320086, 770.1605250277224, 772.5982489105634, 5560.304961879765, 5562.360328562268, 5859.267591551056, 6308.337624549356, 6342.016987366966, 25012.87493562557, 25034.248972530488, 26024.609630855553, 26222.606660900103, 26467.735322646527, 24920.750792492207, 26238.0, 26282.211533654023, 26348.47303053928, 26374.076907308536, 12703.809442858364, 12928.353582320846, 13130.34348282582, 13185.472581096841, 13212.603621891358, 9411.43531388119, 9575.425474471554, 9611.711648650551, 9702.078302561527, 9962.501874906371, 21523.031463583862, 21603.891980539996, 22191.0, 22226.222082227043, 22349.441263968532, 22107.557848843255, 22361.888190558944, 22619.208327708453, 22918.427039323484, 23045.423864403525, 12855.29295888735, 13016.414261358072, 13080.476780928657, 13086.08397412172, 13086.214827110403, 15452.690946180788, 15767.369305228121, 15797.763033554736, 15830.683386331979, 15861.682766344378, 12675.619731408073, 12712.491500339884, 12793.680157996125, 13017.479300827861, 13273.800892986807, 11942.761144777229, 11964.58123965657, 12142.0, 12196.0, 12384.256944583354, 11034.117270618492, 11247.66257012291, 11260.7747845041, 11373.14701397382, 11388.943055285003, 8602.827943441222, 8655.134486551295, 8666.220040196413, 8761.693340733043, 8790.824183516423, 8638.35212359063, 8690.652373905226, 8695.913040869511, 8706.738797836075, 8812.0], "value": 7388.25380849982, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.1873371209474, 548.1394211088592, 548.3611592494747, 576.4091805898953, 580.1761498671885, 6230.31466538681, 6235.59468634539, 6236.407541283571, 6289.49684025278, 6376.202974628171, 6097.0, 6204.968975155118, 6224.221972253468, 6232.220972378453, 6238.220222472191, 4997.151623574564, 5056.671316364434, 5059.595232381401, 5071.543561079502, 5081.2886195932415, 4952.777125029383, 5040.571551418134, 5077.822276220333, 5081.110805609003, 5124.692518448905, 5009.398872135349, 5015.874603134915, 5060.39275286966, 5071.31537242473, 5071.670341427795, 5013.248012798073, 5030.446650868402, 5031.547160755549, 5033.798648054073, 5073.467285934998, 4583.8166473341025, 4632.0, 4653.208954477747, 4660.5106463821485, 4682.2508398656055, 6184.721687524072, 6228.190335256433, 6252.2809876864285, 6268.341824108448, 6270.905936410957, 5866.237389139427, 5903.49820265278, 5966.850828729273, 5988.161657367972, 5995.790147344822, 6723.865522689568, 6740.93259067408, 6753.088333075021, 6767.526273160832, 6768.357006084414, 5138.794448222066, 5141.460146684582, 5155.072087024334, 5158.226266060084, 5172.948270517322, 7039.612821294827, 7052.858942821114, 7082.964585177093, 7086.574805511686, 7123.109611298588, 5274.709890955957, 5326.307580014651, 5329.413764485904, 5332.0, 5333.146696528537, 5342.839714808562, 5408.59435542328, 5428.502888671255, 5429.918551221735, 5453.10023846061, 5857.941420585739, 5877.735501902339, 5921.12825279739, 5927.73325200367, 5960.850978725566, 6471.546991710535, 6626.801195964129, 6635.6350400728425, 6753.49348798842, 6781.118454600969, 1737.956551086233, 1844.2899483698604, 1847.7320788485595, 1853.7219417087274, 1858.9163487643089, 1306.6014865465934, 1314.2180402660401, 1329.4283458113105, 1338.6987927716382, 1352.3576301256824, 6036.5170786336985, 6141.170941922873, 6154.261488621394, 6157.168782214344, 6165.2971001824035, 6724.462043036546, 6777.864442711217, 6812.14848143982, 6848.589084654936, 6850.177978642595, 6244.812655620339, 6269.0, 6287.402696743802, 6301.558890877594, 6371.39471750183, 3554.9466757998653, 3576.7496275260482, 3579.6599323064265, 3615.6745892869767, 3658.2683463307444, 6996.615186164708, 7091.82270443243, 7209.125627336825, 7211.295764088467, 7234.982067394619, 6866.416354609914, 6916.930830691729, 6919.6540172991145, 6997.300269972962, 7054.788356349318, 7038.824029399204, 7062.223155452896, 7110.146782386043, 7122.394596459359, 7123.893141602984, 6588.5058620604605, 6731.461483081243, 6731.629760363227, 6779.932200678128, 6864.38220560152, 6719.328067193242, 6757.783598952039, 6794.59232446035, 6815.727370905108, 6845.452363810784, 6984.7206111757, 7031.648417579203, 7049.859002820018, 7070.964645176741, 7170.749023784142, 5325.0, 5329.467053294795, 5346.438623944586, 5347.919781203363, 5378.489043540857, 6661.400473957173, 6822.249552549315, 6897.0, 6913.10129683138, 6934.965325173342, 6414.775482858077, 6583.374579415139, 6620.966895165686, 6626.057495789997, 6684.364985326386, 6556.311587283267, 6571.211454625475, 6578.572392794453, 6580.177477815273, 6616.66916654175, 6332.430081292706, 6411.198600174978, 6413.16628838248, 6418.29398766126, 6471.320511346241, 6454.354564543508, 6506.869862602627, 6556.311587283267, 6648.867022659617, 6661.733530658719, 6477.821804935884, 6520.282768895323, 6521.597921403129, 6527.869442611026, 6578.736850525926], "value": 5236.9048481657555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [976.8974257702945, 998.8263790046695, 1023.4422239879265, 1024.7335692719896, 1027.0038063078812, 21421.0, 21833.563328733417, 21855.344339669795, 21864.23475178371, 21868.23461178859, 19690.0, 20143.29498467554, 20353.796462035374, 20555.075021624027, 20570.0743466544, 1069.7699994501181, 1089.4389389464432, 1091.8635170603695, 1092.3009274064605, 1092.4865313302735, 1052.6000119954444, 1085.5332207150923, 1085.696005118568, 1087.7117563845586, 1095.4194277033184, 1151.222924525946, 1158.519214525975, 1158.768246350729, 1164.3537836500739, 1165.3357586175882, 1146.8337091121823, 1151.5393842462997, 1152.0265375757472, 1155.3068159104555, 1157.2477889371933, 845.0366582096415, 849.5667209723024, 851.5529347092764, 853.6670698427619, 854.6196942360652, 21593.784062159335, 22271.665925011137, 22329.77670223293, 22540.0, 22808.65787013196, 22603.208887688852, 23259.534809303717, 23855.0, 23912.28263152108, 24142.637860432107, 16592.917035414746, 16634.0, 16642.50072497827, 16712.997220166708, 16727.247273872705, 3827.8660246891504, 3880.5149356330458, 3900.4734360861203, 3904.2777086238852, 3904.882853514399, 168570.0, 171271.0, 171788.99999999875, 173965.0, 174267.0, 17184.91407542979, 18004.189811458516, 18289.634207316045, 18290.54273643143, 18323.81676183221, 35120.0, 35810.820945895626, 35871.82064089715, 35888.28223435517, 35995.28009439797, 9307.72076837696, 9596.23230141587, 9662.951685241529, 9666.661666841768, 9794.706158815246, 4866.902661946741, 4929.014197160583, 4953.7523123844385, 4960.776765045582, 4963.305137280783, 6054.51563874889, 6081.543884208702, 6118.479929206067, 6168.938310616836, 6178.969105154445, 1161.2103769436865, 1188.9108316876268, 1203.1277323940249, 1207.2696018908434, 1208.0637505932796, 738.593773424625, 741.4068745003975, 749.8950146979428, 760.5930827007635, 769.3037800790294, 11880.40597970098, 11911.0, 12059.638210853689, 12172.208806427554, 12317.815232771516, 692.840646651263, 692.9549579277331, 697.5779653309776, 699.9440044796404, 711.1040089487283, 6064.332923378425, 6127.662978536134, 6181.350958149419, 6217.502599792006, 6217.937820621736, 159121.0, 162899.0, 163186.0, 163562.0, 166697.0, 139756.30121849326, 146497.0, 146789.53210467973, 152225.0, 154018.0, 122778.12476578273, 124700.37649811874, 126569.0, 132250.0, 135257.0, 13026.609201723963, 13538.932305338803, 13726.65683357924, 14104.365303561159, 14310.284485775877, 57752.42247577639, 59224.407755921886, 59875.0, 60641.393586063576, 61664.38335616586, 73817.63091184724, 74054.62972685102, 74124.62937685277, 75978.6201068991, 76339.23660763321, 19417.611647767248, 20077.196912123352, 20248.59502809965, 20489.795102049386, 20506.17975280972, 20606.381808545768, 20862.0, 20905.686414703487, 21117.47206319793, 21188.576228475653, 20192.39422817318, 20709.378718638465, 20718.689219661417, 20816.479588009814, 21013.579728405042, 18321.175547100145, 18486.537836554195, 18553.072346382898, 18582.070896455392, 18649.0, 19436.61126777485, 19501.804981950565, 19508.414747557596, 19571.412857614294, 19633.11650975681, 14842.332095055532, 15124.848751512343, 15225.16261605578, 15333.463328783886, 15369.615759606098, 15086.54740357791, 15139.394424222908, 15200.847991519944, 15426.0, 15458.149801761012], "value": 10410.83158901272, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1363.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 107.0, 106.0, 105.0, 105.0, 110.0, 101.0, 107.0, 106.0, 107.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 117.0], "value": 114.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 160.0, 163.0, 163.0, 161.0, 165.0, 165.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 72.0, 73.0, 73.0, 73.0, 73.0, 74.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 77.0, 87.0, 78.0, 80.0, 80.0, 86.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 112.0, 113.0, 112.0, 112.0, 111.0, 113.0, 112.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 151.0, 149.0, 150.0, 150.0, 149.0, 150.0, 149.0, 150.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 45.0, 44.0, 45.0, 45.0, 44.0, 52.0, 45.0, 46.0], "value": 45.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 37.0, 38.0, 36.0, 36.0, 36.0, 35.0, 36.0, 36.0], "value": 36.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 71.0, 73.0, 73.0, 76.0, 72.0, 79.0, 74.0, 75.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 104.0, 106.0, 113.0, 108.0, 113.0, 104.0, 102.0, 106.0, 103.0], "value": 106.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 159.0, 146.0, 148.0, 143.0, 150.0, 150.0, 148.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 64.0, 57.0, 57.0, 58.0, 59.0, 59.0, 66.0, 57.0, 58.0], "value": 60.6, "unit": "score"}]}]} 04:20:44 INFO - Return code: 0 04:20:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:20:44 INFO - # TBPL SUCCESS # 04:20:44 INFO - Running post-action listener: _package_coverage_data 04:20:44 INFO - Running post-action listener: _resource_record_post_action 04:20:44 INFO - [mozharness: 2017-10-01 11:20:44.742036Z] Finished run-tests step (success) 04:20:44 INFO - Running post-run listener: _resource_record_post_run 04:20:44 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 339857408; Read time: 16; Write time: 390132 04:20:44 INFO - TinderboxPrint: CPU usage
13.1% 04:20:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:20:44 INFO - TinderboxPrint: I/O write bytes / time
339,857,408 / 390,132 04:20:44 INFO - TinderboxPrint: CPU idle
8,217.4 (86.9%) 04:20:44 INFO - TinderboxPrint: CPU user
1,187.5 (12.6%) 04:20:44 INFO - TinderboxPrint: Swap in / out
0 / 0 04:20:44 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12582912; Read time: 0; Write time: 4104 04:20:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:20:44 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326660096; Read time: 16; Write time: 386024 04:20:45 INFO - Running post-run listener: _upload_blobber_files 04:20:45 INFO - Blob upload gear active. 04:20:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:20:45 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 04:20:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:20:45 INFO - (blobuploader) - INFO - Open directory for files ... 04:20:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:20:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:20:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:52 INFO - (blobuploader) - INFO - Done attempting. 04:20:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:20:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:20:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:53 INFO - (blobuploader) - INFO - Done attempting. 04:20:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:20:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:20:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:54 INFO - (blobuploader) - INFO - Done attempting. 04:20:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:20:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:20:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:55 INFO - (blobuploader) - INFO - Done attempting. 04:20:55 INFO - (blobuploader) - INFO - Iteration through files over. 04:20:55 INFO - Return code: 0 04:20:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:20:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:20:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/005d8d8742fe8f65161fcc20829b3ea137c7f98e4fab1c80850680befb169cd033fe53f2589cfc8bc8ca8009bb47f2ffb3c67a0a3f348819d36666ecc1d49e33", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f04087c28a42680e234665fa4aa103425d552edb7283eae7741b09819a3701d1bb2d23ff8ff4167fb6455ea2cbb47b6dd04b380266fbc5275cca99a7fa0c0ed", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff0103b6efa580c3161e493649ff749233894e953174b12bbb8fc1929d27cf2c38e8d45949b029dc247e74e48531c0bd5e085d45381b7cebf3b717027a3f3e68", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14adaf2baddce9dfa39062baf497fcfc4d35a77a52bd1eaaac12f417bdeb3e54df4c05ed6f4f35340a02b60faae51e9660beec25efae07e963ce11cf20843414"} 04:20:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:20:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:20:55 INFO - Contents: 04:20:55 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/005d8d8742fe8f65161fcc20829b3ea137c7f98e4fab1c80850680befb169cd033fe53f2589cfc8bc8ca8009bb47f2ffb3c67a0a3f348819d36666ecc1d49e33", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f04087c28a42680e234665fa4aa103425d552edb7283eae7741b09819a3701d1bb2d23ff8ff4167fb6455ea2cbb47b6dd04b380266fbc5275cca99a7fa0c0ed", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff0103b6efa580c3161e493649ff749233894e953174b12bbb8fc1929d27cf2c38e8d45949b029dc247e74e48531c0bd5e085d45381b7cebf3b717027a3f3e68", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14adaf2baddce9dfa39062baf497fcfc4d35a77a52bd1eaaac12f417bdeb3e54df4c05ed6f4f35340a02b60faae51e9660beec25efae07e963ce11cf20843414"} 04:20:55 INFO - Running post-run listener: copy_logs_to_upload_dir 04:20:55 INFO - Copying logs to upload dir... 04:20:55 INFO - mkdir: /builds/slave/test/build/upload/logs 04:20:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.469399 ========= master_lag: 1.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-10-01 04:20:56.518070) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-01 04:20:56.520310) ========= 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=ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/005d8d8742fe8f65161fcc20829b3ea137c7f98e4fab1c80850680befb169cd033fe53f2589cfc8bc8ca8009bb47f2ffb3c67a0a3f348819d36666ecc1d49e33", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f04087c28a42680e234665fa4aa103425d552edb7283eae7741b09819a3701d1bb2d23ff8ff4167fb6455ea2cbb47b6dd04b380266fbc5275cca99a7fa0c0ed", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff0103b6efa580c3161e493649ff749233894e953174b12bbb8fc1929d27cf2c38e8d45949b029dc247e74e48531c0bd5e085d45381b7cebf3b717027a3f3e68", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14adaf2baddce9dfa39062baf497fcfc4d35a77a52bd1eaaac12f417bdeb3e54df4c05ed6f4f35340a02b60faae51e9660beec25efae07e963ce11cf20843414"} build_url:https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.009798 build_url: 'https://queue.taskcluster.net/v1/task/LTVQZ2y-So2WoMe30iGkIw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/005d8d8742fe8f65161fcc20829b3ea137c7f98e4fab1c80850680befb169cd033fe53f2589cfc8bc8ca8009bb47f2ffb3c67a0a3f348819d36666ecc1d49e33", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f04087c28a42680e234665fa4aa103425d552edb7283eae7741b09819a3701d1bb2d23ff8ff4167fb6455ea2cbb47b6dd04b380266fbc5275cca99a7fa0c0ed", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff0103b6efa580c3161e493649ff749233894e953174b12bbb8fc1929d27cf2c38e8d45949b029dc247e74e48531c0bd5e085d45381b7cebf3b717027a3f3e68", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14adaf2baddce9dfa39062baf497fcfc4d35a77a52bd1eaaac12f417bdeb3e54df4c05ed6f4f35340a02b60faae51e9660beec25efae07e963ce11cf20843414"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-01 04:20:56.547238) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 04:20:56.547579) ========= 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=ea65d483da93c827905c2090000001f5-1506855583.361010-1990432733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004674 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 04:20:56.601798) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-01 04:20:56.604166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-01 04:20:56.604542) ========= ========= Total master_lag: 1.42 =========