builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1505845226.34 results: success (0) revision: ba69e294fc80f23d54fc68050f1b7d63d341aa9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.342913) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.343360) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.343631) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.409265) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.409559) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 11:20:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 106M=0s 2017-09-19 11:20:26 (106 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104120 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.545835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.546121) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018376 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.602441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.602742) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ba69e294fc80f23d54fc68050f1b7d63d341aa9c --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 ba69e294fc80f23d54fc68050f1b7d63d341aa9c --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=9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 11:20:26,667 truncating revision to first 12 chars 2017-09-19 11:20:26,667 Setting DEBUG logging. 2017-09-19 11:20:26,667 attempt 1/10 2017-09-19 11:20:26,667 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ba69e294fc80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 11:20:27,115 unpacking tar archive at: mozilla-central-ba69e294fc80/testing/mozharness/ program finished with exit code 0 elapsedTime=0.756028 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:27.385830) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:27.386143) ========= script_repo_revision: ba69e294fc80f23d54fc68050f1b7d63d341aa9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:27.386524) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:27.386827) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:27.400281) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-19 11:20:27.400640) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:27 INFO - MultiFileLogger online at 20170919 11:20:27 in /builds/slave/test 11:20:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:20:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:27 INFO - {'append_to_log': False, 11:20:27 INFO - 'base_work_dir': '/builds/slave/test', 11:20:27 INFO - 'blob_upload_branch': 'Firefox', 11:20:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:27 INFO - 'branch': 'Firefox', 11:20:27 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:27 INFO - 'code_coverage': False, 11:20:27 INFO - 'config_files': ('talos/linux_config.py',), 11:20:27 INFO - 'default_actions': ('clobber', 11:20:27 INFO - 'read-buildbot-config', 11:20:27 INFO - 'download-and-extract', 11:20:27 INFO - 'populate-webroot', 11:20:27 INFO - 'create-virtualenv', 11:20:27 INFO - 'install', 11:20:27 INFO - 'setup-mitmproxy', 11:20:27 INFO - 'run-tests'), 11:20:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:27 INFO - 'disable_ccov_upload': False, 11:20:27 INFO - 'disable_stylo': False, 11:20:27 INFO - 'download_minidump_stackwalk': True, 11:20:27 INFO - 'download_symbols': 'ondemand', 11:20:27 INFO - 'enable_stylo': False, 11:20:27 INFO - 'enable_webrender': False, 11:20:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:20:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:27 INFO - 'gecko_profile': False, 11:20:27 INFO - 'gecko_profile_interval': 0, 11:20:27 INFO - 'installer_path': 'installer.exe', 11:20:27 INFO - 'log_level': 'info', 11:20:27 INFO - 'log_name': 'talos', 11:20:27 INFO - 'log_to_console': True, 11:20:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:27 INFO - 'opt_config_files': (), 11:20:27 INFO - 'pip_index': False, 11:20:27 INFO - 'suite': 'dromaeojs-e10s', 11:20:27 INFO - 'system_bits': '32', 11:20:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:27 INFO - 'title': 'talos-linux64-ix-013', 11:20:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:27 INFO - 'use_talos_json': True, 11:20:27 INFO - 'verify': 'False', 11:20:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:27 INFO - 'work_dir': 'build'} 11:20:27 INFO - [mozharness: 2017-09-19 18:20:27.599283Z] Running clobber step. 11:20:27 INFO - Running pre-action listener: _resource_record_pre_action 11:20:27 INFO - Running main action method: clobber 11:20:27 INFO - rmtree: /builds/slave/test/build 11:20:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:29 INFO - Running post-action listener: _resource_record_post_action 11:20:29 INFO - [mozharness: 2017-09-19 18:20:29.104757Z] Finished clobber step (success) 11:20:29 INFO - [mozharness: 2017-09-19 18:20:29.104853Z] Running read-buildbot-config step. 11:20:29 INFO - Running pre-action listener: _resource_record_pre_action 11:20:29 INFO - Running main action method: read_buildbot_config 11:20:29 INFO - Using buildbot properties: 11:20:29 INFO - { 11:20:29 INFO - "project": "", 11:20:29 INFO - "product": "firefox", 11:20:29 INFO - "who": "ffxbld@noreply.mozilla.org", 11:20:29 INFO - "installer_path": "public/build/target.tar.bz2", 11:20:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:20:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:20:29 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:20:29 INFO - "stage_platform": "linux64-qr", 11:20:29 INFO - "basedir": "/builds/slave/test", 11:20:29 INFO - "buildnumber": 76, 11:20:29 INFO - "platform": "ubuntu64_hw_qr", 11:20:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:20:29 INFO - "slavebuilddir": "test", 11:20:29 INFO - "taskId": "O9OQcAJqRuC6j35ZhhS5Ig", 11:20:29 INFO - "branch": "mozilla-central", 11:20:29 INFO - "script_repo_revision": "production", 11:20:29 INFO - "revision": "ba69e294fc80f23d54fc68050f1b7d63d341aa9c", 11:20:29 INFO - "slavename": "talos-linux64-ix-013", 11:20:29 INFO - "repo_path": "mozilla-central" 11:20:29 INFO - } 11:20:29 INFO - Finding installer, test and symbols from parent task. 11:20:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O9OQcAJqRuC6j35ZhhS5Ig'}, attempt #1 11:20:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O9OQcAJqRuC6j35ZhhS5Ig'}, attempt #1 11:20:30 INFO - Task dependencies: L7l39DLCQeO5S_9KbepNFA 11:20:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA'}, attempt #1 11:20:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 11:20:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.test_packages.json 11:20:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.crashreporter-symbols.zip 11:20:30 INFO - Running post-action listener: _resource_record_post_action 11:20:30 INFO - [mozharness: 2017-09-19 18:20:30.508169Z] Finished read-buildbot-config step (success) 11:20:30 INFO - [mozharness: 2017-09-19 18:20:30.508385Z] Running download-and-extract step. 11:20:30 INFO - Running pre-action listener: _resource_record_pre_action 11:20:30 INFO - Running main action method: download_and_extract 11:20:30 INFO - mkdir: /builds/slave/test/build/tests 11:20:30 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')]} 11:20:30 INFO - trying https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.test_packages.json 11:20:30 INFO - Downloading https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:20:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:20:31 INFO - Downloaded 989 bytes. 11:20:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:20:31 INFO - Using the following test package requirements: 11:20:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:20:31 INFO - u'common': [u'target.common.tests.zip'], 11:20:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:20:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:20:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:20:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:20:31 INFO - u'mozbase': [u'target.common.tests.zip'], 11:20:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:20:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:20:31 INFO - u'web-platform': [u'target.common.tests.zip', 11:20:31 INFO - u'target.web-platform.tests.tar.gz'], 11:20:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:20:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:20:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.common.tests.zip 11:20:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:20:31 INFO - Fetch https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.common.tests.zip into memory 11:20:32 INFO - Content-Length response header: 54731465 11:20:32 INFO - Bytes received: 54731465 11:20:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.talos.tests.zip 11:20:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:20:42 INFO - Fetch https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.talos.tests.zip into memory 11:20:46 INFO - Content-Length response header: 14508787 11:20:46 INFO - Bytes received: 14508787 11:20: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')]} 11:20:46 INFO - trying https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 11:20:46 INFO - Downloading https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:20:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:20:48 INFO - Downloaded 61613416 bytes. 11:20:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 11:20:48 INFO - mkdir: /builds/slave/test/properties 11:20:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:48 INFO - Contents: 11:20:48 INFO - build_url:https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 11:20:48 INFO - Running post-action listener: _resource_record_post_action 11:20:48 INFO - Running post-action listener: find_tests_for_verification 11:20:48 INFO - Running post-action listener: set_extra_try_arguments 11:20:48 INFO - [mozharness: 2017-09-19 18:20:48.454934Z] Finished download-and-extract step (success) 11:20:48 INFO - [mozharness: 2017-09-19 18:20:48.455036Z] Running populate-webroot step. 11:20:48 INFO - Running pre-action listener: _resource_record_pre_action 11:20:48 INFO - Running main action method: populate_webroot 11:20:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['tresize', 11:20:48 INFO - 'tcanvasmark']}, 11:20:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['dromaeo_css', 11:20:48 INFO - 'kraken']}, 11:20:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'tests': ['damp', 'tps']}, 11:20:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['damp', 'tps']}, 11:20:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['dromaeo_dom']}, 11:20:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:20:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['basic_compositor_video', 11:20:48 INFO - 'glvideo']}, 11:20:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:20:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['ts_paint_webext', 11:20:48 INFO - 'tp5o_webext']}, 11:20:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:48 INFO - 'ts_paint', 11:20:48 INFO - 'tpaint', 11:20:48 INFO - 'sessionrestore', 11:20:48 INFO - 'sessionrestore_many_windows', 11:20:48 INFO - 'sessionrestore_no_auto_restore', 11:20:48 INFO - 'tabpaint']}, 11:20:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['a11yr', 11:20:48 INFO - 'ts_paint', 11:20:48 INFO - 'tpaint', 11:20:48 INFO - 'sessionrestore', 11:20:48 INFO - 'sessionrestore_many_windows', 11:20:48 INFO - 'sessionrestore_no_auto_restore', 11:20:48 INFO - 'tabpaint']}, 11:20:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:20:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:20:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['perf_reftest_singletons']}, 11:20:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['bloom_basic']}, 11:20:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:48 INFO - 'tsvgr_opacity', 11:20:48 INFO - 'tart', 11:20:48 INFO - 'tscrollx', 11:20:48 INFO - 'tsvg_static']}, 11:20:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['tsvgx', 11:20:48 INFO - 'tsvgr_opacity', 11:20:48 INFO - 'tart', 11:20:48 INFO - 'tscrollx', 11:20:48 INFO - 'tsvg_static']}, 11:20:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:20:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['tp5o']}, 11:20:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:48 INFO - 'talos_options': ['--mitmproxy', 11:20:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:48 INFO - '--firstNonBlankPaint'], 11:20:48 INFO - 'tests': ['tp6_google', 11:20:48 INFO - 'tp6_youtube', 11:20:48 INFO - 'tp6_amazon', 11:20:48 INFO - 'tp6_facebook']}, 11:20:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:48 INFO - 'talos_options': ['--disable-stylo', 11:20:48 INFO - '--mitmproxy', 11:20:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:48 INFO - '--firstNonBlankPaint'], 11:20:48 INFO - 'tests': ['tp6_google', 11:20:48 INFO - 'tp6_youtube', 11:20:48 INFO - 'tp6_amazon', 11:20:48 INFO - 'tp6_facebook']}, 11:20:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:48 INFO - 'talos_options': ['--stylo-threads=1', 11:20:48 INFO - '--mitmproxy', 11:20:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:48 INFO - '--firstNonBlankPaint'], 11:20:48 INFO - 'tests': ['tp6_google', 11:20:48 INFO - 'tp6_youtube', 11:20:48 INFO - 'tp6_amazon', 11:20:48 INFO - 'tp6_facebook']}, 11:20:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'talos_options': ['--xperf_path', 11:20:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:48 INFO - 'tests': ['tp5n']}, 11:20:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'talos_options': ['--disable-stylo', 11:20:48 INFO - '--xperf_path', 11:20:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:48 INFO - 'tests': ['tp5n']}}} 11:20:48 INFO - Running post-action listener: _resource_record_post_action 11:20:48 INFO - [mozharness: 2017-09-19 18:20:48.477599Z] Finished populate-webroot step (success) 11:20:48 INFO - [mozharness: 2017-09-19 18:20:48.477705Z] Running create-virtualenv step. 11:20:48 INFO - Running pre-action listener: _resource_record_pre_action 11:20:48 INFO - Running main action method: create_virtualenv 11:20:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:20:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:20:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:20:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:49 INFO - Installing pip...............done. 11:20:49 INFO - Return code: 0 11:20:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:20:49 INFO - Reading from file tmpfile_stdout 11:20:49 INFO - Output received: 11:20:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:20:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20: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')]} 11:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20: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')]} 11:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:49 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 0xcd01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040090>, '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 0x1040d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', '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 11:20:49 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 11:20:49 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 11:20:49 INFO - Using env: {'DISPLAY': ':0', 11:20:49 INFO - 'HOME': '/home/cltbld', 11:20:49 INFO - 'LANG': 'en_US.UTF-8', 11:20:49 INFO - 'LANGUAGE': 'en_US:en', 11:20:49 INFO - 'LOGNAME': 'cltbld', 11:20:49 INFO - 'MAIL': '/var/mail/cltbld', 11:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:49 INFO - 'MOZ_NO_REMOTE': '1', 11:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:49 INFO - 'NO_EM_RESTART': '1', 11:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:49 INFO - 'PWD': '/builds/slave/test', 11:20:49 INFO - 'SHELL': '/bin/bash', 11:20:49 INFO - 'SHLVL': '1', 11:20:49 INFO - 'TERM': 'linux', 11:20:49 INFO - 'TMOUT': '86400', 11:20:49 INFO - 'USER': 'cltbld', 11:20:49 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', 11:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:49 INFO - '_': '/tools/buildbot/bin/python'} 11:20:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:20:50 INFO - Downloading/unpacking pip>=1.5 11:20:50 INFO - Running setup.py egg_info for package pip 11:20:50 INFO - warning: no files found matching 'pip/cacert.pem' 11:20:50 INFO - warning: no files found matching '*.html' under directory 'docs' 11:20:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:20:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:20:50 INFO - Installing collected packages: pip 11:20:50 INFO - Found existing installation: pip 1.1 11:20:50 INFO - Uninstalling pip: 11:20:50 INFO - Successfully uninstalled pip 11:20:50 INFO - Running setup.py install for pip 11:20:50 INFO - warning: no files found matching 'pip/cacert.pem' 11:20:50 INFO - warning: no files found matching '*.html' under directory 'docs' 11:20:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:20:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:20:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:20:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:20:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:20:50 INFO - Successfully installed pip 11:20:50 INFO - Cleaning up... 11:20:50 INFO - Return code: 0 11:20:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xcd01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040090>, '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 0x1040d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', '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 11:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:20:50 INFO - Using env: {'DISPLAY': ':0', 11:20:50 INFO - 'HOME': '/home/cltbld', 11:20:50 INFO - 'LANG': 'en_US.UTF-8', 11:20:50 INFO - 'LANGUAGE': 'en_US:en', 11:20:50 INFO - 'LOGNAME': 'cltbld', 11:20:50 INFO - 'MAIL': '/var/mail/cltbld', 11:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:50 INFO - 'MOZ_NO_REMOTE': '1', 11:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:50 INFO - 'NO_EM_RESTART': '1', 11:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:50 INFO - 'PWD': '/builds/slave/test', 11:20:50 INFO - 'SHELL': '/bin/bash', 11:20:50 INFO - 'SHLVL': '1', 11:20:50 INFO - 'TERM': 'linux', 11:20:50 INFO - 'TMOUT': '86400', 11:20:50 INFO - 'USER': 'cltbld', 11:20:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', 11:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:50 INFO - '_': '/tools/buildbot/bin/python'} 11:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:50 INFO - Downloading/unpacking psutil>=3.1.1 11:20:50 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 11:20:50 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 11:20:50 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 11:20:50 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 11:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:52 INFO - Installing collected packages: psutil 11:20:52 INFO - Running setup.py install for psutil 11:20:52 INFO - building 'psutil._psutil_linux' extension 11:20:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:20:52 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 11:20:52 INFO - building 'psutil._psutil_posix' extension 11:20:52 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 11:20:52 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 11:20:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:52 INFO - Successfully installed psutil 11:20:52 INFO - Cleaning up... 11:20:52 INFO - Return code: 0 11:20:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:20: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')]} 11:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20: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')]} 11:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcd01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040090>, '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 0x1040d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', '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 11:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:20:52 INFO - Using env: {'DISPLAY': ':0', 11:20:52 INFO - 'HOME': '/home/cltbld', 11:20:52 INFO - 'LANG': 'en_US.UTF-8', 11:20:52 INFO - 'LANGUAGE': 'en_US:en', 11:20:52 INFO - 'LOGNAME': 'cltbld', 11:20:52 INFO - 'MAIL': '/var/mail/cltbld', 11:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:52 INFO - 'MOZ_NO_REMOTE': '1', 11:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:52 INFO - 'NO_EM_RESTART': '1', 11:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:52 INFO - 'PWD': '/builds/slave/test', 11:20:52 INFO - 'SHELL': '/bin/bash', 11:20:52 INFO - 'SHLVL': '1', 11:20:52 INFO - 'TERM': 'linux', 11:20:52 INFO - 'TMOUT': '86400', 11:20:52 INFO - 'USER': 'cltbld', 11:20:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', 11:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:52 INFO - '_': '/tools/buildbot/bin/python'} 11:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:20:52 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 11:20:52 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 11:20:52 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 11:20:52 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 11:20:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:20:54 INFO - Installing collected packages: mozsystemmonitor 11:20:54 INFO - Running setup.py install for mozsystemmonitor 11:20:54 INFO - Successfully installed mozsystemmonitor 11:20:54 INFO - Cleaning up... 11:20:55 INFO - Return code: 0 11:20:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:20: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')]} 11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20: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')]} 11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xcd01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040090>, '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 0x1040d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', '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 11:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:20:55 INFO - Using env: {'DISPLAY': ':0', 11:20:55 INFO - 'HOME': '/home/cltbld', 11:20:55 INFO - 'LANG': 'en_US.UTF-8', 11:20:55 INFO - 'LANGUAGE': 'en_US:en', 11:20:55 INFO - 'LOGNAME': 'cltbld', 11:20:55 INFO - 'MAIL': '/var/mail/cltbld', 11:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:55 INFO - 'MOZ_NO_REMOTE': '1', 11:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:55 INFO - 'NO_EM_RESTART': '1', 11:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:55 INFO - 'PWD': '/builds/slave/test', 11:20:55 INFO - 'SHELL': '/bin/bash', 11:20:55 INFO - 'SHLVL': '1', 11:20:55 INFO - 'TERM': 'linux', 11:20:55 INFO - 'TMOUT': '86400', 11:20:55 INFO - 'USER': 'cltbld', 11:20:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', 11:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:55 INFO - '_': '/tools/buildbot/bin/python'} 11:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:55 INFO - Downloading/unpacking jsonschema==2.5.1 11:20: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 11:20: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 11:20: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 11:20: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 11:20:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:20:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:56 INFO - Downloading functools32-3.2.3-2.tar.gz 11:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:20:56 INFO - warning: no files found matching '*.txt' 11:20:56 INFO - no previously-included directories found matching 'build' 11:20:56 INFO - no previously-included directories found matching 'dist' 11:20:56 INFO - no previously-included directories found matching '.git*' 11:20:56 INFO - Installing collected packages: jsonschema, functools32 11:20:56 INFO - Running setup.py install for functools32 11:20:56 INFO - warning: no files found matching '*.txt' 11:20:56 INFO - no previously-included directories found matching 'build' 11:20:56 INFO - no previously-included directories found matching 'dist' 11:20:56 INFO - no previously-included directories found matching '.git*' 11:20:56 INFO - Successfully installed jsonschema functools32 11:20:56 INFO - Cleaning up... 11:20:56 INFO - Return code: 0 11:20:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:56 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 0xcd01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040090>, '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 0x1040d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', '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 11:20:56 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 11:20:56 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 11:20:56 INFO - Using env: {'DISPLAY': ':0', 11:20:56 INFO - 'HOME': '/home/cltbld', 11:20:56 INFO - 'LANG': 'en_US.UTF-8', 11:20:56 INFO - 'LANGUAGE': 'en_US:en', 11:20:56 INFO - 'LOGNAME': 'cltbld', 11:20:56 INFO - 'MAIL': '/var/mail/cltbld', 11:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:56 INFO - 'MOZ_NO_REMOTE': '1', 11:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:56 INFO - 'NO_EM_RESTART': '1', 11:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:56 INFO - 'PWD': '/builds/slave/test', 11:20:56 INFO - 'SHELL': '/bin/bash', 11:20:56 INFO - 'SHLVL': '1', 11:20:56 INFO - 'TERM': 'linux', 11:20:56 INFO - 'TMOUT': '86400', 11:20:56 INFO - 'USER': 'cltbld', 11:20:56 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', 11:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:56 INFO - '_': '/tools/buildbot/bin/python'} 11:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:20:57 INFO - Cleaning up... 11:20:57 INFO - Return code: 0 11:20:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xcd01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040090>, '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 0x1040d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', '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 11:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:20:57 INFO - Using env: {'DISPLAY': ':0', 11:20:57 INFO - 'HOME': '/home/cltbld', 11:20:57 INFO - 'LANG': 'en_US.UTF-8', 11:20:57 INFO - 'LANGUAGE': 'en_US:en', 11:20:57 INFO - 'LOGNAME': 'cltbld', 11:20:57 INFO - 'MAIL': '/var/mail/cltbld', 11:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:57 INFO - 'MOZ_NO_REMOTE': '1', 11:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:57 INFO - 'NO_EM_RESTART': '1', 11:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:57 INFO - 'PWD': '/builds/slave/test', 11:20:57 INFO - 'SHELL': '/bin/bash', 11:20:57 INFO - 'SHLVL': '1', 11:20:57 INFO - 'TERM': 'linux', 11:20:57 INFO - 'TMOUT': '86400', 11:20:57 INFO - 'USER': 'cltbld', 11:20:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', 11:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:57 INFO - '_': '/tools/buildbot/bin/python'} 11:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:57 INFO - Downloading/unpacking blobuploader==1.2.4 11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:20:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:20:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:58 INFO - Downloading docopt-0.6.1.tar.gz 11:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:20:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:20:59 INFO - Running setup.py install for blobuploader 11:20:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:20:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:20:59 INFO - Running setup.py install for requests 11:20:59 INFO - Running setup.py install for docopt 11:20:59 INFO - Successfully installed blobuploader requests docopt 11:20:59 INFO - Cleaning up... 11:20:59 INFO - Return code: 0 11:20:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:59 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 0xcd01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040090>, '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 0x1040d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', '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 11:20:59 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 11:20:59 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 11:20:59 INFO - Using env: {'DISPLAY': ':0', 11:20:59 INFO - 'HOME': '/home/cltbld', 11:20:59 INFO - 'LANG': 'en_US.UTF-8', 11:20:59 INFO - 'LANGUAGE': 'en_US:en', 11:20:59 INFO - 'LOGNAME': 'cltbld', 11:20:59 INFO - 'MAIL': '/var/mail/cltbld', 11:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:59 INFO - 'MOZ_NO_REMOTE': '1', 11:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:59 INFO - 'NO_EM_RESTART': '1', 11:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:59 INFO - 'PWD': '/builds/slave/test', 11:20:59 INFO - 'SHELL': '/bin/bash', 11:20:59 INFO - 'SHLVL': '1', 11:20:59 INFO - 'TERM': 'linux', 11:20:59 INFO - 'TMOUT': '86400', 11:20:59 INFO - 'USER': 'cltbld', 11:20:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', 11:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:59 INFO - '_': '/tools/buildbot/bin/python'} 11:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:59 INFO - Running setup.py (path:/tmp/pip-G4o8qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:59 INFO - Running setup.py (path:/tmp/pip-jSNn_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:59 INFO - Running setup.py (path:/tmp/pip-eDsdLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:00 INFO - Running setup.py (path:/tmp/pip-Ze0Viq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:00 INFO - Running setup.py (path:/tmp/pip-0osWMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:00 INFO - Running setup.py (path:/tmp/pip-dVYwCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:00 INFO - Running setup.py (path:/tmp/pip-hpWerd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:00 INFO - Running setup.py (path:/tmp/pip-CM4Qba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:00 INFO - Running setup.py (path:/tmp/pip-Z4OvPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:00 INFO - Running setup.py (path:/tmp/pip-J72gQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:00 INFO - Running setup.py (path:/tmp/pip-z6ErYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:00 INFO - Running setup.py (path:/tmp/pip-dbMFvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:00 INFO - Running setup.py (path:/tmp/pip-WQRSdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:00 INFO - Running setup.py (path:/tmp/pip-JP__oB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:00 INFO - Running setup.py (path:/tmp/pip-EsRVZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:00 INFO - Running setup.py (path:/tmp/pip-fkEd3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:00 INFO - Running setup.py (path:/tmp/pip-YleTVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:21:01 INFO - Running setup.py install for manifestparser 11:21:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozcrash 11:21:01 INFO - Running setup.py install for mozdebug 11:21:01 INFO - Running setup.py install for mozdevice 11:21:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozfile 11:21:01 INFO - Running setup.py install for mozhttpd 11:21:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozinfo 11:21:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozInstall 11:21:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozleak 11:21:01 INFO - Running setup.py install for mozlog 11:21:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:02 INFO - Running setup.py install for moznetwork 11:21:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:02 INFO - Running setup.py install for mozprocess 11:21:02 INFO - Running setup.py install for mozprofile 11:21:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:02 INFO - Running setup.py install for mozrunner 11:21:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:02 INFO - Running setup.py install for mozscreenshot 11:21:02 INFO - Running setup.py install for moztest 11:21:02 INFO - Running setup.py install for mozversion 11:21:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:02 INFO - Cleaning up... 11:21:02 INFO - Return code: 0 11:21:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:02 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')]} 11:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:02 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')]} 11:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:02 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 0xcd01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040090>, '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 0x1040d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', '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 11:21:02 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 11:21:02 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 11:21:02 INFO - Using env: {'DISPLAY': ':0', 11:21:02 INFO - 'HOME': '/home/cltbld', 11:21:02 INFO - 'LANG': 'en_US.UTF-8', 11:21:02 INFO - 'LANGUAGE': 'en_US:en', 11:21:02 INFO - 'LOGNAME': 'cltbld', 11:21:02 INFO - 'MAIL': '/var/mail/cltbld', 11:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:02 INFO - 'MOZ_NO_REMOTE': '1', 11:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:02 INFO - 'NO_EM_RESTART': '1', 11:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:02 INFO - 'PWD': '/builds/slave/test', 11:21:02 INFO - 'SHELL': '/bin/bash', 11:21:02 INFO - 'SHLVL': '1', 11:21:02 INFO - 'TERM': 'linux', 11:21:02 INFO - 'TMOUT': '86400', 11:21:02 INFO - 'USER': 'cltbld', 11:21:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', 11:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:02 INFO - '_': '/tools/buildbot/bin/python'} 11:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:02 INFO - Running setup.py (path:/tmp/pip-R_2ltk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:03 INFO - Running setup.py (path:/tmp/pip-JjpeCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:03 INFO - Running setup.py (path:/tmp/pip-77WYWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:03 INFO - Running setup.py (path:/tmp/pip-zVNnfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:03 INFO - Running setup.py (path:/tmp/pip-8rnrhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:03 INFO - Running setup.py (path:/tmp/pip-qKysAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:03 INFO - Running setup.py (path:/tmp/pip-KQhpl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:03 INFO - Running setup.py (path:/tmp/pip-2sZ2NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:03 INFO - Running setup.py (path:/tmp/pip-fU4xuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:03 INFO - Running setup.py (path:/tmp/pip-iiYO_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:03 INFO - Running setup.py (path:/tmp/pip-JBOzc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:03 INFO - Running setup.py (path:/tmp/pip-GrZSld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:03 INFO - Running setup.py (path:/tmp/pip-wOqm1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:03 INFO - Running setup.py (path:/tmp/pip-WFyerR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:04 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)) 11:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:04 INFO - Running setup.py (path:/tmp/pip-CcMd_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:04 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)) 11:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:04 INFO - Running setup.py (path:/tmp/pip-8XulVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:04 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)) 11:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:04 INFO - Running setup.py (path:/tmp/pip-SRQvwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:04 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)) 11:21:04 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)) 11:21:04 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)) 11:21:04 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)) 11:21:04 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)) 11:21:04 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)) 11:21:04 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)) 11:21:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:04 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 11:21:04 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 11:21:04 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 11:21:04 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 11:21:05 INFO - Downloading blessings-1.6.tar.gz 11:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:05 INFO - Installing collected packages: blessings 11:21:05 INFO - Running setup.py install for blessings 11:21:05 INFO - Successfully installed blessings 11:21:05 INFO - Cleaning up... 11:21:05 INFO - Return code: 0 11:21:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:05 INFO - Reading from file tmpfile_stdout 11:21:05 INFO - Current package versions: 11:21:05 INFO - argparse == 1.2.1 11:21:05 INFO - blessings == 1.6 11:21:05 INFO - blobuploader == 1.2.4 11:21:05 INFO - docopt == 0.6.1 11:21:05 INFO - functools32 == 3.2.3-2 11:21:05 INFO - jsonschema == 2.5.1 11:21:05 INFO - manifestparser == 1.1 11:21:05 INFO - mozInstall == 1.13 11:21:05 INFO - mozcrash == 1.0 11:21:05 INFO - mozdebug == 0.1 11:21:05 INFO - mozdevice == 0.51 11:21:05 INFO - mozfile == 1.2 11:21:05 INFO - mozhttpd == 0.7 11:21:05 INFO - mozinfo == 0.10 11:21:05 INFO - mozleak == 0.1 11:21:05 INFO - mozlog == 3.5 11:21:05 INFO - moznetwork == 0.27 11:21:05 INFO - mozprocess == 0.25 11:21:05 INFO - mozprofile == 0.28 11:21:05 INFO - mozrunner == 6.13 11:21:05 INFO - mozscreenshot == 0.1 11:21:05 INFO - mozsystemmonitor == 0.3 11:21:05 INFO - moztest == 0.8 11:21:05 INFO - mozversion == 1.4 11:21:05 INFO - psutil == 3.1.1 11:21:05 INFO - requests == 1.2.3 11:21:05 INFO - wsgiref == 0.1.2 11:21:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:05 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')]} 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:05 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')]} 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:05 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 0xcd01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040090>, '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 0x1040d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', '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 11:21:05 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 11:21:05 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 11:21:05 INFO - Using env: {'DISPLAY': ':0', 11:21:05 INFO - 'HOME': '/home/cltbld', 11:21:05 INFO - 'LANG': 'en_US.UTF-8', 11:21:05 INFO - 'LANGUAGE': 'en_US:en', 11:21:05 INFO - 'LOGNAME': 'cltbld', 11:21:05 INFO - 'MAIL': '/var/mail/cltbld', 11:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:05 INFO - 'MOZ_NO_REMOTE': '1', 11:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:05 INFO - 'NO_EM_RESTART': '1', 11:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:05 INFO - 'PWD': '/builds/slave/test', 11:21:05 INFO - 'SHELL': '/bin/bash', 11:21:05 INFO - 'SHLVL': '1', 11:21:05 INFO - 'TERM': 'linux', 11:21:05 INFO - 'TMOUT': '86400', 11:21:05 INFO - 'USER': 'cltbld', 11:21:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', 11:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:05 INFO - '_': '/tools/buildbot/bin/python'} 11:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:05 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)) 11:21:05 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)) 11:21:05 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)) 11:21:05 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)) 11:21:05 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)) 11:21:05 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)) 11:21:05 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)) 11:21:05 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)) 11:21:05 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)) 11:21:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:21:05 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 11:21:05 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 11:21:05 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 11:21:05 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 11:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:21:07 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)) 11:21:07 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)) 11:21:07 INFO - Installing collected packages: simplejson 11:21:07 INFO - Running setup.py install for simplejson 11:21:07 INFO - building 'simplejson._speedups' extension 11:21:07 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 11:21:08 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 11:21:08 INFO - Successfully installed simplejson 11:21:08 INFO - Cleaning up... 11:21:08 INFO - Return code: 0 11:21:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21:08 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')]} 11:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:08 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')]} 11:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:08 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 0xcd01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040090>, '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 0x1040d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', '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 11:21:08 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 11:21:08 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 11:21:08 INFO - Using env: {'DISPLAY': ':0', 11:21:08 INFO - 'HOME': '/home/cltbld', 11:21:08 INFO - 'LANG': 'en_US.UTF-8', 11:21:08 INFO - 'LANGUAGE': 'en_US:en', 11:21:08 INFO - 'LOGNAME': 'cltbld', 11:21:08 INFO - 'MAIL': '/var/mail/cltbld', 11:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:08 INFO - 'MOZ_NO_REMOTE': '1', 11:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:08 INFO - 'NO_EM_RESTART': '1', 11:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:08 INFO - 'PWD': '/builds/slave/test', 11:21:08 INFO - 'SHELL': '/bin/bash', 11:21:08 INFO - 'SHLVL': '1', 11:21:08 INFO - 'TERM': 'linux', 11:21:08 INFO - 'TMOUT': '86400', 11:21:08 INFO - 'USER': 'cltbld', 11:21:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', 11:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:08 INFO - '_': '/tools/buildbot/bin/python'} 11:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:21:08 INFO - Cleaning up... 11:21:08 INFO - Return code: 0 11:21:08 INFO - Running post-action listener: _resource_record_post_action 11:21:08 INFO - Running post-action listener: _start_resource_monitoring 11:21:08 INFO - Starting resource monitoring. 11:21:08 INFO - [mozharness: 2017-09-19 18:21:08.493615Z] Finished create-virtualenv step (success) 11:21:08 INFO - [mozharness: 2017-09-19 18:21:08.494088Z] Running install step. 11:21:08 INFO - Running pre-action listener: _resource_record_pre_action 11:21:08 INFO - Running main action method: install 11:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:08 INFO - Reading from file tmpfile_stdout 11:21:08 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:08 INFO - Reading from file tmpfile_stdout 11:21:08 INFO - Output received: 11:21:08 INFO - Usage: mozinstall [options] installer 11:21:08 INFO - Options: 11:21:08 INFO - -h, --help show this help message and exit 11:21:08 INFO - -d DEST, --destination=DEST 11:21:08 INFO - Directory to install application into. [default: 11:21:08 INFO - "/builds/slave/test"] 11:21:08 INFO - --app=APP Application being installed. [default: firefox] 11:21:08 INFO - mkdir: /builds/slave/test/build/application 11:21:08 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'] 11:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:21:26 INFO - Reading from file tmpfile_stdout 11:21:26 INFO - Output received: 11:21:26 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:26 INFO - Running post-action listener: _resource_record_post_action 11:21:26 INFO - [mozharness: 2017-09-19 18:21:26.598303Z] Finished install step (success) 11:21:26 INFO - [mozharness: 2017-09-19 18:21:26.598447Z] Running setup-mitmproxy step. 11:21:26 INFO - Running pre-action listener: _resource_record_pre_action 11:21:26 INFO - Running main action method: setup_mitmproxy 11:21:26 INFO - Skipping: mitmproxy is not required 11:21:26 INFO - Running post-action listener: _resource_record_post_action 11:21:26 INFO - [mozharness: 2017-09-19 18:21:26.598967Z] Finished setup-mitmproxy step (success) 11:21:26 INFO - [mozharness: 2017-09-19 18:21:26.599068Z] Running run-tests step. 11:21:26 INFO - Running pre-action listener: _resource_record_pre_action 11:21:26 INFO - Running pre-action listener: _set_gcov_prefix 11:21:26 INFO - Running main action method: run_tests 11:21:26 WARNING - Try message not found. 11:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:26 INFO - Python 2.7.3 11:21:26 INFO - Return code: 0 11:21:26 INFO - grabbing minidump binary from tooltool 11:21:26 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')]} 11:21:26 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 0x1040090>, '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 0x1040d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:26 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 11:21:26 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 11:21:26 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 11:21:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:26 INFO - Return code: 0 11:21:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:26 INFO - ENV: RUST_BACKTRACE is now full 11:21:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:21:26 INFO - Using env: {'DISPLAY': ':0', 11:21:26 INFO - 'HOME': '/home/cltbld', 11:21:26 INFO - 'LANG': 'en_US.UTF-8', 11:21:26 INFO - 'LANGUAGE': 'en_US:en', 11:21:26 INFO - 'LOGNAME': 'cltbld', 11:21:26 INFO - 'MAIL': '/var/mail/cltbld', 11:21:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:26 INFO - 'MOZ_ACCELERATED': '1', 11:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:26 INFO - 'MOZ_NO_REMOTE': '1', 11:21:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:26 INFO - 'MOZ_WEBRENDER': '1', 11:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:26 INFO - 'NO_EM_RESTART': '1', 11:21:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:26 INFO - 'PWD': '/builds/slave/test', 11:21:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:26 INFO - 'RUST_BACKTRACE': 'full', 11:21:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:26 INFO - 'SHELL': '/bin/bash', 11:21:26 INFO - 'SHLVL': '1', 11:21:26 INFO - 'TERM': 'linux', 11:21:26 INFO - 'TMOUT': '86400', 11:21:26 INFO - 'USER': 'cltbld', 11:21:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', 11:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:26 INFO - '_': '/tools/buildbot/bin/python'} 11:21:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:21:26 INFO - mozversion application_buildid: 20170919173329 11:21:26 INFO - mozversion application_changeset: ba69e294fc80f23d54fc68050f1b7d63d341aa9c 11:21:26 INFO - mozversion application_display_name: Nightly 11:21:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:26 INFO - mozversion application_name: Firefox 11:21:26 INFO - mozversion application_remotingname: firefox 11:21:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:21:26 INFO - mozversion application_vendor: Mozilla 11:21:26 INFO - mozversion application_version: 57.0a1 11:21:26 INFO - mozversion platform_buildid: 20170919173329 11:21:26 INFO - mozversion platform_changeset: ba69e294fc80f23d54fc68050f1b7d63d341aa9c 11:21:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:21:26 INFO - mozversion platform_version: 57.0a1 11:21:26 INFO - using testdate: 1505845286 11:21:26 INFO - actual date: 1505845286 11:21:26 INFO - starting webserver on 'localhost:51018' 11:21:26 INFO - SUITE-START | Running 2 tests 11:21:26 INFO - TEST-START | dromaeo_css 11:21:26 INFO - Initialising browser for dromaeo_css test... 11:21:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51018/getInfo.html -profile /tmp/tmpcPWX3H/profile 11:21:26 INFO - TEST-INFO | started process 26727 (/builds/slave/test/build/application/firefox/firefox http://localhost:51018/getInfo.html) 11:21:33 INFO - TEST-INFO | 26727: exit 0 11:21:33 INFO - Browser initialized. 11:21:33 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:33 INFO - Using env: {'DISPLAY': ':0', 11:21:33 INFO - 'HOME': '/home/cltbld', 11:21:33 INFO - 'JSGC_DISABLE_POISONING': '1', 11:21:33 INFO - 'LANG': 'en_US.UTF-8', 11:21:33 INFO - 'LANGUAGE': 'en_US:en', 11:21:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:21:33 INFO - 'LOGNAME': 'cltbld', 11:21:33 INFO - 'MAIL': '/var/mail/cltbld', 11:21:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:33 INFO - 'MOZ_ACCELERATED': '1', 11:21:33 INFO - 'MOZ_CRASHREPORTER': '1', 11:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:21:33 INFO - 'MOZ_NO_REMOTE': '1', 11:21:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:33 INFO - 'MOZ_WEBRENDER': '1', 11:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:33 INFO - 'NO_EM_RESTART': '1', 11:21:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:33 INFO - 'PWD': '/builds/slave/test', 11:21:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:33 INFO - 'RUST_BACKTRACE': 'full', 11:21:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:33 INFO - 'SHELL': '/bin/bash', 11:21:33 INFO - 'SHLVL': '1', 11:21:33 INFO - 'TERM': 'linux', 11:21:33 INFO - 'TMOUT': '86400', 11:21:33 INFO - 'USER': 'cltbld', 11:21:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', 11:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:33 INFO - '_': '/tools/buildbot/bin/python'} 11:21:33 INFO - TEST-INFO | started process 26968 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcPWX3H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:34 INFO - PID 26968 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:21:34 INFO - PID 26968 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:21:34 INFO - PID 26968 | 11:21:34 INFO - PID 26968 | (/builds/slave/test/build/application/firefox/firefox:27028): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:21:34 INFO - PID 26968 | 11:21:45 INFO - PID 26968 | RSS: Main: 185122816 11:21:45 INFO - PID 26968 | 11:24:42 INFO - PID 26968 | Cycle 1(1): loaded http://localhost:51018/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51018/tests/dromaeo/cssquery-ext.html) 11:24:43 INFO - PID 26968 | RSS: Main: 185151488 11:24:43 INFO - PID 26968 | 11:27:45 INFO - PID 26968 | Cycle 1(1): loaded http://localhost:51018/tests/dromaeo/cssquery-ext.html (next: http://localhost:51018/tests/dromaeo/cssquery-jquery.html) 11:27:46 INFO - PID 26968 | RSS: Main: 191307776 11:27:46 INFO - PID 26968 | 11:30:48 INFO - PID 26968 | Cycle 1(1): loaded http://localhost:51018/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51018/tests/dromaeo/cssquery-mootools.html) 11:30:49 INFO - PID 26968 | RSS: Main: 187432960 11:30:49 INFO - PID 26968 | 11:33:51 INFO - PID 26968 | Cycle 1(1): loaded http://localhost:51018/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51018/tests/dromaeo/cssquery-prototype.html) 11:33:51 INFO - PID 26968 | RSS: Main: 188739584 11:33:51 INFO - PID 26968 | 11:36:55 INFO - PID 26968 | Cycle 1(1): loaded http://localhost:51018/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51018/tests/dromaeo/cssquery-yui.html) 11:36:56 INFO - PID 26968 | RSS: Main: 189796352 11:36:56 INFO - PID 26968 | 11:39:58 INFO - PID 26968 | Cycle 1(1): loaded http://localhost:51018/tests/dromaeo/cssquery-yui.html (next: http://localhost:51018/tests/dromaeo/cssquery-dojo.html) 11:39:58 INFO - PID 26968 | RSS: Main: 192581632 11:39:58 INFO - PID 26968 | 11:39:58 INFO - PID 26968 | __start_tp_report 11:39:58 INFO - PID 26968 | _x_x_mozilla_page_load 11:39:58 INFO - PID 26968 | _x_x_mozilla_page_load_details 11:39:58 INFO - PID 26968 | |i|pagename|runs| 11:39:58 INFO - PID 26968 | |0;dojo.html;3098.1944694379454;3105.937881242375;3117.4544454720417;3118.501039833627;3124.218945263684;5997.160397544348;6235.314115447303;6252.062190671401;6259.780907668232;6266;6150.077488376745;6169.568130230886;6225.533085018619;6265.592736472137;6266.310705822356;5681.744321505522;5724;5737.426257374261;5755.769769209227;5767.711614419283;5721.284839395075;5730.341010783751;5784.45047720468;5818.592698511085;5832.154337621042;5702.885942281152;5796.710164491779;5818.8254352369495;5857.531397488191;5859.267591551056;877.7427876136509;5705.286839145107;5773.3072031356505;5846.912296315559;5884.6763428011445;5657.12314591239;5662.8301150965535;5708.400617935098;5729.541636669098;5772.451617096369;6231.813045608594;6237.688115594247;6249.031400132987;6319.936800631981;6351.87296254077;6599.175103112111;6623.701933413008;6765.086713293692;6770.052192693027;6791.185057793047;6726.428253598401;6774.322567743236;6818.249992500871;6847.17833859935;6876.759313424006;6202.782902598433;6218.5025197984505;6223;6292.4966002719675;6310.305866354697;6733.966330168318;6839.0425340452375;6852.725890964405;6873.862522749517;6945.652717364213;6480.4815614750705;6545.672716364163;6556.213254409406;6559.6064236145985;6571.31001244872;6509.381608747161;6565.606063636197;6612.305707900698;6664.300248473937;6699.263081061079;6694.698738556776;6776.457883369417;6778.627175505296;6781.966090169616;6785.59286442815;6717;6734.494912881553;6790.72837086511;6800.52396332252;6816.250212476623;5110.054639891632;5222.895542089137;5246.449122842047;5252.080885844962;5326.866828329323;4599.9080018399445;4600.5629465200755;4623.098495793288;4634.745089020069;4655.231886738718;5656.6888821115235;5692.57305702074;5701.543876489871;5733.541316694655;5738.5982981191755;6662.167229096363;6705.530612857053;6742.561733487308;6752.763653272112;6756.898646520306;5680.14797780328;5696.572757043238;5708.71456427177;5726.026575482178;5775.33583637887;5635.267415236075;5669.31968163823;5710.371859095496;5722.484976352148;5725.0267454531995;6308.684565771693;6352.841178970562;6371.139896114058;6406.135171751847;6409.166808314889;6609.339066093352;6673.899891501631;6767.729290828509;6793.796186114425;6798.7280508779095;6388.329225431263;6450.483961282992;6488.091667166506;6495.642739649175;6511.38141876521;6603.273639899511;6611.404973552403;6691.732330706717;6703.597784132968;6708.396244338033;6594.373534514213;6684.866302674017;6689.665516724047;6780.355866192901;6780.491463140185;6489.7404103835315;6524.804255872332;6557.442617377576;6597.373249541478;6605.372489613479;6501.8699626008165;6515.218173819172;6539.542232043711;6559.048937903882;6580.638064906285;6437.195350581177;6444.967775161094;6463.515236357198;6527.086207930988;6539.673016349068;6431.678416079271;6526.967365163334;6614.933850661432;6629.834254143685;6674.466042716668;6191.938080619317;6301.464375528131;6387.552871298964;6393.552451328363;6466.159399278252 11:39:58 INFO - PID 26968 | |1;ext.html;865.6667183134496;871.6295574380887;877.1009715042077;887.9911200887989;891.1445012787724;40149.19701605966;41024.179516409655;41603.58396416035;41765.955851103776;41818;38053.61946380536;38423.231535369276;38437.80781096098;38477.03807404816;38486.807565962205;7136.215016348197;7145.749898753532;7215.963920180392;7249.891251631229;7261.382782463497;7060.858782824341;7183.030290910739;7191.568505889663;7194.28057194279;7217.927820721804;7154.964225178893;7183.066201393812;7188.2811718828225;7767.223277672244;8003.439759216857;7878.4485086044;7926;7929.326007289387;7933.603319834014;7943.165967573437;7763.146053934062;7862.449628526006;7904.486208396494;7906.248906353887;7914.0503139623615;37140.07149821276;37301.81349093264;37863;37869.62130378689;38078.42882356767;3471.687548120656;3506.3513250048823;3519.0674471265133;3526.576810782697;3532.7350448716447;31171.53242701361;31197.064088077168;31296.37407251865;31387.37225255505;31599.84200079008;5098.5411312982005;5115.053715062688;5122.103631864409;5134.743262836881;5190.247414124969;182201;185310;186785;195532;197004.01497992562;45995.77002115035;46008.53991460043;46029.539704603194;46129.077418452114;46150.5384946153;47169.933954292865;47254.5274547257;47322.05355892863;47747.761261194166;47775.04449911052;15820.841791582166;15868.285927133307;15911;15940.442084526985;15942.840571594368;13070;13158.539451119164;13214.933925330311;13297.26865022433;13305.401256943267;13105.672358191121;13118.672033199246;13231.73536529264;13272.867271327163;13293.202407855366;5420.810271640474;5583.748731307101;5596.656802367484;5633.971830140905;5651.321841379061;976.4190306767604;1007.4459047523833;1014.2443879309961;1022.5705203814416;1025.3130402630256;22931;22967.88516057409;22975.770242297363;23265.302040938797;23278.65082023771;1109.4840898982013;1118.3513562133942;1125.5047778977223;1129.1474936422949;1133.7845809296207;11984.52061917531;12292.877071229173;12350.75298494025;12392.81410778839;12404.25574465535;215374;217693;217897;217966;218962;49556.75221623869;49917.25124123141;50238;50491.747541262055;50530.49469505331;1377.1668140774686;1441.7332793433247;1443.1124858212333;1443.3577058209205;1453.3459943025468;22117.33647990563;22416.663750043437;22574.20990265333;22767.772322276564;22951.196708115804;36114.27771444609;36116.63883361133;36158.638413615525;36195.276094477435;36374.45438318374;182294;182721.0863945672;183250;183532.08233958745;184286;29518.55722164212;30168.69831301659;32614.184645384055;32619.34761304808;32706.83646581752;41602.58397415987;42269.577304226565;42320.57679423167;42433.5756642442;42892.78553607212;31070.53394199134;31276.687233128287;31410.528842067844;31590.52614210743;31596.210094747814;31124;31150.844245778626;31249.531257030707;31338.686613133577;31463.84268078645;33807.66192338045;34373.140671483416;34991.65008349986;35000.12499687528;35180.12049698778;30409.695903040687;30437.847810760806;30663.386732264782;30673.233169170056;31356.52965205478;23082.422939426648;23327.300180994596;23421.297361079196;23605.52788944177;23772.524549508566 11:39:58 INFO - PID 26968 | |2;jquery.html;572.1589263782239;576.4293349583911;582.9970850145746;583.9503642190414;586.9530437564994;21887.890560547214;22708;22780;22857.31428057157;22890.65664015041;23226.65160022601;24166.51666966664;24183.153589624366;24453.510929781394;24496.510069798638;6392.264889537704;6569.080328753978;6579.309172536887;6584.868302633944;6584.93415065848;6409.230892292908;6454.5159113066475;6482;6507.219133703962;6511.706973186218;6272.937270627281;6472.061551075091;6598.967005164967;6603.438707709851;6610.537262391635;6487.41613254807;6513;6520.608763474207;6528.988006858945;6541.705623246941;5992.79025234119;6044.24446944132;6091.695415229221;6092.817215483543;6098.024316109401;26537.336566585796;27675.446491070266;27744.722552774616;27827.860860695768;27857.86071069652;2021.2218295956015;2062.1339037604243;2065.3390914907236;2067.173130747698;2069.4102180878376;18498.722519162224;18969.43091707251;19130.139143738565;19175.712364314546;19289.131989060526;2395.6406539019285;2456.987715061431;2461.803055755553;2483.4412257242157;2488.1042824583137;122668.38665806703;129735;142542;144821.2758936209;145717;20043.799562004195;20365.490862728253;20948.895255523625;21002.36992890185;21644.78355216459;40549.18901621951;41090.58909410868;41117.79441102775;41156.176876462305;41182.1763564727;11397.658070257905;11450.599229026944;11508.769824603462;11534.500514933005;11568.595099171489;9650.179734722627;9693.418394896187;9758.560864761102;9779.902200978042;9815.950920245354;10840.457977101114;11212.70620395172;11316;11444;11613.129015323884;3662.887181882331;4127.318992366226;4169.624733773975;4277.593628605277;4313.266744653416;938.9953050234706;957.4494665567327;969.6363863551169;970.2044323654535;989.8564708117427;18743.625127497373;18960.14679339433;19270.518237044187;19313.4205973821;19549.120289587;1041.5417216424748;1045.1429827541494;1050.1231471721046;1055.0715370473933;1058.6506452870535;10512.789744205073;10618.150547956146;10938.124950003981;10963.890361096286;11015.28400653971;483858;489592;490778;496072;521013;111543;112459;113126;113132.43433782943;113839;1149.408054851752;1163.7381589142544;1178.2871362825538;1188.9405529723479;1190.2739329009298;16766.832331676527;16870.240839162023;17110.914445427694;17398.39105631297;17409.303627854744;53783.193252102035;55347;55499.445005551046;56158.43841561532;56565.43434565602;69323;69872;70448.64775676088;71412;72084.63957680178;19557.511062222988;19615.31346402869;19623;19666.311679091163;19697.212111515953;21743.56512869702;22038.88980555087;22177.556448870608;22189.77810221877;22231.666525001816;17620.64758704793;17776.555586109935;17904.10479476047;18060.277588896297;18211.817881821542;15342.923285383502;15955.441559545361;16090.758638620197;16094.356225751308;16115;17656.91171544134;17943.102844857443;18182.81817181811;18226.088695565435;18357.816421836145;19119;19156.52108697238;19234.903825481342;19246.518837028627;19528.90235548813;17439.651206975537;17604.73592896082;17797.377091801725;17819.554511137325;18056.277748889897 11:39:58 INFO - PID 26968 | |3;mootools.html;1295.086963690598;1391.916485010899;1402.4810819996596;1407.3385508810854;1408.8027676125341;14869.62825929351;15437.768433473508;15586.454474093409;15591.610209744747;15606.375744970188;15137.167455789928;15226.771598426032;15257.694846103072;15269.312880920357;15271.6945661087;2733.7949653775945;2751.55975043993;2800.7339302766204;2802.2574017885277;2802.5936239245298;2726.086760935089;2766.986165069172;2780.33272014716;2785.610014597958;2787.456445993032;2737.9726202737916;2748.1206014075506;2767.681716602586;2769.4461107778425;2786.3730660601304;2666.2134670272317;2672.038066296132;2698.042195020759;2705.6753189617175;2706.052881491482;2584.819062665614;2586.6249393837975;2600.2199340198054;2603.3231359846577;2619.738026197384;14461.71076578473;14497.710045799025;14532.854671453257;14614.050086744328;14680.119192848357;7742.225777422269;7950.642221100006;8024.3580513559355;8031.558264295461;8039.799005024863;5107.412647545542;5227.398849132361;5396.973015134939;5506.091494903336;5510.889782204334;1984.3848406993734;1985.2753744883014;1993.9401817945484;2027.8479114066504;2047.0890453748088;22995.77004229953;23615.173468928504;23660;25568;26128.86935565329;7143.499595254956;7243.022192004012;7322.926770732331;7371.852562948711;7389.667464963982;19898.801011989985;20122;20126.19495220175;20141.49646258826;20167.294144704865;8190.303824175012;8260.545669988209;8303.169683031649;8310.21052999964;8312.127226641116;7164.319389657974;7450.2549745026145;7474.962625186839;7513.774586762406;7585.506942048749;5480.177973304037;5675.716214189274;5695.629784064023;5750.338711048199;5750.5112065474905;1744.3109971561162;1767.3814165042133;1810.6650269699885;1828.4880233534632;1829.9268029278946;887.5650931043871;903.2548147778109;916.0152835701514;922.3773952582114;936.1621348892703;8170.632321545545;8454.535000574904;8480.448770829877;8500.404971651926;8587.699430519902;682.9146356705412;729.095921057895;734.3574372424129;734.9963250183715;735.3308489274734;4657.347971284023;4661.974365639554;4725.621950243973;4750.216214324598;4756.904861902743;20962.685559716618;22012.889935550542;22094.22670206535;22163.556728865657;22226.666600001012;20684.58630827375;21567.2451464198;21671.241506547194;21782.45543861416;21845.235416760337;10422.426766527913;10540.367577945348;10724.14206863449;10734.57061717538;10884.129269658408;8152.388570857091;8210.466319689202;8222.671093156207;8228.50628962264;8407.915920840713;17624;17962.640747185244;18286.72569911479;18637.347692830685;18784.53038674044;19162.7125593119;19288.614227715647;19831.900840495706;19927.900360498104;20239.089240984486;11870.821937671115;12113.333766642567;12181.147319687538;12244.142909996572;12267.447964841782;13795.655108622364;13869.445222191;13940.58178254654;13947.930260348634;13970.860291396955;11461.4269286537;11508.59719909799;11727.648170554898;11767.058635309326;11896.583619573274;11308.943455282671;11386.373749443861;11453.141014423785;11564.942175289407;11623.244489108181;9796.118349348593;9847.310688251753;9902;9927.602895884083;9961.252906032221;6999.160100787938;7088.291170882871;7102.538335008208;7219.169795473378;7228.457865660202;6823.454123669995;6860;6928;6931.237563868071;7013.859722805618 11:39:58 INFO - PID 26968 | |4;prototype.html;500.5768365890382;505.2961790078721;518.468569716041;522.5453855146023;526.2579762534826;6174.629522228669;6237.220347456568;6253.187085678861;6259.374062593744;6276.435120839124;6057.42454466825;6191.783287584935;6224.937750622493;6228.750849966007;6289.528285378604;5158.690478571289;5184.53339199472;5202.687838729688;5216.191490318987;5221.843344699646;5171.922421163686;5196.350456192976;5217.869553261161;5222.764975576109;5226.817061402851;4705.976470117662;4920.23736320869;5033.11920413928;5104.285400043997;5163.664361816489;4922.704637721748;4956.801727930879;4973.129702302119;4988.5260900214425;5005.224190250498;4403.64770818337;4448.777561121931;4450.955490445119;4452.265376212921;4478.641708663299;5960.754536008329;6080.543959203077;6088.908666370008;6121.846953826145;6121.877562448726;5643.576731745095;5689.9146512802345;5699;5710.543156547507;5747.856303592402;6462.450691691165;6501.609903405763;6552.803415897531;6558.770443034518;6587.473002159863;4660.300954856799;4830.130576496229;4852.684575502616;4883.511648835088;4893.975530122327;6609.570377925419;6663.333666633298;6692.795296846566;6719.697613607399;6784.694688739019;4970.329005584272;4975.203967365204;4979.178435558092;5008.073506401327;5034.8237811677145;5021.246812978009;5040.59675225981;5062.341895553554;5066.923996140061;5088.414832294334;5570.721463926869;5590.888182236333;5633.774649014075;5642.85892852682;5704.543636509069;6471.288158302583;6525.955847064447;6535.411812936859;6595.307492713196;6609.1408116944485;1721.5868191634167;1734.7051001329805;1762.1805860275033;1762.3038899634573;1765.435060780538;1159.3739380734478;1194.1103877611063;1207.1007099710596;1231.9630411087683;1257.8930790882694;5575.1915972184615;5611.130274807411;5629.395622247722;5632.52123569493;5670.432956704297;6335.334789847;6508.934910650928;6554.868902621921;6588;6592.24189218246;5480.808171713971;5530.5299049580435;5545.057340252167;5633.915491267634;5679.393585073508;3519.7184225261917;3524.9685270667205;3527.976886702879;3535.876244331436;3543.698785603201;6307.161777200278;6378.394052564999;6391.296957334689;6395.456386207225;6457.966725323926;6784.219814721271;6854.760083397057;6909.309069093151;6911.930880691129;6916.723331066802;5924.7333869975955;6324.747010119544;6341.365863413622;6356.713947872449;6409.903851442232;6348.682565871595;6496.252930913006;6593.472522198117;6670;6700.49746269022;6449.9355006451215;6508.656883522023;6603.570767900071;6673.632950187786;6675.6995935184;6202.5658203925295;6325.873482530232;6356.459700925473;6372.299047104908;6373.681315934277;4852.878678033077;4944.554990050912;4950.851474455772;4962.900741985212;5235.345581802275;6569.343065693583;6574.211094668479;6642.83392915181;6648.7340506379205;6650.536881885977;6295.527835412271;6312.905306420315;6325;6441.677916104082;6475.481961443167;6332.968335158294;6351.555391122762;6361.777337793155;6370.044493326038;6443.838904027437;6285.182926219745;6291.685415729104;6304.369563043659;6425.325340839145;6454.128692626436;6421.357864213728;6450.258220304725;6526.477881769542;6590;6623.635700036544;6245.18812554365;6283.617604127085;6314.747410103544;6316.589421687576;6383.297837237993 11:39:58 INFO - PID 26968 | |5;yui.html;879.56461551532;889.7820034091646;905.714699869541;913.5980168725764;923.1599244687334;19031.52421189471;20157.899210503947;20227.494312642153;20242.29151979681;20358.287459938925;18139.45581632553;18445.169967351467;18457;18642.627147457042;18684;943.2406912435487;950.9429434233933;954.6897258391016;955.4888134847857;956.5312996631635;952.6522819170988;958.0276019839833;965.3146266151041;969.3747532841313;971.9076687714692;1027.9537420816082;1029.0892560084305;1046.9842952355682;1047.193660881125;1047.4291511126455;1025.8204814157568;1029.2280789407944;1029.927905046647;1031.5512751952888;1039.50103950104;754.4266357568233;754.9169591344947;760.4752720622753;760.5360729954723;762.3177256355531;18906.05469726522;19032.143553540125;19045.7143142853;19098.80901190984;19104.713429298572;21404.89297553518;21586.460338491506;21735.891320543455;21851.016704248348;21868.89065554662;17278.30886764528;17723.556911077198;17732.91133544324;17738.11309434536;17837.732434013502;3674.1365779041903;3701.61133081028;3705.073731567108;3708.517892673935;3711.164987877733;137894;137926.31036844852;138096;139251;139650.30174849162;16041.117738524494;16605.50183494497;16630.75053874193;16702.916485417496;16733.66532669364;28093;28185.57721634177;28340.00809971641;28398;29955;8431.747047588582;8598.441101328519;8675;8682.913170868336;8683.56582170889;4162.604552567501;4180.8118634660905;4211.389348544505;4215.747055176699;4235.343521754133;5280.339957505312;5390.54180394663;5419.701916394557;5446.727663616883;5455.972720136374;1018.9082982531608;1040.5213601743133;1054.1040115901576;1063.0645032371463;1065.387402243713;649.7595889520908;678.4097834883682;678.4165617568887;682.3347236444426;688.8932215506604;10742.946285268523;11142.220044596963;11823;12054.276743395425;12349.073819463576;666.120720648739;676.6549059979347;680.1022650101917;688.2119972631309;702.2731472925498;5479.75341109651;5538.9169162462595;5554.1946417769195;5594.384617692051;5688.5733569981585;114379;119775;120079;120481.39759301147;122075;103659;104461.47769261105;106935;107425.4628726867;107558.46220768846;88371.55814220887;89114;90384;90778;91728.54135729278;10236.590536378462;10311;10414.635487757892;10534.315269507457;10609.469526523797;40826.591734083464;42128.57871421247;42591.14817703691;43028.56971430246;43469.347959779996;54232.18651720149;54849.725751370985;55575.05487307925;55880.161797572255;56238.718806405705;15253.16107614092;15452.3002469726;15619.453319133776;15672.843271567595;15806.209689515708;16838.158092095593;17172.742408864127;17320.65358692794;17329.653406932044;17611.64776704433;15937.68124637524;16172.353105875633;16228.432004879773;16335.428260010842;16345.182740862672;14993.700125997637;15244.390224391344;15351.539453816404;15473.148976806384;15698;14815.703685926437;14970.775438368215;15102.169380684169;15179.924100379427;15245.16151611672;11179.72050698739;11187.384693841917;11240.887591123985;11330.036946859609;11356.94321528387;11554.839223177385;11623.186376953532;11664.825027624762;11673.241239319417;11685.065194784567 11:39:58 INFO - PID 26968 | __end_tp_report 11:39:58 INFO - PID 26968 | __start_cc_report 11:39:58 INFO - PID 26968 | _x_x_mozilla_cycle_collect,307 11:39:58 INFO - PID 26968 | __end_cc_report 11:39:58 INFO - PID 26968 | __startTimestamp1505846398271__endTimestamp 11:39:58 INFO - PID 26968 | 11:39:58 INFO - PID 26968 | ------- Summary: start ------- 11:39:58 INFO - PID 26968 | Number of tests: 6 11:39:58 INFO - PID 26968 | 11:39:58 INFO - PID 26968 | [#0] dojo.html Cycles:165 Average:6123.72 Median:6406.14 stddev:851.54 (13.3%) stddev-sans-first:820.40 11:39:58 INFO - PID 26968 | Values: 3098.2 3105.9 3117.5 3118.5 3124.2 5997.2 6235.3 6252.1 6259.8 6266.0 6150.1 6169.6 6225.5 6265.6 6266.3 5681.7 5724.0 5737.4 5755.8 5767.7 5721.3 5730.3 5784.5 5818.6 5832.2 5702.9 5796.7 5818.8 5857.5 5859.3 877.7 5705.3 5773.3 5846.9 5884.7 5657.1 5662.8 5708.4 5729.5 5772.5 6231.8 6237.7 6249.0 6319.9 6351.9 6599.2 6623.7 6765.1 6770.1 6791.2 6726.4 6774.3 6818.2 6847.2 6876.8 6202.8 6218.5 6223.0 6292.5 6310.3 6734.0 6839.0 6852.7 6873.9 6945.7 6480.5 6545.7 6556.2 6559.6 6571.3 6509.4 6565.6 6612.3 6664.3 6699.3 6694.7 6776.5 6778.6 6782.0 6785.6 6717.0 6734.5 6790.7 6800.5 6816.3 5110.1 5222.9 5246.4 5252.1 5326.9 4599.9 4600.6 4623.1 4634.7 4655.2 5656.7 5692.6 5701.5 5733.5 5738.6 6662.2 6705.5 6742.6 6752.8 6756.9 5680.1 5696.6 5708.7 5726.0 5775.3 5635.3 5669.3 5710.4 5722.5 5725.0 6308.7 6352.8 6371.1 6406.1 6409.2 6609.3 6673.9 6767.7 6793.8 6798.7 6388.3 6450.5 6488.1 6495.6 6511.4 6603.3 6611.4 6691.7 6703.6 6708.4 6594.4 6684.9 6689.7 6780.4 6780.5 6489.7 6524.8 6557.4 6597.4 6605.4 6501.9 6515.2 6539.5 6559.0 6580.6 6437.2 6445.0 6463.5 6527.1 6539.7 6431.7 6527.0 6614.9 6629.8 6674.5 6191.9 6301.5 6387.6 6393.6 6466.2 11:39:58 INFO - PID 26968 | 11:39:58 INFO - PID 26968 | [#1] ext.html Cycles:180 Average:36124.47 Median:18922.41 stddev:51021.99 (269.6%) stddev-sans-first:51096.44 11:39:58 INFO - PID 26968 | Values: 865.7 871.6 877.1 888.0 891.1 40149.2 41024.2 41603.6 41766.0 41818.0 38053.6 38423.2 38437.8 38477.0 38486.8 7136.2 7145.7 7216.0 7249.9 7261.4 7060.9 7183.0 7191.6 7194.3 7217.9 7155.0 7183.1 7188.3 7767.2 8003.4 7878.4 7926.0 7929.3 7933.6 7943.2 7763.1 7862.4 7904.5 7906.2 7914.1 37140.1 37301.8 37863.0 37869.6 38078.4 3471.7 3506.4 3519.1 3526.6 3532.7 31171.5 31197.1 31296.4 31387.4 31599.8 5098.5 5115.1 5122.1 5134.7 5190.2 182201.0 185310.0 186785.0 195532.0 197004.0 45995.8 46008.5 46029.5 46129.1 46150.5 47169.9 47254.5 47322.1 47747.8 47775.0 15820.8 15868.3 15911.0 15940.4 15942.8 13070.0 13158.5 13214.9 13297.3 13305.4 13105.7 13118.7 13231.7 13272.9 13293.2 5420.8 5583.7 5596.7 5634.0 5651.3 976.4 1007.4 1014.2 1022.6 1025.3 22931.0 22967.9 22975.8 23265.3 23278.7 1109.5 1118.4 1125.5 1129.1 1133.8 11984.5 12292.9 12350.8 12392.8 12404.3 215374.0 217693.0 217897.0 217966.0 218962.0 49556.8 49917.3 50238.0 50491.7 50530.5 1377.2 1441.7 1443.1 1443.4 1453.3 22117.3 22416.7 22574.2 22767.8 22951.2 36114.3 36116.6 36158.6 36195.3 36374.5 182294.0 182721.1 183250.0 183532.1 184286.0 29518.6 30168.7 32614.2 32619.3 32706.8 41602.6 42269.6 42320.6 42433.6 42892.8 31070.5 31276.7 31410.5 31590.5 31596.2 31124.0 31150.8 31249.5 31338.7 31463.8 33807.7 34373.1 34991.7 35000.1 35180.1 30409.7 30437.8 30663.4 30673.2 31356.5 23082.4 23327.3 23421.3 23605.5 23772.5 11:39:58 INFO - PID 26968 | 11:39:58 INFO - PID 26968 | [#2] jquery.html Cycles:180 Average:35613.73 Median:21815.73 stddev:83334.61 (382.0%) stddev-sans-first:83526.85 11:39:58 INFO - PID 26968 | Values: 572.2 576.4 583.0 584.0 587.0 21887.9 22708.0 22780.0 22857.3 22890.7 23226.7 24166.5 24183.2 24453.5 24496.5 6392.3 6569.1 6579.3 6584.9 6584.9 6409.2 6454.5 6482.0 6507.2 6511.7 6272.9 6472.1 6599.0 6603.4 6610.5 6487.4 6513.0 6520.6 6529.0 6541.7 5992.8 6044.2 6091.7 6092.8 6098.0 26537.3 27675.4 27744.7 27827.9 27857.9 2021.2 2062.1 2065.3 2067.2 2069.4 18498.7 18969.4 19130.1 19175.7 19289.1 2395.6 2457.0 2461.8 2483.4 2488.1 122668.4 129735.0 142542.0 144821.3 145717.0 20043.8 20365.5 20948.9 21002.4 21644.8 40549.2 41090.6 41117.8 41156.2 41182.2 11397.7 11450.6 11508.8 11534.5 11568.6 9650.2 9693.4 9758.6 9779.9 9816.0 10840.5 11212.7 11316.0 11444.0 11613.1 3662.9 4127.3 4169.6 4277.6 4313.3 939.0 957.4 969.6 970.2 989.9 18743.6 18960.1 19270.5 19313.4 19549.1 1041.5 1045.1 1050.1 1055.1 1058.7 10512.8 10618.2 10938.1 10963.9 11015.3 483858.0 489592.0 490778.0 496072.0 521013.0 111543.0 112459.0 113126.0 113132.4 113839.0 1149.4 1163.7 1178.3 1188.9 1190.3 16766.8 16870.2 17110.9 17398.4 17409.3 53783.2 55347.0 55499.4 56158.4 56565.4 69323.0 69872.0 70448.6 71412.0 72084.6 19557.5 19615.3 19623.0 19666.3 19697.2 21743.6 22038.9 22177.6 22189.8 22231.7 17620.6 17776.6 17904.1 18060.3 18211.8 15342.9 15955.4 16090.8 16094.4 16115.0 17656.9 17943.1 18182.8 18226.1 18357.8 19119.0 19156.5 19234.9 19246.5 19528.9 17439.7 17604.7 17797.4 17819.6 18056.3 11:39:58 INFO - PID 26968 | 11:39:58 INFO - PID 26968 | [#3] mootools.html Cycles:180 Average:9405.80 Median:2669.13 stddev:6663.11 (249.6%) stddev-sans-first:6653.93 11:39:58 INFO - PID 26968 | Values: 1295.1 1391.9 1402.5 1407.3 1408.8 14869.6 15437.8 15586.5 15591.6 15606.4 15137.2 15226.8 15257.7 15269.3 15271.7 2733.8 2751.6 2800.7 2802.3 2802.6 2726.1 2767.0 2780.3 2785.6 2787.5 2738.0 2748.1 2767.7 2769.4 2786.4 2666.2 2672.0 2698.0 2705.7 2706.1 2584.8 2586.6 2600.2 2603.3 2619.7 14461.7 14497.7 14532.9 14614.1 14680.1 7742.2 7950.6 8024.4 8031.6 8039.8 5107.4 5227.4 5397.0 5506.1 5510.9 1984.4 1985.3 1993.9 2027.8 2047.1 22995.8 23615.2 23660.0 25568.0 26128.9 7143.5 7243.0 7322.9 7371.9 7389.7 19898.8 20122.0 20126.2 20141.5 20167.3 8190.3 8260.5 8303.2 8310.2 8312.1 7164.3 7450.3 7475.0 7513.8 7585.5 5480.2 5675.7 5695.6 5750.3 5750.5 1744.3 1767.4 1810.7 1828.5 1829.9 887.6 903.3 916.0 922.4 936.2 8170.6 8454.5 8480.4 8500.4 8587.7 682.9 729.1 734.4 735.0 735.3 4657.3 4662.0 4725.6 4750.2 4756.9 20962.7 22012.9 22094.2 22163.6 22226.7 20684.6 21567.2 21671.2 21782.5 21845.2 10422.4 10540.4 10724.1 10734.6 10884.1 8152.4 8210.5 8222.7 8228.5 8407.9 17624.0 17962.6 18286.7 18637.3 18784.5 19162.7 19288.6 19831.9 19927.9 20239.1 11870.8 12113.3 12181.1 12244.1 12267.4 13795.7 13869.4 13940.6 13947.9 13970.9 11461.4 11508.6 11727.6 11767.1 11896.6 11308.9 11386.4 11453.1 11564.9 11623.2 9796.1 9847.3 9902.0 9927.6 9961.3 6999.2 7088.3 7102.5 7219.2 7228.5 6823.5 6860.0 6928.0 6931.2 7013.9 11:39:58 INFO - PID 26968 | 11:39:58 INFO - PID 26968 | [#4] prototype.html Cycles:180 Average:5459.62 Median:6121.86 stddev:1511.93 (24.7%) stddev-sans-first:1469.64 11:39:58 INFO - PID 26968 | Values: 500.6 505.3 518.5 522.5 526.3 6174.6 6237.2 6253.2 6259.4 6276.4 6057.4 6191.8 6224.9 6228.8 6289.5 5158.7 5184.5 5202.7 5216.2 5221.8 5171.9 5196.4 5217.9 5222.8 5226.8 4706.0 4920.2 5033.1 5104.3 5163.7 4922.7 4956.8 4973.1 4988.5 5005.2 4403.6 4448.8 4451.0 4452.3 4478.6 5960.8 6080.5 6088.9 6121.8 6121.9 5643.6 5689.9 5699.0 5710.5 5747.9 6462.5 6501.6 6552.8 6558.8 6587.5 4660.3 4830.1 4852.7 4883.5 4894.0 6609.6 6663.3 6692.8 6719.7 6784.7 4970.3 4975.2 4979.2 5008.1 5034.8 5021.2 5040.6 5062.3 5066.9 5088.4 5570.7 5590.9 5633.8 5642.9 5704.5 6471.3 6526.0 6535.4 6595.3 6609.1 1721.6 1734.7 1762.2 1762.3 1765.4 1159.4 1194.1 1207.1 1232.0 1257.9 5575.2 5611.1 5629.4 5632.5 5670.4 6335.3 6508.9 6554.9 6588.0 6592.2 5480.8 5530.5 5545.1 5633.9 5679.4 3519.7 3525.0 3528.0 3535.9 3543.7 6307.2 6378.4 6391.3 6395.5 6458.0 6784.2 6854.8 6909.3 6911.9 6916.7 5924.7 6324.7 6341.4 6356.7 6409.9 6348.7 6496.3 6593.5 6670.0 6700.5 6449.9 6508.7 6603.6 6673.6 6675.7 6202.6 6325.9 6356.5 6372.3 6373.7 4852.9 4944.6 4950.9 4962.9 5235.3 6569.3 6574.2 6642.8 6648.7 6650.5 6295.5 6312.9 6325.0 6441.7 6475.5 6333.0 6351.6 6361.8 6370.0 6443.8 6285.2 6291.7 6304.4 6425.3 6454.1 6421.4 6450.3 6526.5 6590.0 6623.6 6245.2 6283.6 6314.7 6316.6 6383.3 11:39:58 INFO - PID 26968 | 11:39:58 INFO - PID 26968 | [#5] yui.html Cycles:180 Average:23713.56 Median:18968.79 stddev:34394.99 (181.3%) stddev-sans-first:34448.74 11:39:58 INFO - PID 26968 | Values: 879.6 889.8 905.7 913.6 923.2 19031.5 20157.9 20227.5 20242.3 20358.3 18139.5 18445.2 18457.0 18642.6 18684.0 943.2 950.9 954.7 955.5 956.5 952.7 958.0 965.3 969.4 971.9 1028.0 1029.1 1047.0 1047.2 1047.4 1025.8 1029.2 1029.9 1031.6 1039.5 754.4 754.9 760.5 760.5 762.3 18906.1 19032.1 19045.7 19098.8 19104.7 21404.9 21586.5 21735.9 21851.0 21868.9 17278.3 17723.6 17732.9 17738.1 17837.7 3674.1 3701.6 3705.1 3708.5 3711.2 137894.0 137926.3 138096.0 139251.0 139650.3 16041.1 16605.5 16630.8 16702.9 16733.7 28093.0 28185.6 28340.0 28398.0 29955.0 8431.7 8598.4 8675.0 8682.9 8683.6 4162.6 4180.8 4211.4 4215.7 4235.3 5280.3 5390.5 5419.7 5446.7 5456.0 1018.9 1040.5 1054.1 1063.1 1065.4 649.8 678.4 678.4 682.3 688.9 10742.9 11142.2 11823.0 12054.3 12349.1 666.1 676.7 680.1 688.2 702.3 5479.8 5538.9 5554.2 5594.4 5688.6 114379.0 119775.0 120079.0 120481.4 122075.0 103659.0 104461.5 106935.0 107425.5 107558.5 88371.6 89114.0 90384.0 90778.0 91728.5 10236.6 10311.0 10414.6 10534.3 10609.5 40826.6 42128.6 42591.1 43028.6 43469.3 54232.2 54849.7 55575.1 55880.2 56238.7 15253.2 15452.3 15619.5 15672.8 15806.2 16838.2 17172.7 17320.7 17329.7 17611.6 15937.7 16172.4 16228.4 16335.4 16345.2 14993.7 15244.4 15351.5 15473.1 15698.0 14815.7 14970.8 15102.2 15179.9 15245.2 11179.7 11187.4 11240.9 11330.0 11356.9 11554.8 11623.2 11664.8 11673.2 11685.1 11:39:58 INFO - PID 26968 | -------- Summary: end -------- 11:39:58 INFO - PID 26968 | 11:39:59 INFO - TEST-INFO | 26968: exit 0 11:39:59 INFO - TEST-OK | dromaeo_css | took 1112157ms 11:39:59 INFO - TEST-START | kraken 11:39:59 INFO - Initialising browser for kraken test... 11:39:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51018/getInfo.html -profile /tmp/tmpfWe6LI/profile 11:39:59 INFO - TEST-INFO | started process 27352 (/builds/slave/test/build/application/firefox/firefox http://localhost:51018/getInfo.html) 11:40:05 INFO - TEST-INFO | 27352: exit 0 11:40:05 INFO - Browser initialized. 11:40:05 INFO - Running cycle 1/1 for kraken test... 11:40:05 INFO - Using env: {'DISPLAY': ':0', 11:40:05 INFO - 'HOME': '/home/cltbld', 11:40:05 INFO - 'JSGC_DISABLE_POISONING': '1', 11:40:05 INFO - 'LANG': 'en_US.UTF-8', 11:40:05 INFO - 'LANGUAGE': 'en_US:en', 11:40:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:40:05 INFO - 'LOGNAME': 'cltbld', 11:40:05 INFO - 'MAIL': '/var/mail/cltbld', 11:40:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:40:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:40:05 INFO - 'MOZ_ACCELERATED': '1', 11:40:05 INFO - 'MOZ_CRASHREPORTER': '1', 11:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:40:05 INFO - 'MOZ_NO_REMOTE': '1', 11:40:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:40:05 INFO - 'MOZ_WEBRENDER': '1', 11:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:05 INFO - 'NO_EM_RESTART': '1', 11:40:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:05 INFO - 'PWD': '/builds/slave/test', 11:40:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:40:05 INFO - 'RUST_BACKTRACE': 'full', 11:40:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:40:05 INFO - 'SHELL': '/bin/bash', 11:40:05 INFO - 'SHLVL': '1', 11:40:05 INFO - 'TERM': 'linux', 11:40:05 INFO - 'TMOUT': '86400', 11:40:05 INFO - 'USER': 'cltbld', 11:40:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039', 11:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:05 INFO - '_': '/tools/buildbot/bin/python'} 11:40:05 INFO - TEST-INFO | started process 27596 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfWe6LI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:05 INFO - PID 27596 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:40:06 INFO - PID 27596 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:40:06 INFO - PID 27596 | 11:40:06 INFO - PID 27596 | (/builds/slave/test/build/application/firefox/firefox:27655): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:40:06 INFO - PID 27596 | 11:40:16 INFO - PID 27596 | RSS: Main: 186540032 11:40:16 INFO - PID 27596 | 11:40:19 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51018/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:20 INFO - PID 27596 | RSS: Main: 188170240 11:40:20 INFO - PID 27596 | 11:40:23 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51018/tests/kraken/driver.html?testName=audio-dft) 11:40:23 INFO - PID 27596 | RSS: Main: 186421248 11:40:23 INFO - PID 27596 | 11:40:26 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51018/tests/kraken/driver.html?testName=audio-fft) 11:40:27 INFO - PID 27596 | RSS: Main: 184508416 11:40:27 INFO - PID 27596 | 11:40:29 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51018/tests/kraken/driver.html?testName=audio-oscillator) 11:40:30 INFO - PID 27596 | RSS: Main: 184745984 11:40:30 INFO - PID 27596 | 11:40:32 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51018/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:32 INFO - PID 27596 | RSS: Main: 186490880 11:40:32 INFO - PID 27596 | 11:40:36 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51018/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:36 INFO - PID 27596 | RSS: Main: 188452864 11:40:36 INFO - PID 27596 | 11:40:40 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51018/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:41 INFO - PID 27596 | RSS: Main: 187256832 11:40:41 INFO - PID 27596 | 11:40:44 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51018/tests/kraken/driver.html?testName=json-parse-financial) 11:40:44 INFO - PID 27596 | RSS: Main: 187760640 11:40:44 INFO - PID 27596 | 11:40:46 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51018/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:46 INFO - PID 27596 | RSS: Main: 187625472 11:40:46 INFO - PID 27596 | 11:40:48 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51018/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:49 INFO - PID 27596 | RSS: Main: 185335808 11:40:49 INFO - PID 27596 | 11:40:51 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51018/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:52 INFO - PID 27596 | RSS: Main: 185454592 11:40:52 INFO - PID 27596 | 11:40:54 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:55 INFO - PID 27596 | RSS: Main: 185765888 11:40:55 INFO - PID 27596 | 11:40:58 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:40:58 INFO - PID 27596 | RSS: Main: 185298944 11:40:58 INFO - PID 27596 | 11:41:00 INFO - PID 27596 | Cycle 1(1): loaded http://localhost:51018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51018/tests/kraken/driver.html?testName=ai-astar) 11:41:01 INFO - PID 27596 | RSS: Main: 187772928 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | __start_tp_report 11:41:01 INFO - PID 27596 | _x_x_mozilla_page_load 11:41:01 INFO - PID 27596 | _x_x_mozilla_page_load_details 11:41:01 INFO - PID 27596 | |i|pagename|runs| 11:41:01 INFO - PID 27596 | |0;ai-astar;114;108;115;107;108;108;112;107;108;112 11:41:01 INFO - PID 27596 | |1;audio-beat-detection;130;119;117;115;116;115;118;122;152;118 11:41:01 INFO - PID 27596 | |2;audio-dft;165;162;162;176;163;168;166;167;166;164 11:41:01 INFO - PID 27596 | |3;audio-fft;81;78;75;83;80;82;74;79;85;81 11:41:01 INFO - PID 27596 | |4;audio-oscillator;79;84;79;80;87;79;89;80;82;79 11:41:01 INFO - PID 27596 | |5;imaging-gaussian-blur;119;115;117;114;118;113;113;114;116;115 11:41:01 INFO - PID 27596 | |6;imaging-darkroom;149;149;152;148;154;155;150;149;149;148 11:41:01 INFO - PID 27596 | |7;imaging-desaturate;96;96;94;95;99;96;100;101;95;94 11:41:01 INFO - PID 27596 | |8;json-parse-financial;60;51;53;54;59;49;52;51;51;53 11:41:01 INFO - PID 27596 | |9;json-stringify-tinderbox;37;38;48;38;44;42;38;37;40;45 11:41:01 INFO - PID 27596 | |10;stanford-crypto-aes;77;73;73;82;78;84;79;78;76;77 11:41:01 INFO - PID 27596 | |11;stanford-crypto-ccm;122;112;127;123;114;111;118;116;110;118 11:41:01 INFO - PID 27596 | |12;stanford-crypto-pbkdf2;168;180;171;176;188;168;171;169;172;169 11:41:01 INFO - PID 27596 | |13;stanford-crypto-sha256-iterative;67;66;63;70;73;67;67;75;66;63 11:41:01 INFO - PID 27596 | __end_tp_report 11:41:01 INFO - PID 27596 | __start_cc_report 11:41:01 INFO - PID 27596 | _x_x_mozilla_cycle_collect,720 11:41:01 INFO - PID 27596 | __end_cc_report 11:41:01 INFO - PID 27596 | __startTimestamp1505846461041__endTimestamp 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | ------- Summary: start ------- 11:41:01 INFO - PID 27596 | Number of tests: 14 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:3.03 (2.8%) stddev-sans-first:2.83 11:41:01 INFO - PID 27596 | Values: 114.0 108.0 115.0 107.0 108.0 108.0 112.0 107.0 108.0 112.0 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#1] audio-beat-detection Cycles:10 Average:122.20 Median:118.50 stddev:11.37 (9.6%) stddev-sans-first:11.70 11:41:01 INFO - PID 27596 | Values: 130.0 119.0 117.0 115.0 116.0 115.0 118.0 122.0 152.0 118.0 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.00 stddev:4.09 (2.5%) stddev-sans-first:4.33 11:41:01 INFO - PID 27596 | Values: 165.0 162.0 162.0 176.0 163.0 168.0 166.0 167.0 166.0 164.0 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#3] audio-fft Cycles:10 Average:79.80 Median:81.00 stddev:3.43 (4.2%) stddev-sans-first:3.61 11:41:01 INFO - PID 27596 | Values: 81.0 78.0 75.0 83.0 80.0 82.0 74.0 79.0 85.0 81.0 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#4] audio-oscillator Cycles:10 Average:81.80 Median:81.00 stddev:3.68 (4.5%) stddev-sans-first:3.76 11:41:01 INFO - PID 27596 | Values: 79.0 84.0 79.0 80.0 87.0 79.0 89.0 80.0 82.0 79.0 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.50 stddev:2.07 (1.8%) stddev-sans-first:1.73 11:41:01 INFO - PID 27596 | Values: 119.0 115.0 117.0 114.0 118.0 113.0 113.0 114.0 116.0 115.0 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:149.50 stddev:2.50 (1.7%) stddev-sans-first:2.60 11:41:01 INFO - PID 27596 | Values: 149.0 149.0 152.0 148.0 154.0 155.0 150.0 149.0 149.0 148.0 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:95.50 stddev:2.50 (2.6%) stddev-sans-first:2.65 11:41:01 INFO - PID 27596 | Values: 96.0 96.0 94.0 95.0 99.0 96.0 100.0 101.0 95.0 94.0 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:3.56 (6.7%) stddev-sans-first:2.83 11:41:01 INFO - PID 27596 | Values: 60.0 51.0 53.0 54.0 59.0 49.0 52.0 51.0 51.0 53.0 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#9] json-stringify-tinderbox Cycles:10 Average:40.70 Median:41.00 stddev:3.86 (9.4%) stddev-sans-first:3.86 11:41:01 INFO - PID 27596 | Values: 37.0 38.0 48.0 38.0 44.0 42.0 38.0 37.0 40.0 45.0 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:3.47 (4.4%) stddev-sans-first:3.67 11:41:01 INFO - PID 27596 | Values: 77.0 73.0 73.0 82.0 78.0 84.0 79.0 78.0 76.0 77.0 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:118.00 stddev:5.61 (4.8%) stddev-sans-first:5.66 11:41:01 INFO - PID 27596 | Values: 122.0 112.0 127.0 123.0 114.0 111.0 118.0 116.0 110.0 118.0 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:171.50 stddev:6.44 (3.8%) stddev-sans-first:6.55 11:41:01 INFO - PID 27596 | Values: 168.0 180.0 171.0 176.0 188.0 168.0 171.0 169.0 172.0 169.0 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:3.92 (5.8%) stddev-sans-first:4.15 11:41:01 INFO - PID 27596 | Values: 67.0 66.0 63.0 70.0 73.0 67.0 67.0 75.0 66.0 63.0 11:41:01 INFO - PID 27596 | -------- Summary: end -------- 11:41:01 INFO - PID 27596 | 11:41:01 INFO - PID 27596 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:41:01 INFO - TEST-INFO | 27596: exit 0 11:41:01 INFO - TEST-OK | kraken | took 62817ms 11:41:01 INFO - SUITE-END | took 1174s 11:41:02 INFO - Completed test suite (00:19:35) 11:41:02 INFO - javascript benchmark 11:41:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8503.34059170223, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3098.1944694379454, 3105.937881242375, 3117.4544454720417, 3118.501039833627, 3124.218945263684, 5997.160397544348, 6235.314115447303, 6252.062190671401, 6259.780907668232, 6266.0, 6150.077488376745, 6169.568130230886, 6225.533085018619, 6265.592736472137, 6266.310705822356, 5681.744321505522, 5724.0, 5737.426257374261, 5755.769769209227, 5767.711614419283, 5721.284839395075, 5730.341010783751, 5784.45047720468, 5818.592698511085, 5832.154337621042, 5702.885942281152, 5796.710164491779, 5818.8254352369495, 5857.531397488191, 5859.267591551056, 877.7427876136509, 5705.286839145107, 5773.3072031356505, 5846.912296315559, 5884.6763428011445, 5657.12314591239, 5662.8301150965535, 5708.400617935098, 5729.541636669098, 5772.451617096369, 6231.813045608594, 6237.688115594247, 6249.031400132987, 6319.936800631981, 6351.87296254077, 6599.175103112111, 6623.701933413008, 6765.086713293692, 6770.052192693027, 6791.185057793047, 6726.428253598401, 6774.322567743236, 6818.249992500871, 6847.17833859935, 6876.759313424006, 6202.782902598433, 6218.5025197984505, 6223.0, 6292.4966002719675, 6310.305866354697, 6733.966330168318, 6839.0425340452375, 6852.725890964405, 6873.862522749517, 6945.652717364213, 6480.4815614750705, 6545.672716364163, 6556.213254409406, 6559.6064236145985, 6571.31001244872, 6509.381608747161, 6565.606063636197, 6612.305707900698, 6664.300248473937, 6699.263081061079, 6694.698738556776, 6776.457883369417, 6778.627175505296, 6781.966090169616, 6785.59286442815, 6717.0, 6734.494912881553, 6790.72837086511, 6800.52396332252, 6816.250212476623, 5110.054639891632, 5222.895542089137, 5246.449122842047, 5252.080885844962, 5326.866828329323, 4599.9080018399445, 4600.5629465200755, 4623.098495793288, 4634.745089020069, 4655.231886738718, 5656.6888821115235, 5692.57305702074, 5701.543876489871, 5733.541316694655, 5738.5982981191755, 6662.167229096363, 6705.530612857053, 6742.561733487308, 6752.763653272112, 6756.898646520306, 5680.14797780328, 5696.572757043238, 5708.71456427177, 5726.026575482178, 5775.33583637887, 5635.267415236075, 5669.31968163823, 5710.371859095496, 5722.484976352148, 5725.0267454531995, 6308.684565771693, 6352.841178970562, 6371.139896114058, 6406.135171751847, 6409.166808314889, 6609.339066093352, 6673.899891501631, 6767.729290828509, 6793.796186114425, 6798.7280508779095, 6388.329225431263, 6450.483961282992, 6488.091667166506, 6495.642739649175, 6511.38141876521, 6603.273639899511, 6611.404973552403, 6691.732330706717, 6703.597784132968, 6708.396244338033, 6594.373534514213, 6684.866302674017, 6689.665516724047, 6780.355866192901, 6780.491463140185, 6489.7404103835315, 6524.804255872332, 6557.442617377576, 6597.373249541478, 6605.372489613479, 6501.8699626008165, 6515.218173819172, 6539.542232043711, 6559.048937903882, 6580.638064906285, 6437.195350581177, 6444.967775161094, 6463.515236357198, 6527.086207930988, 6539.673016349068, 6431.678416079271, 6526.967365163334, 6614.933850661432, 6629.834254143685, 6674.466042716668, 6191.938080619317, 6301.464375528131, 6387.552871298964, 6393.552451328363, 6466.159399278252], "value": 6061.681786817254, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [865.6667183134496, 871.6295574380887, 877.1009715042077, 887.9911200887989, 891.1445012787724, 40149.19701605966, 41024.179516409655, 41603.58396416035, 41765.955851103776, 41818.0, 38053.61946380536, 38423.231535369276, 38437.80781096098, 38477.03807404816, 38486.807565962205, 7136.215016348197, 7145.749898753532, 7215.963920180392, 7249.891251631229, 7261.382782463497, 7060.858782824341, 7183.030290910739, 7191.568505889663, 7194.28057194279, 7217.927820721804, 7154.964225178893, 7183.066201393812, 7188.2811718828225, 7767.223277672244, 8003.439759216857, 7878.4485086044, 7926.0, 7929.326007289387, 7933.603319834014, 7943.165967573437, 7763.146053934062, 7862.449628526006, 7904.486208396494, 7906.248906353887, 7914.0503139623615, 37140.07149821276, 37301.81349093264, 37863.0, 37869.62130378689, 38078.42882356767, 3471.687548120656, 3506.3513250048823, 3519.0674471265133, 3526.576810782697, 3532.7350448716447, 31171.53242701361, 31197.064088077168, 31296.37407251865, 31387.37225255505, 31599.84200079008, 5098.5411312982005, 5115.053715062688, 5122.103631864409, 5134.743262836881, 5190.247414124969, 182201.0, 185310.0, 186785.0, 195532.0, 197004.01497992562, 45995.77002115035, 46008.53991460043, 46029.539704603194, 46129.077418452114, 46150.5384946153, 47169.933954292865, 47254.5274547257, 47322.05355892863, 47747.761261194166, 47775.04449911052, 15820.841791582166, 15868.285927133307, 15911.0, 15940.442084526985, 15942.840571594368, 13070.0, 13158.539451119164, 13214.933925330311, 13297.26865022433, 13305.401256943267, 13105.672358191121, 13118.672033199246, 13231.73536529264, 13272.867271327163, 13293.202407855366, 5420.810271640474, 5583.748731307101, 5596.656802367484, 5633.971830140905, 5651.321841379061, 976.4190306767604, 1007.4459047523833, 1014.2443879309961, 1022.5705203814416, 1025.3130402630256, 22931.0, 22967.88516057409, 22975.770242297363, 23265.302040938797, 23278.65082023771, 1109.4840898982013, 1118.3513562133942, 1125.5047778977223, 1129.1474936422949, 1133.7845809296207, 11984.52061917531, 12292.877071229173, 12350.75298494025, 12392.81410778839, 12404.25574465535, 215374.0, 217693.0, 217897.0, 217966.0, 218962.0, 49556.75221623869, 49917.25124123141, 50238.0, 50491.747541262055, 50530.49469505331, 1377.1668140774686, 1441.7332793433247, 1443.1124858212333, 1443.3577058209205, 1453.3459943025468, 22117.33647990563, 22416.663750043437, 22574.20990265333, 22767.772322276564, 22951.196708115804, 36114.27771444609, 36116.63883361133, 36158.638413615525, 36195.276094477435, 36374.45438318374, 182294.0, 182721.0863945672, 183250.0, 183532.08233958745, 184286.0, 29518.55722164212, 30168.69831301659, 32614.184645384055, 32619.34761304808, 32706.83646581752, 41602.58397415987, 42269.577304226565, 42320.57679423167, 42433.5756642442, 42892.78553607212, 31070.53394199134, 31276.687233128287, 31410.528842067844, 31590.52614210743, 31596.210094747814, 31124.0, 31150.844245778626, 31249.531257030707, 31338.686613133577, 31463.84268078645, 33807.66192338045, 34373.140671483416, 34991.65008349986, 35000.12499687528, 35180.12049698778, 30409.695903040687, 30437.847810760806, 30663.386732264782, 30673.233169170056, 31356.52965205478, 23082.422939426648, 23327.300180994596, 23421.297361079196, 23605.52788944177, 23772.524549508566], "value": 16733.740533116357, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.1589263782239, 576.4293349583911, 582.9970850145746, 583.9503642190414, 586.9530437564994, 21887.890560547214, 22708.0, 22780.0, 22857.31428057157, 22890.65664015041, 23226.65160022601, 24166.51666966664, 24183.153589624366, 24453.510929781394, 24496.510069798638, 6392.264889537704, 6569.080328753978, 6579.309172536887, 6584.868302633944, 6584.93415065848, 6409.230892292908, 6454.5159113066475, 6482.0, 6507.219133703962, 6511.706973186218, 6272.937270627281, 6472.061551075091, 6598.967005164967, 6603.438707709851, 6610.537262391635, 6487.41613254807, 6513.0, 6520.608763474207, 6528.988006858945, 6541.705623246941, 5992.79025234119, 6044.24446944132, 6091.695415229221, 6092.817215483543, 6098.024316109401, 26537.336566585796, 27675.446491070266, 27744.722552774616, 27827.860860695768, 27857.86071069652, 2021.2218295956015, 2062.1339037604243, 2065.3390914907236, 2067.173130747698, 2069.4102180878376, 18498.722519162224, 18969.43091707251, 19130.139143738565, 19175.712364314546, 19289.131989060526, 2395.6406539019285, 2456.987715061431, 2461.803055755553, 2483.4412257242157, 2488.1042824583137, 122668.38665806703, 129735.0, 142542.0, 144821.2758936209, 145717.0, 20043.799562004195, 20365.490862728253, 20948.895255523625, 21002.36992890185, 21644.78355216459, 40549.18901621951, 41090.58909410868, 41117.79441102775, 41156.176876462305, 41182.1763564727, 11397.658070257905, 11450.599229026944, 11508.769824603462, 11534.500514933005, 11568.595099171489, 9650.179734722627, 9693.418394896187, 9758.560864761102, 9779.902200978042, 9815.950920245354, 10840.457977101114, 11212.70620395172, 11316.0, 11444.0, 11613.129015323884, 3662.887181882331, 4127.318992366226, 4169.624733773975, 4277.593628605277, 4313.266744653416, 938.9953050234706, 957.4494665567327, 969.6363863551169, 970.2044323654535, 989.8564708117427, 18743.625127497373, 18960.14679339433, 19270.518237044187, 19313.4205973821, 19549.120289587, 1041.5417216424748, 1045.1429827541494, 1050.1231471721046, 1055.0715370473933, 1058.6506452870535, 10512.789744205073, 10618.150547956146, 10938.124950003981, 10963.890361096286, 11015.28400653971, 483858.0, 489592.0, 490778.0, 496072.0, 521013.0, 111543.0, 112459.0, 113126.0, 113132.43433782943, 113839.0, 1149.408054851752, 1163.7381589142544, 1178.2871362825538, 1188.9405529723479, 1190.2739329009298, 16766.832331676527, 16870.240839162023, 17110.914445427694, 17398.39105631297, 17409.303627854744, 53783.193252102035, 55347.0, 55499.445005551046, 56158.43841561532, 56565.43434565602, 69323.0, 69872.0, 70448.64775676088, 71412.0, 72084.63957680178, 19557.511062222988, 19615.31346402869, 19623.0, 19666.311679091163, 19697.212111515953, 21743.56512869702, 22038.88980555087, 22177.556448870608, 22189.77810221877, 22231.666525001816, 17620.64758704793, 17776.555586109935, 17904.10479476047, 18060.277588896297, 18211.817881821542, 15342.923285383502, 15955.441559545361, 16090.758638620197, 16094.356225751308, 16115.0, 17656.91171544134, 17943.102844857443, 18182.81817181811, 18226.088695565435, 18357.816421836145, 19119.0, 19156.52108697238, 19234.903825481342, 19246.518837028627, 19528.90235548813, 17439.651206975537, 17604.73592896082, 17797.377091801725, 17819.554511137325, 18056.277748889897], "value": 12585.19257911003, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.086963690598, 1391.916485010899, 1402.4810819996596, 1407.3385508810854, 1408.8027676125341, 14869.62825929351, 15437.768433473508, 15586.454474093409, 15591.610209744747, 15606.375744970188, 15137.167455789928, 15226.771598426032, 15257.694846103072, 15269.312880920357, 15271.6945661087, 2733.7949653775945, 2751.55975043993, 2800.7339302766204, 2802.2574017885277, 2802.5936239245298, 2726.086760935089, 2766.986165069172, 2780.33272014716, 2785.610014597958, 2787.456445993032, 2737.9726202737916, 2748.1206014075506, 2767.681716602586, 2769.4461107778425, 2786.3730660601304, 2666.2134670272317, 2672.038066296132, 2698.042195020759, 2705.6753189617175, 2706.052881491482, 2584.819062665614, 2586.6249393837975, 2600.2199340198054, 2603.3231359846577, 2619.738026197384, 14461.71076578473, 14497.710045799025, 14532.854671453257, 14614.050086744328, 14680.119192848357, 7742.225777422269, 7950.642221100006, 8024.3580513559355, 8031.558264295461, 8039.799005024863, 5107.412647545542, 5227.398849132361, 5396.973015134939, 5506.091494903336, 5510.889782204334, 1984.3848406993734, 1985.2753744883014, 1993.9401817945484, 2027.8479114066504, 2047.0890453748088, 22995.77004229953, 23615.173468928504, 23660.0, 25568.0, 26128.86935565329, 7143.499595254956, 7243.022192004012, 7322.926770732331, 7371.852562948711, 7389.667464963982, 19898.801011989985, 20122.0, 20126.19495220175, 20141.49646258826, 20167.294144704865, 8190.303824175012, 8260.545669988209, 8303.169683031649, 8310.21052999964, 8312.127226641116, 7164.319389657974, 7450.2549745026145, 7474.962625186839, 7513.774586762406, 7585.506942048749, 5480.177973304037, 5675.716214189274, 5695.629784064023, 5750.338711048199, 5750.5112065474905, 1744.3109971561162, 1767.3814165042133, 1810.6650269699885, 1828.4880233534632, 1829.9268029278946, 887.5650931043871, 903.2548147778109, 916.0152835701514, 922.3773952582114, 936.1621348892703, 8170.632321545545, 8454.535000574904, 8480.448770829877, 8500.404971651926, 8587.699430519902, 682.9146356705412, 729.095921057895, 734.3574372424129, 734.9963250183715, 735.3308489274734, 4657.347971284023, 4661.974365639554, 4725.621950243973, 4750.216214324598, 4756.904861902743, 20962.685559716618, 22012.889935550542, 22094.22670206535, 22163.556728865657, 22226.666600001012, 20684.58630827375, 21567.2451464198, 21671.241506547194, 21782.45543861416, 21845.235416760337, 10422.426766527913, 10540.367577945348, 10724.14206863449, 10734.57061717538, 10884.129269658408, 8152.388570857091, 8210.466319689202, 8222.671093156207, 8228.50628962264, 8407.915920840713, 17624.0, 17962.640747185244, 18286.72569911479, 18637.347692830685, 18784.53038674044, 19162.7125593119, 19288.614227715647, 19831.900840495706, 19927.900360498104, 20239.089240984486, 11870.821937671115, 12113.333766642567, 12181.147319687538, 12244.142909996572, 12267.447964841782, 13795.655108622364, 13869.445222191, 13940.58178254654, 13947.930260348634, 13970.860291396955, 11461.4269286537, 11508.59719909799, 11727.648170554898, 11767.058635309326, 11896.583619573274, 11308.943455282671, 11386.373749443861, 11453.141014423785, 11564.942175289407, 11623.244489108181, 9796.118349348593, 9847.310688251753, 9902.0, 9927.602895884083, 9961.252906032221, 6999.160100787938, 7088.291170882871, 7102.538335008208, 7219.169795473378, 7228.457865660202, 6823.454123669995, 6860.0, 6928.0, 6931.237563868071, 7013.859722805618], "value": 6710.370234820549, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.5768365890382, 505.2961790078721, 518.468569716041, 522.5453855146023, 526.2579762534826, 6174.629522228669, 6237.220347456568, 6253.187085678861, 6259.374062593744, 6276.435120839124, 6057.42454466825, 6191.783287584935, 6224.937750622493, 6228.750849966007, 6289.528285378604, 5158.690478571289, 5184.53339199472, 5202.687838729688, 5216.191490318987, 5221.843344699646, 5171.922421163686, 5196.350456192976, 5217.869553261161, 5222.764975576109, 5226.817061402851, 4705.976470117662, 4920.23736320869, 5033.11920413928, 5104.285400043997, 5163.664361816489, 4922.704637721748, 4956.801727930879, 4973.129702302119, 4988.5260900214425, 5005.224190250498, 4403.64770818337, 4448.777561121931, 4450.955490445119, 4452.265376212921, 4478.641708663299, 5960.754536008329, 6080.543959203077, 6088.908666370008, 6121.846953826145, 6121.877562448726, 5643.576731745095, 5689.9146512802345, 5699.0, 5710.543156547507, 5747.856303592402, 6462.450691691165, 6501.609903405763, 6552.803415897531, 6558.770443034518, 6587.473002159863, 4660.300954856799, 4830.130576496229, 4852.684575502616, 4883.511648835088, 4893.975530122327, 6609.570377925419, 6663.333666633298, 6692.795296846566, 6719.697613607399, 6784.694688739019, 4970.329005584272, 4975.203967365204, 4979.178435558092, 5008.073506401327, 5034.8237811677145, 5021.246812978009, 5040.59675225981, 5062.341895553554, 5066.923996140061, 5088.414832294334, 5570.721463926869, 5590.888182236333, 5633.774649014075, 5642.85892852682, 5704.543636509069, 6471.288158302583, 6525.955847064447, 6535.411812936859, 6595.307492713196, 6609.1408116944485, 1721.5868191634167, 1734.7051001329805, 1762.1805860275033, 1762.3038899634573, 1765.435060780538, 1159.3739380734478, 1194.1103877611063, 1207.1007099710596, 1231.9630411087683, 1257.8930790882694, 5575.1915972184615, 5611.130274807411, 5629.395622247722, 5632.52123569493, 5670.432956704297, 6335.334789847, 6508.934910650928, 6554.868902621921, 6588.0, 6592.24189218246, 5480.808171713971, 5530.5299049580435, 5545.057340252167, 5633.915491267634, 5679.393585073508, 3519.7184225261917, 3524.9685270667205, 3527.976886702879, 3535.876244331436, 3543.698785603201, 6307.161777200278, 6378.394052564999, 6391.296957334689, 6395.456386207225, 6457.966725323926, 6784.219814721271, 6854.760083397057, 6909.309069093151, 6911.930880691129, 6916.723331066802, 5924.7333869975955, 6324.747010119544, 6341.365863413622, 6356.713947872449, 6409.903851442232, 6348.682565871595, 6496.252930913006, 6593.472522198117, 6670.0, 6700.49746269022, 6449.9355006451215, 6508.656883522023, 6603.570767900071, 6673.632950187786, 6675.6995935184, 6202.5658203925295, 6325.873482530232, 6356.459700925473, 6372.299047104908, 6373.681315934277, 4852.878678033077, 4944.554990050912, 4950.851474455772, 4962.900741985212, 5235.345581802275, 6569.343065693583, 6574.211094668479, 6642.83392915181, 6648.7340506379205, 6650.536881885977, 6295.527835412271, 6312.905306420315, 6325.0, 6441.677916104082, 6475.481961443167, 6332.968335158294, 6351.555391122762, 6361.777337793155, 6370.044493326038, 6443.838904027437, 6285.182926219745, 6291.685415729104, 6304.369563043659, 6425.325340839145, 6454.128692626436, 6421.357864213728, 6450.258220304725, 6526.477881769542, 6590.0, 6623.635700036544, 6245.18812554365, 6283.617604127085, 6314.747410103544, 6316.589421687576, 6383.297837237993], "value": 5015.344525737359, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.56461551532, 889.7820034091646, 905.714699869541, 913.5980168725764, 923.1599244687334, 19031.52421189471, 20157.899210503947, 20227.494312642153, 20242.29151979681, 20358.287459938925, 18139.45581632553, 18445.169967351467, 18457.0, 18642.627147457042, 18684.0, 943.2406912435487, 950.9429434233933, 954.6897258391016, 955.4888134847857, 956.5312996631635, 952.6522819170988, 958.0276019839833, 965.3146266151041, 969.3747532841313, 971.9076687714692, 1027.9537420816082, 1029.0892560084305, 1046.9842952355682, 1047.193660881125, 1047.4291511126455, 1025.8204814157568, 1029.2280789407944, 1029.927905046647, 1031.5512751952888, 1039.50103950104, 754.4266357568233, 754.9169591344947, 760.4752720622753, 760.5360729954723, 762.3177256355531, 18906.05469726522, 19032.143553540125, 19045.7143142853, 19098.80901190984, 19104.713429298572, 21404.89297553518, 21586.460338491506, 21735.891320543455, 21851.016704248348, 21868.89065554662, 17278.30886764528, 17723.556911077198, 17732.91133544324, 17738.11309434536, 17837.732434013502, 3674.1365779041903, 3701.61133081028, 3705.073731567108, 3708.517892673935, 3711.164987877733, 137894.0, 137926.31036844852, 138096.0, 139251.0, 139650.30174849162, 16041.117738524494, 16605.50183494497, 16630.75053874193, 16702.916485417496, 16733.66532669364, 28093.0, 28185.57721634177, 28340.00809971641, 28398.0, 29955.0, 8431.747047588582, 8598.441101328519, 8675.0, 8682.913170868336, 8683.56582170889, 4162.604552567501, 4180.8118634660905, 4211.389348544505, 4215.747055176699, 4235.343521754133, 5280.339957505312, 5390.54180394663, 5419.701916394557, 5446.727663616883, 5455.972720136374, 1018.9082982531608, 1040.5213601743133, 1054.1040115901576, 1063.0645032371463, 1065.387402243713, 649.7595889520908, 678.4097834883682, 678.4165617568887, 682.3347236444426, 688.8932215506604, 10742.946285268523, 11142.220044596963, 11823.0, 12054.276743395425, 12349.073819463576, 666.120720648739, 676.6549059979347, 680.1022650101917, 688.2119972631309, 702.2731472925498, 5479.75341109651, 5538.9169162462595, 5554.1946417769195, 5594.384617692051, 5688.5733569981585, 114379.0, 119775.0, 120079.0, 120481.39759301147, 122075.0, 103659.0, 104461.47769261105, 106935.0, 107425.4628726867, 107558.46220768846, 88371.55814220887, 89114.0, 90384.0, 90778.0, 91728.54135729278, 10236.590536378462, 10311.0, 10414.635487757892, 10534.315269507457, 10609.469526523797, 40826.591734083464, 42128.57871421247, 42591.14817703691, 43028.56971430246, 43469.347959779996, 54232.18651720149, 54849.725751370985, 55575.05487307925, 55880.161797572255, 56238.718806405705, 15253.16107614092, 15452.3002469726, 15619.453319133776, 15672.843271567595, 15806.209689515708, 16838.158092095593, 17172.742408864127, 17320.65358692794, 17329.653406932044, 17611.64776704433, 15937.68124637524, 16172.353105875633, 16228.432004879773, 16335.428260010842, 16345.182740862672, 14993.700125997637, 15244.390224391344, 15351.539453816404, 15473.148976806384, 15698.0, 14815.703685926437, 14970.775438368215, 15102.169380684169, 15179.924100379427, 15245.16151611672, 11179.72050698739, 11187.384693841917, 11240.887591123985, 11330.036946859609, 11356.94321528387, 11554.839223177385, 11623.186376953532, 11664.825027624762, 11673.241239319417, 11685.065194784567], "value": 8798.686222086497, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1451.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 115.0, 107.0, 108.0, 108.0, 112.0, 107.0, 108.0, 112.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 119.0, 117.0, 115.0, 116.0, 115.0, 118.0, 122.0, 152.0, 118.0], "value": 122.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 176.0, 163.0, 168.0, 166.0, 167.0, 166.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 75.0, 83.0, 80.0, 82.0, 74.0, 79.0, 85.0, 81.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 79.0, 80.0, 87.0, 79.0, 89.0, 80.0, 82.0, 79.0], "value": 81.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 115.0, 117.0, 114.0, 118.0, 113.0, 113.0, 114.0, 116.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 152.0, 148.0, 154.0, 155.0, 150.0, 149.0, 149.0, 148.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 94.0, 95.0, 99.0, 96.0, 100.0, 101.0, 95.0, 94.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 51.0, 53.0, 54.0, 59.0, 49.0, 52.0, 51.0, 51.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 48.0, 38.0, 44.0, 42.0, 38.0, 37.0, 40.0, 45.0], "value": 40.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 73.0, 82.0, 78.0, 84.0, 79.0, 78.0, 76.0, 77.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 112.0, 127.0, 123.0, 114.0, 111.0, 118.0, 116.0, 110.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 180.0, 171.0, 176.0, 188.0, 168.0, 171.0, 169.0, 172.0, 169.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 63.0, 70.0, 73.0, 67.0, 67.0, 75.0, 66.0, 63.0], "value": 67.7, "unit": "score"}]}]} 11:41:02 INFO - Return code: 0 11:41:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:41:02 INFO - # TBPL SUCCESS # 11:41:02 INFO - Running post-action listener: _package_coverage_data 11:41:02 INFO - Running post-action listener: _resource_record_post_action 11:41:02 INFO - [mozharness: 2017-09-19 18:41:02.323326Z] Finished run-tests step (success) 11:41:02 INFO - Running post-run listener: _resource_record_post_run 11:41:02 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 345706496; Read time: 8; Write time: 256668 11:41:02 INFO - TinderboxPrint: CPU usage
13.3% 11:41:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:41:02 INFO - TinderboxPrint: I/O write bytes / time
345,706,496 / 256,668 11:41:02 INFO - TinderboxPrint: CPU idle
8,244.6 (86.7%) 11:41:02 INFO - TinderboxPrint: CPU user
1,200.3 (12.6%) 11:41:02 INFO - TinderboxPrint: Swap in / out
0 / 0 11:41:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13123584; Read time: 0; Write time: 1676 11:41:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:41:02 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 332582912; Read time: 0; Write time: 254992 11:41:02 INFO - Running post-run listener: _upload_blobber_files 11:41:02 INFO - Blob upload gear active. 11:41:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:41:02 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 11:41:02 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'] 11:41:02 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 11:41:03 INFO - (blobuploader) - INFO - Open directory for files ... 11:41:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:41:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:41:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:06 INFO - (blobuploader) - INFO - Done attempting. 11:41:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:41:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:41:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:07 INFO - (blobuploader) - INFO - Done attempting. 11:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:11 INFO - (blobuploader) - INFO - Done attempting. 11:41:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:41:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:41:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:12 INFO - (blobuploader) - INFO - Done attempting. 11:41:12 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:12 INFO - Return code: 0 11:41:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fb452caed367054bba864c6fa1d2e6e0cb542935e19876a8905e3bcf751e88c0b10810c07aa9a68ed7e6d1dd5c006797c5f7c85dea2e44ecfb55d5a8ba38ffe", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2b819733be9ea5031efcc5732b286b42c476e8e2a7b9dfcc28553c038409a27ca4c456c79f98284079a4df25f8417610284987b1c8bd07917528272b543a72f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc9afac267ffdd5154a3333f1c15a383ed7f1ddc9811012f10df71b4217bfbd0dd9f2f33b403dfdc8380c6b604d3411ecd2cb4f3d75747d0012b6251370c73e9", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7c356608f1cae64305b019b4b07aa55e83d15fa8e83aa1ccf994889907057f9296a99de3eca92be357f80c1176538cdfd0e2119f1eb24e0473d7f42eab97175"} 11:41:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:12 INFO - Contents: 11:41:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fb452caed367054bba864c6fa1d2e6e0cb542935e19876a8905e3bcf751e88c0b10810c07aa9a68ed7e6d1dd5c006797c5f7c85dea2e44ecfb55d5a8ba38ffe", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2b819733be9ea5031efcc5732b286b42c476e8e2a7b9dfcc28553c038409a27ca4c456c79f98284079a4df25f8417610284987b1c8bd07917528272b543a72f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc9afac267ffdd5154a3333f1c15a383ed7f1ddc9811012f10df71b4217bfbd0dd9f2f33b403dfdc8380c6b604d3411ecd2cb4f3d75747d0012b6251370c73e9", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7c356608f1cae64305b019b4b07aa55e83d15fa8e83aa1ccf994889907057f9296a99de3eca92be357f80c1176538cdfd0e2119f1eb24e0473d7f42eab97175"} 11:41:12 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:12 INFO - Copying logs to upload dir... 11:41:12 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.050704 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-19 11:41:12.506622) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 11:41:12.514230) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fb452caed367054bba864c6fa1d2e6e0cb542935e19876a8905e3bcf751e88c0b10810c07aa9a68ed7e6d1dd5c006797c5f7c85dea2e44ecfb55d5a8ba38ffe", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2b819733be9ea5031efcc5732b286b42c476e8e2a7b9dfcc28553c038409a27ca4c456c79f98284079a4df25f8417610284987b1c8bd07917528272b543a72f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc9afac267ffdd5154a3333f1c15a383ed7f1ddc9811012f10df71b4217bfbd0dd9f2f33b403dfdc8380c6b604d3411ecd2cb4f3d75747d0012b6251370c73e9", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7c356608f1cae64305b019b4b07aa55e83d15fa8e83aa1ccf994889907057f9296a99de3eca92be357f80c1176538cdfd0e2119f1eb24e0473d7f42eab97175"} build_url:https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011247 build_url: 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fb452caed367054bba864c6fa1d2e6e0cb542935e19876a8905e3bcf751e88c0b10810c07aa9a68ed7e6d1dd5c006797c5f7c85dea2e44ecfb55d5a8ba38ffe", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2b819733be9ea5031efcc5732b286b42c476e8e2a7b9dfcc28553c038409a27ca4c456c79f98284079a4df25f8417610284987b1c8bd07917528272b543a72f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc9afac267ffdd5154a3333f1c15a383ed7f1ddc9811012f10df71b4217bfbd0dd9f2f33b403dfdc8380c6b604d3411ecd2cb4f3d75747d0012b6251370c73e9", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7c356608f1cae64305b019b4b07aa55e83d15fa8e83aa1ccf994889907057f9296a99de3eca92be357f80c1176538cdfd0e2119f1eb24e0473d7f42eab97175"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 11:41:12.543759) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:41:12.544106) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1505839603.961537-180709039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:41:12.626676) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 11:41:12.629994) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 11:41:12.630296) ========= ========= Total master_lag: 0.25 =========