builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1505598470.68 results: success (0) revision: 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 14:47:50.679295) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 14:47:50.679726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 14:47:50.679992) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 14:47:50.698011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:47:50.698304) ========= 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=a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 14:47:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.3M=0s 2017-09-16 14:47:51 (44.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:47:50.818523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:47:50.818837) ========= 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=a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019866 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:47:50.873347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 14:47:50.873678) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 --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 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 --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=a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 14:47:51,316 truncating revision to first 12 chars 2017-09-16 14:47:51,316 Setting DEBUG logging. 2017-09-16 14:47:51,316 attempt 1/10 2017-09-16 14:47:51,316 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45b63125a430?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 14:47:52,262 unpacking tar archive at: mozilla-central-45b63125a430/testing/mozharness/ program finished with exit code 0 elapsedTime=1.242818 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 14:47:52.136743) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 14:47:52.137054) ========= script_repo_revision: 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 14:47:52.137423) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 14:47:52.137698) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 14:47:52.156379) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-16 14:47:52.156727) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:47:52 INFO - MultiFileLogger online at 20170916 14:47:52 in /builds/slave/test 14:47:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:47:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:47:52 INFO - {'append_to_log': False, 14:47:52 INFO - 'base_work_dir': '/builds/slave/test', 14:47:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:47:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:47:52 INFO - 'branch': 'Firefox-Non-PGO', 14:47:52 INFO - 'buildbot_json_path': 'buildprops.json', 14:47:52 INFO - 'code_coverage': False, 14:47:52 INFO - 'config_files': ('talos/linux_config.py',), 14:47:52 INFO - 'default_actions': ('clobber', 14:47:52 INFO - 'read-buildbot-config', 14:47:52 INFO - 'download-and-extract', 14:47:52 INFO - 'populate-webroot', 14:47:52 INFO - 'create-virtualenv', 14:47:52 INFO - 'install', 14:47:52 INFO - 'setup-mitmproxy', 14:47:52 INFO - 'run-tests'), 14:47:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:47:52 INFO - 'disable_ccov_upload': False, 14:47:52 INFO - 'disable_stylo': False, 14:47:52 INFO - 'download_minidump_stackwalk': True, 14:47:52 INFO - 'download_symbols': 'ondemand', 14:47:52 INFO - 'enable_stylo': False, 14:47:52 INFO - 'enable_webrender': False, 14:47:52 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 14:47:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:47:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:47:52 INFO - 'gecko_profile': False, 14:47:52 INFO - 'gecko_profile_interval': 0, 14:47:52 INFO - 'installer_path': 'installer.exe', 14:47:52 INFO - 'log_level': 'info', 14:47:52 INFO - 'log_name': 'talos', 14:47:52 INFO - 'log_to_console': True, 14:47:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:47:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:47:52 INFO - 'opt_config_files': (), 14:47:52 INFO - 'pip_index': False, 14:47:52 INFO - 'suite': 'dromaeojs-e10s', 14:47:52 INFO - 'system_bits': '32', 14:47:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:47:52 INFO - 'title': 'talos-linux64-ix-002', 14:47:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:47:52 INFO - 'use_talos_json': True, 14:47:52 INFO - 'verify': 'False', 14:47:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:47:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:47:52 INFO - 'work_dir': 'build'} 14:47:52 INFO - [mozharness: 2017-09-16 21:47:52.747030Z] Running clobber step. 14:47:52 INFO - Running pre-action listener: _resource_record_pre_action 14:47:52 INFO - Running main action method: clobber 14:47:52 INFO - rmtree: /builds/slave/test/build 14:47:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:47:53 INFO - Running post-action listener: _resource_record_post_action 14:47:53 INFO - [mozharness: 2017-09-16 21:47:53.779242Z] Finished clobber step (success) 14:47:53 INFO - [mozharness: 2017-09-16 21:47:53.779339Z] Running read-buildbot-config step. 14:47:53 INFO - Running pre-action listener: _resource_record_pre_action 14:47:53 INFO - Running main action method: read_buildbot_config 14:47:53 INFO - Using buildbot properties: 14:47:53 INFO - { 14:47:53 INFO - "project": "", 14:47:53 INFO - "product": "firefox", 14:47:53 INFO - "who": "ryanvm@gmail.com", 14:47:53 INFO - "installer_path": "public/build/target.tar.bz2", 14:47:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:47:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:47:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:47:53 INFO - "stage_platform": "linux64", 14:47:53 INFO - "basedir": "/builds/slave/test", 14:47:53 INFO - "buildnumber": 835, 14:47:53 INFO - "platform": "ubuntu64_hw", 14:47:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:47:53 INFO - "slavebuilddir": "test", 14:47:53 INFO - "taskId": "W-tGjvX6RaO5zf0dzowu8g", 14:47:53 INFO - "branch": "mozilla-central", 14:47:53 INFO - "script_repo_revision": "production", 14:47:53 INFO - "revision": "45b63125a4301eb89e7a4d70d0da1c650f11c7e4", 14:47:53 INFO - "slavename": "talos-linux64-ix-002", 14:47:53 INFO - "repo_path": "mozilla-central" 14:47:53 INFO - } 14:47:53 INFO - Finding installer, test and symbols from parent task. 14:47:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W-tGjvX6RaO5zf0dzowu8g'}, attempt #1 14:47:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W-tGjvX6RaO5zf0dzowu8g'}, attempt #1 14:47:54 INFO - Task dependencies: YmktQZGVQlizREbTDMsobw 14:47:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw'}, attempt #1 14:47:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2 14:47:55 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.test_packages.json 14:47:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.crashreporter-symbols.zip 14:47:55 INFO - Running post-action listener: _resource_record_post_action 14:47:55 INFO - [mozharness: 2017-09-16 21:47:55.166299Z] Finished read-buildbot-config step (success) 14:47:55 INFO - [mozharness: 2017-09-16 21:47:55.166516Z] Running download-and-extract step. 14:47:55 INFO - Running pre-action listener: _resource_record_pre_action 14:47:55 INFO - Running main action method: download_and_extract 14:47:55 INFO - mkdir: /builds/slave/test/build/tests 14:47: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')]} 14:47:55 INFO - trying https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.test_packages.json 14:47:55 INFO - Downloading https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:47:55 INFO - Downloaded 989 bytes. 14:47:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:47:55 INFO - Using the following test package requirements: 14:47:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:47:55 INFO - u'common': [u'target.common.tests.zip'], 14:47:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:47:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:47:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:47:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:47:55 INFO - u'mozbase': [u'target.common.tests.zip'], 14:47:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:47:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:47:55 INFO - u'web-platform': [u'target.common.tests.zip', 14:47:55 INFO - u'target.web-platform.tests.tar.gz'], 14:47:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:47:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 14:47:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.common.tests.zip 14:47:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:47:55 INFO - Fetch https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.common.tests.zip into memory 14:47:56 INFO - Content-Length response header: 54731132 14:47:56 INFO - Bytes received: 54731132 14:48:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.talos.tests.zip 14:48:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:48:07 INFO - Fetch https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.talos.tests.zip into memory 14:48:08 INFO - Content-Length response header: 14508748 14:48:08 INFO - Bytes received: 14508748 14:48: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')]} 14:48:08 INFO - trying https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2 14:48:08 INFO - Downloading https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:48:09 INFO - Downloaded 61464140 bytes. 14:48:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2 14:48:09 INFO - mkdir: /builds/slave/test/properties 14:48:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:48:09 INFO - Writing to file /builds/slave/test/properties/build_url 14:48:09 INFO - Contents: 14:48:09 INFO - build_url:https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2 14:48:09 INFO - Running post-action listener: _resource_record_post_action 14:48:09 INFO - Running post-action listener: find_tests_for_verification 14:48:09 INFO - Running post-action listener: set_extra_try_arguments 14:48:09 INFO - [mozharness: 2017-09-16 21:48:09.880813Z] Finished download-and-extract step (success) 14:48:09 INFO - [mozharness: 2017-09-16 21:48:09.880970Z] Running populate-webroot step. 14:48:09 INFO - Running pre-action listener: _resource_record_pre_action 14:48:09 INFO - Running main action method: populate_webroot 14:48:09 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:48:09 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:09 INFO - 'tests': ['tresize', 14:48:09 INFO - 'tcanvasmark']}, 14:48:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:48:09 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:09 INFO - 'tests': ['dromaeo_css', 14:48:09 INFO - 'kraken']}, 14:48:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:48:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:09 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:48:09 INFO - 'talos_options': ['--disable-stylo'], 14:48:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:48:09 INFO - 'tests': ['damp', 'tps']}, 14:48:09 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:48:09 INFO - 'talos_options': ['--disable-stylo'], 14:48:09 INFO - 'tests': ['damp', 'tps']}, 14:48:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:48:09 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:09 INFO - 'tests': ['dromaeo_dom']}, 14:48:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:48:09 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:09 INFO - 'tests': ['basic_compositor_video', 14:48:09 INFO - 'glvideo']}, 14:48:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:48:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:48:09 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:48:09 INFO - 'talos_options': ['--disable-stylo'], 14:48:09 INFO - 'tests': ['ts_paint_webext', 14:48:09 INFO - 'tp5o_webext']}, 14:48:09 INFO - 'other-e10s': {'tests': ['a11yr', 14:48:09 INFO - 'ts_paint', 14:48:09 INFO - 'tpaint', 14:48:09 INFO - 'sessionrestore', 14:48:09 INFO - 'sessionrestore_many_windows', 14:48:09 INFO - 'sessionrestore_no_auto_restore', 14:48:09 INFO - 'tabpaint']}, 14:48:09 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:09 INFO - 'tests': ['a11yr', 14:48:09 INFO - 'ts_paint', 14:48:09 INFO - 'tpaint', 14:48:09 INFO - 'sessionrestore', 14:48:09 INFO - 'sessionrestore_many_windows', 14:48:09 INFO - 'sessionrestore_no_auto_restore', 14:48:09 INFO - 'tabpaint']}, 14:48:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:48:09 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 14:48:09 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:09 INFO - 'tests': ['perf_reftest_singletons']}, 14:48:09 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:09 INFO - 'tests': ['bloom_basic']}, 14:48:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:48:09 INFO - 'tsvgr_opacity', 14:48:09 INFO - 'tart', 14:48:09 INFO - 'tscrollx', 14:48:09 INFO - 'tsvg_static']}, 14:48:09 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:48:09 INFO - 'tests': ['tsvgx', 14:48:09 INFO - 'tsvgr_opacity', 14:48:09 INFO - 'tart', 14:48:09 INFO - 'tscrollx', 14:48:09 INFO - 'tsvg_static']}, 14:48:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:48:09 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:48:09 INFO - 'talos_options': ['--disable-stylo'], 14:48:09 INFO - 'tests': ['tp5o']}, 14:48:09 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:48:09 INFO - 'talos_options': ['--mitmproxy', 14:48:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:48:09 INFO - '--firstNonBlankPaint'], 14:48:09 INFO - 'tests': ['tp6_google', 14:48:09 INFO - 'tp6_youtube', 14:48:09 INFO - 'tp6_amazon', 14:48:09 INFO - 'tp6_facebook']}, 14:48:09 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:48:09 INFO - 'talos_options': ['--disable-stylo', 14:48:09 INFO - '--mitmproxy', 14:48:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:48:09 INFO - '--firstNonBlankPaint'], 14:48:09 INFO - 'tests': ['tp6_google', 14:48:09 INFO - 'tp6_youtube', 14:48:09 INFO - 'tp6_amazon', 14:48:09 INFO - 'tp6_facebook']}, 14:48:09 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:48:09 INFO - 'talos_options': ['--stylo-threads=1', 14:48:09 INFO - '--mitmproxy', 14:48:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:48:09 INFO - '--firstNonBlankPaint'], 14:48:09 INFO - 'tests': ['tp6_google', 14:48:09 INFO - 'tp6_youtube', 14:48:09 INFO - 'tp6_amazon', 14:48:09 INFO - 'tp6_facebook']}, 14:48:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:48:09 INFO - 'talos_options': ['--xperf_path', 14:48:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:09 INFO - 'tests': ['tp5n']}, 14:48:09 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:48:09 INFO - 'talos_options': ['--disable-stylo', 14:48:09 INFO - '--xperf_path', 14:48:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:09 INFO - 'tests': ['tp5n']}}} 14:48:09 INFO - Running post-action listener: _resource_record_post_action 14:48:09 INFO - [mozharness: 2017-09-16 21:48:09.976794Z] Finished populate-webroot step (success) 14:48:09 INFO - [mozharness: 2017-09-16 21:48:09.976901Z] Running create-virtualenv step. 14:48:09 INFO - Running pre-action listener: _resource_record_pre_action 14:48:09 INFO - Running main action method: create_virtualenv 14:48:09 INFO - Creating virtualenv /builds/slave/test/build/venv 14:48:09 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:48:09 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 14:48:09 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:48:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:48:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:48:11 INFO - Installing distribute.............................................................................................................................................................................................done. 14:48:11 INFO - Installing pip...............done. 14:48:11 INFO - Return code: 0 14:48:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:48:11 INFO - Reading from file tmpfile_stdout 14:48:11 INFO - Output received: 14:48:11 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 14:48:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:48:11 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')]} 14:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:11 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')]} 14:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:11 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 0x26471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7090>, '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 0x29b7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', '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 14:48:11 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 14:48:11 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 14:48:11 INFO - Using env: {'DISPLAY': ':0', 14:48:11 INFO - 'HOME': '/home/cltbld', 14:48:11 INFO - 'LANG': 'en_US.UTF-8', 14:48:11 INFO - 'LANGUAGE': 'en_US:en', 14:48:11 INFO - 'LOGNAME': 'cltbld', 14:48:11 INFO - 'MAIL': '/var/mail/cltbld', 14:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:11 INFO - 'MOZ_NO_REMOTE': '1', 14:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:11 INFO - 'NO_EM_RESTART': '1', 14:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:11 INFO - 'PWD': '/builds/slave/test', 14:48:11 INFO - 'SHELL': '/bin/bash', 14:48:11 INFO - 'SHLVL': '1', 14:48:11 INFO - 'TERM': 'linux', 14:48:11 INFO - 'TMOUT': '86400', 14:48:11 INFO - 'USER': 'cltbld', 14:48:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', 14:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:11 INFO - '_': '/tools/buildbot/bin/python'} 14:48:13 INFO - Ignoring indexes: http://pypi.python.org/simple/ 14:48:13 INFO - Downloading/unpacking pip>=1.5 14:48:13 INFO - Running setup.py egg_info for package pip 14:48:13 INFO - warning: no files found matching 'pip/cacert.pem' 14:48:13 INFO - warning: no files found matching '*.html' under directory 'docs' 14:48:13 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:48:13 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:48:13 INFO - Installing collected packages: pip 14:48:13 INFO - Found existing installation: pip 1.1 14:48:13 INFO - Uninstalling pip: 14:48:13 INFO - Successfully uninstalled pip 14:48:13 INFO - Running setup.py install for pip 14:48:13 INFO - warning: no files found matching 'pip/cacert.pem' 14:48:13 INFO - warning: no files found matching '*.html' under directory 'docs' 14:48:13 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:48:13 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:48:13 INFO - Installing pip script to /builds/slave/test/build/venv/bin 14:48:13 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 14:48:13 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 14:48:13 INFO - Successfully installed pip 14:48:13 INFO - Cleaning up... 14:48:13 INFO - Return code: 0 14:48:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:48:13 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')]} 14:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:13 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')]} 14:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:13 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 0x26471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7090>, '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 0x29b7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', '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 14:48:13 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 14:48:13 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 14:48:13 INFO - Using env: {'DISPLAY': ':0', 14:48:13 INFO - 'HOME': '/home/cltbld', 14:48:13 INFO - 'LANG': 'en_US.UTF-8', 14:48:13 INFO - 'LANGUAGE': 'en_US:en', 14:48:13 INFO - 'LOGNAME': 'cltbld', 14:48:13 INFO - 'MAIL': '/var/mail/cltbld', 14:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:13 INFO - 'MOZ_NO_REMOTE': '1', 14:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:13 INFO - 'NO_EM_RESTART': '1', 14:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:13 INFO - 'PWD': '/builds/slave/test', 14:48:13 INFO - 'SHELL': '/bin/bash', 14:48:13 INFO - 'SHLVL': '1', 14:48:13 INFO - 'TERM': 'linux', 14:48:13 INFO - 'TMOUT': '86400', 14:48:13 INFO - 'USER': 'cltbld', 14:48:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', 14:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:13 INFO - '_': '/tools/buildbot/bin/python'} 14:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:13 INFO - Downloading/unpacking psutil>=3.1.1 14:48:13 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 14:48:13 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 14:48:13 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 14:48:13 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 14:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:48:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:14 INFO - Installing collected packages: psutil 14:48:14 INFO - Running setup.py install for psutil 14:48:14 INFO - building 'psutil._psutil_linux' extension 14:48:14 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 14:48:14 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 14:48:14 INFO - building 'psutil._psutil_posix' extension 14:48:14 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 14:48:14 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 14:48:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:15 INFO - Successfully installed psutil 14:48:15 INFO - Cleaning up... 14:48:15 INFO - Return code: 0 14:48:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:48:15 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')]} 14:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:15 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')]} 14:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:15 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 0x26471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7090>, '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 0x29b7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', '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 14:48:15 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 14:48:15 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 14:48:15 INFO - Using env: {'DISPLAY': ':0', 14:48:15 INFO - 'HOME': '/home/cltbld', 14:48:15 INFO - 'LANG': 'en_US.UTF-8', 14:48:15 INFO - 'LANGUAGE': 'en_US:en', 14:48:15 INFO - 'LOGNAME': 'cltbld', 14:48:15 INFO - 'MAIL': '/var/mail/cltbld', 14:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:15 INFO - 'MOZ_NO_REMOTE': '1', 14:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:15 INFO - 'NO_EM_RESTART': '1', 14:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:15 INFO - 'PWD': '/builds/slave/test', 14:48:15 INFO - 'SHELL': '/bin/bash', 14:48:15 INFO - 'SHLVL': '1', 14:48:15 INFO - 'TERM': 'linux', 14:48:15 INFO - 'TMOUT': '86400', 14:48:15 INFO - 'USER': 'cltbld', 14:48:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', 14:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:15 INFO - '_': '/tools/buildbot/bin/python'} 14:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:48:15 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 14:48:15 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 14:48:15 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 14:48:15 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 14:48:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:48:16 INFO - Installing collected packages: mozsystemmonitor 14:48:16 INFO - Running setup.py install for mozsystemmonitor 14:48:16 INFO - Successfully installed mozsystemmonitor 14:48:16 INFO - Cleaning up... 14:48:17 INFO - Return code: 0 14:48:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:17 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 0x26471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7090>, '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 0x29b7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', '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 14:48:17 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 14:48:17 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 14:48:17 INFO - Using env: {'DISPLAY': ':0', 14:48:17 INFO - 'HOME': '/home/cltbld', 14:48:17 INFO - 'LANG': 'en_US.UTF-8', 14:48:17 INFO - 'LANGUAGE': 'en_US:en', 14:48:17 INFO - 'LOGNAME': 'cltbld', 14:48:17 INFO - 'MAIL': '/var/mail/cltbld', 14:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:17 INFO - 'MOZ_NO_REMOTE': '1', 14:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:17 INFO - 'NO_EM_RESTART': '1', 14:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:17 INFO - 'PWD': '/builds/slave/test', 14:48:17 INFO - 'SHELL': '/bin/bash', 14:48:17 INFO - 'SHLVL': '1', 14:48:17 INFO - 'TERM': 'linux', 14:48:17 INFO - 'TMOUT': '86400', 14:48:17 INFO - 'USER': 'cltbld', 14:48:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', 14:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:17 INFO - '_': '/tools/buildbot/bin/python'} 14:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:18 INFO - Downloading/unpacking jsonschema==2.5.1 14:48:18 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 14:48:18 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 14:48:18 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 14:48:18 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 14:48:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:48:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:48:19 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 14:48:19 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 14:48:19 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 14:48:19 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 14:48:19 INFO - Downloading functools32-3.2.3-2.tar.gz 14:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:48:19 INFO - warning: no files found matching '*.txt' 14:48:19 INFO - no previously-included directories found matching 'build' 14:48:19 INFO - no previously-included directories found matching 'dist' 14:48:19 INFO - no previously-included directories found matching '.git*' 14:48:19 INFO - Installing collected packages: jsonschema, functools32 14:48:19 INFO - Running setup.py install for functools32 14:48:19 INFO - warning: no files found matching '*.txt' 14:48:19 INFO - no previously-included directories found matching 'build' 14:48:19 INFO - no previously-included directories found matching 'dist' 14:48:19 INFO - no previously-included directories found matching '.git*' 14:48:19 INFO - Successfully installed jsonschema functools32 14:48:19 INFO - Cleaning up... 14:48:19 INFO - Return code: 0 14:48:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:48:19 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')]} 14:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:19 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')]} 14:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:19 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 0x26471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7090>, '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 0x29b7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', '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 14:48:19 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 14:48:19 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 14:48:19 INFO - Using env: {'DISPLAY': ':0', 14:48:19 INFO - 'HOME': '/home/cltbld', 14:48:19 INFO - 'LANG': 'en_US.UTF-8', 14:48:19 INFO - 'LANGUAGE': 'en_US:en', 14:48:19 INFO - 'LOGNAME': 'cltbld', 14:48:19 INFO - 'MAIL': '/var/mail/cltbld', 14:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:19 INFO - 'MOZ_NO_REMOTE': '1', 14:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:19 INFO - 'NO_EM_RESTART': '1', 14:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:19 INFO - 'PWD': '/builds/slave/test', 14:48:19 INFO - 'SHELL': '/bin/bash', 14:48:19 INFO - 'SHLVL': '1', 14:48:19 INFO - 'TERM': 'linux', 14:48:19 INFO - 'TMOUT': '86400', 14:48:19 INFO - 'USER': 'cltbld', 14:48:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', 14:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:19 INFO - '_': '/tools/buildbot/bin/python'} 14:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:48:19 INFO - Cleaning up... 14:48:19 INFO - Return code: 0 14:48:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:48:19 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')]} 14:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:19 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')]} 14:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:19 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 0x26471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7090>, '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 0x29b7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', '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 14:48:19 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 14:48:19 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 14:48:19 INFO - Using env: {'DISPLAY': ':0', 14:48:19 INFO - 'HOME': '/home/cltbld', 14:48:19 INFO - 'LANG': 'en_US.UTF-8', 14:48:19 INFO - 'LANGUAGE': 'en_US:en', 14:48:19 INFO - 'LOGNAME': 'cltbld', 14:48:19 INFO - 'MAIL': '/var/mail/cltbld', 14:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:19 INFO - 'MOZ_NO_REMOTE': '1', 14:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:19 INFO - 'NO_EM_RESTART': '1', 14:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:19 INFO - 'PWD': '/builds/slave/test', 14:48:19 INFO - 'SHELL': '/bin/bash', 14:48:19 INFO - 'SHLVL': '1', 14:48:19 INFO - 'TERM': 'linux', 14:48:19 INFO - 'TMOUT': '86400', 14:48:19 INFO - 'USER': 'cltbld', 14:48:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', 14:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:19 INFO - '_': '/tools/buildbot/bin/python'} 14:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:19 INFO - Downloading/unpacking blobuploader==1.2.4 14:48:19 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 14:48:19 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 14:48:19 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 14:48:19 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 14:48:21 INFO - Downloading blobuploader-1.2.4.tar.gz 14:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:48:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:48:21 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 14:48:21 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 14:48:21 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 14:48:21 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 14:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:48:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:48:21 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 14:48:21 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 14:48:21 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 14:48:21 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 14:48:21 INFO - Downloading docopt-0.6.1.tar.gz 14:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:48:21 INFO - Installing collected packages: blobuploader, requests, docopt 14:48:21 INFO - Running setup.py install for blobuploader 14:48:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:48:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:48:21 INFO - Running setup.py install for requests 14:48:22 INFO - Running setup.py install for docopt 14:48:22 INFO - Successfully installed blobuploader requests docopt 14:48:22 INFO - Cleaning up... 14:48:22 INFO - Return code: 0 14:48:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:22 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 0x26471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7090>, '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 0x29b7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', '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 14:48:22 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 14:48:22 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 14:48:22 INFO - Using env: {'DISPLAY': ':0', 14:48:22 INFO - 'HOME': '/home/cltbld', 14:48:22 INFO - 'LANG': 'en_US.UTF-8', 14:48:22 INFO - 'LANGUAGE': 'en_US:en', 14:48:22 INFO - 'LOGNAME': 'cltbld', 14:48:22 INFO - 'MAIL': '/var/mail/cltbld', 14:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:22 INFO - 'MOZ_NO_REMOTE': '1', 14:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:22 INFO - 'NO_EM_RESTART': '1', 14:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:22 INFO - 'PWD': '/builds/slave/test', 14:48:22 INFO - 'SHELL': '/bin/bash', 14:48:22 INFO - 'SHLVL': '1', 14:48:22 INFO - 'TERM': 'linux', 14:48:22 INFO - 'TMOUT': '86400', 14:48:22 INFO - 'USER': 'cltbld', 14:48:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', 14:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:22 INFO - '_': '/tools/buildbot/bin/python'} 14:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:22 INFO - Running setup.py (path:/tmp/pip-fKdCiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:22 INFO - Running setup.py (path:/tmp/pip-eJjrqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:22 INFO - Running setup.py (path:/tmp/pip-9xe2Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:22 INFO - Running setup.py (path:/tmp/pip-MX2TqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:22 INFO - Running setup.py (path:/tmp/pip-YWElzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:22 INFO - Running setup.py (path:/tmp/pip-NKztBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:22 INFO - Running setup.py (path:/tmp/pip-Gi1dpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:22 INFO - Running setup.py (path:/tmp/pip-vU153B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:23 INFO - Running setup.py (path:/tmp/pip-28wH0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:23 INFO - Running setup.py (path:/tmp/pip-_aMCFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:23 INFO - Running setup.py (path:/tmp/pip-VWKBzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:23 INFO - Running setup.py (path:/tmp/pip-Z6XN9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:23 INFO - Running setup.py (path:/tmp/pip-lYgdDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:23 INFO - Running setup.py (path:/tmp/pip-8V7mEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:23 INFO - Running setup.py (path:/tmp/pip-EmSdGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:23 INFO - Running setup.py (path:/tmp/pip-KWcl9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:23 INFO - Running setup.py (path:/tmp/pip-uOGtPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:48:23 INFO - Running setup.py install for manifestparser 14:48:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:48:23 INFO - Running setup.py install for mozcrash 14:48:23 INFO - Running setup.py install for mozdebug 14:48:23 INFO - Running setup.py install for mozdevice 14:48:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:48:24 INFO - Running setup.py install for mozfile 14:48:24 INFO - Running setup.py install for mozhttpd 14:48:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:48:24 INFO - Running setup.py install for mozinfo 14:48:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:48:24 INFO - Running setup.py install for mozInstall 14:48:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:48:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:48:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:48:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:48:24 INFO - Running setup.py install for mozleak 14:48:24 INFO - Running setup.py install for mozlog 14:48:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:48:24 INFO - Running setup.py install for moznetwork 14:48:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:48:24 INFO - Running setup.py install for mozprocess 14:48:24 INFO - Running setup.py install for mozprofile 14:48:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:48:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:48:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:48:25 INFO - Running setup.py install for mozrunner 14:48:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:48:25 INFO - Running setup.py install for mozscreenshot 14:48:25 INFO - Running setup.py install for moztest 14:48:25 INFO - Running setup.py install for mozversion 14:48:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:48:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:48:25 INFO - Cleaning up... 14:48:25 INFO - Return code: 0 14:48:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:25 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')]} 14:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:25 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')]} 14:48:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:25 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 0x26471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7090>, '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 0x29b7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', '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 14:48:25 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 14:48:25 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 14:48:25 INFO - Using env: {'DISPLAY': ':0', 14:48:25 INFO - 'HOME': '/home/cltbld', 14:48:25 INFO - 'LANG': 'en_US.UTF-8', 14:48:25 INFO - 'LANGUAGE': 'en_US:en', 14:48:25 INFO - 'LOGNAME': 'cltbld', 14:48:25 INFO - 'MAIL': '/var/mail/cltbld', 14:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:25 INFO - 'MOZ_NO_REMOTE': '1', 14:48:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:25 INFO - 'NO_EM_RESTART': '1', 14:48:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:25 INFO - 'PWD': '/builds/slave/test', 14:48:25 INFO - 'SHELL': '/bin/bash', 14:48:25 INFO - 'SHLVL': '1', 14:48:25 INFO - 'TERM': 'linux', 14:48:25 INFO - 'TMOUT': '86400', 14:48:25 INFO - 'USER': 'cltbld', 14:48:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', 14:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:25 INFO - '_': '/tools/buildbot/bin/python'} 14:48:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:25 INFO - Running setup.py (path:/tmp/pip-b8Tpdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:25 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)) 14:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:25 INFO - Running setup.py (path:/tmp/pip-RsxNkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:25 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)) 14:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:25 INFO - Running setup.py (path:/tmp/pip-nHetnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:25 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)) 14:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:25 INFO - Running setup.py (path:/tmp/pip-SEBRkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:25 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)) 14:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:25 INFO - Running setup.py (path:/tmp/pip-bZJIOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:26 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)) 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:26 INFO - Running setup.py (path:/tmp/pip-sNKHJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:26 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)) 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:26 INFO - Running setup.py (path:/tmp/pip-uuWEun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:26 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)) 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:26 INFO - Running setup.py (path:/tmp/pip-SfhA9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:26 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)) 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:26 INFO - Running setup.py (path:/tmp/pip-V10Eqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:26 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)) 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:26 INFO - Running setup.py (path:/tmp/pip-NpZtph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:26 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)) 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:26 INFO - Running setup.py (path:/tmp/pip-EZ5xmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:26 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)) 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:26 INFO - Running setup.py (path:/tmp/pip-1WzMoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:26 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)) 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:26 INFO - Running setup.py (path:/tmp/pip-Pbxl9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:26 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)) 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:26 INFO - Running setup.py (path:/tmp/pip-OgYERi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:26 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)) 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:26 INFO - Running setup.py (path:/tmp/pip-OzfN_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:26 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)) 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:26 INFO - Running setup.py (path:/tmp/pip-bDBR9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:26 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)) 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:26 INFO - Running setup.py (path:/tmp/pip-7NXd79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:26 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)) 14:48:26 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)) 14:48:26 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)) 14:48:26 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)) 14:48:26 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)) 14:48:26 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)) 14:48:26 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)) 14:48:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:48:26 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 14:48:26 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 14:48:26 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 14:48:26 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 14:48:27 INFO - Downloading blessings-1.6.tar.gz 14:48:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:48:28 INFO - Installing collected packages: blessings 14:48:28 INFO - Running setup.py install for blessings 14:48:28 INFO - Successfully installed blessings 14:48:28 INFO - Cleaning up... 14:48:28 INFO - Return code: 0 14:48:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:48:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:28 INFO - Reading from file tmpfile_stdout 14:48:28 INFO - Current package versions: 14:48:28 INFO - argparse == 1.2.1 14:48:28 INFO - blessings == 1.6 14:48:28 INFO - blobuploader == 1.2.4 14:48:28 INFO - docopt == 0.6.1 14:48:28 INFO - functools32 == 3.2.3-2 14:48:28 INFO - jsonschema == 2.5.1 14:48:28 INFO - manifestparser == 1.1 14:48:28 INFO - mozInstall == 1.13 14:48:28 INFO - mozcrash == 1.0 14:48:28 INFO - mozdebug == 0.1 14:48:28 INFO - mozdevice == 0.51 14:48:28 INFO - mozfile == 1.2 14:48:28 INFO - mozhttpd == 0.7 14:48:28 INFO - mozinfo == 0.10 14:48:28 INFO - mozleak == 0.1 14:48:28 INFO - mozlog == 3.5 14:48:28 INFO - moznetwork == 0.27 14:48:28 INFO - mozprocess == 0.25 14:48:28 INFO - mozprofile == 0.28 14:48:28 INFO - mozrunner == 6.13 14:48:28 INFO - mozscreenshot == 0.1 14:48:28 INFO - mozsystemmonitor == 0.3 14:48:28 INFO - moztest == 0.8 14:48:28 INFO - mozversion == 1.4 14:48:28 INFO - psutil == 3.1.1 14:48:28 INFO - requests == 1.2.3 14:48:28 INFO - wsgiref == 0.1.2 14:48:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:28 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 0x26471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7090>, '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 0x29b7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', '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 14:48:28 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 14:48:28 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 14:48:28 INFO - Using env: {'DISPLAY': ':0', 14:48:28 INFO - 'HOME': '/home/cltbld', 14:48:28 INFO - 'LANG': 'en_US.UTF-8', 14:48:28 INFO - 'LANGUAGE': 'en_US:en', 14:48:28 INFO - 'LOGNAME': 'cltbld', 14:48:28 INFO - 'MAIL': '/var/mail/cltbld', 14:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:28 INFO - 'MOZ_NO_REMOTE': '1', 14:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:28 INFO - 'NO_EM_RESTART': '1', 14:48:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:28 INFO - 'PWD': '/builds/slave/test', 14:48:28 INFO - 'SHELL': '/bin/bash', 14:48:28 INFO - 'SHLVL': '1', 14:48:28 INFO - 'TERM': 'linux', 14:48:28 INFO - 'TMOUT': '86400', 14:48:28 INFO - 'USER': 'cltbld', 14:48:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', 14:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:28 INFO - '_': '/tools/buildbot/bin/python'} 14:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:28 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)) 14:48:28 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)) 14:48:28 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)) 14:48:28 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)) 14:48:28 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)) 14:48:28 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)) 14:48:28 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)) 14:48:28 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)) 14:48:28 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)) 14:48:28 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:48:28 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 14:48:28 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 14:48:28 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 14:48:28 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 14:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:48:29 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)) 14:48:29 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)) 14:48:29 INFO - Installing collected packages: simplejson 14:48:29 INFO - Running setup.py install for simplejson 14:48:29 INFO - building 'simplejson._speedups' extension 14:48:29 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 14:48:30 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 14:48:30 INFO - Successfully installed simplejson 14:48:30 INFO - Cleaning up... 14:48:30 INFO - Return code: 0 14:48:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48: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')]} 14:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:30 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 0x26471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7090>, '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 0x29b7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', '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 14:48:30 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 14:48:30 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 14:48:30 INFO - Using env: {'DISPLAY': ':0', 14:48:30 INFO - 'HOME': '/home/cltbld', 14:48:30 INFO - 'LANG': 'en_US.UTF-8', 14:48:30 INFO - 'LANGUAGE': 'en_US:en', 14:48:30 INFO - 'LOGNAME': 'cltbld', 14:48:30 INFO - 'MAIL': '/var/mail/cltbld', 14:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:30 INFO - 'MOZ_NO_REMOTE': '1', 14:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:30 INFO - 'NO_EM_RESTART': '1', 14:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:30 INFO - 'PWD': '/builds/slave/test', 14:48:30 INFO - 'SHELL': '/bin/bash', 14:48:30 INFO - 'SHLVL': '1', 14:48:30 INFO - 'TERM': 'linux', 14:48:30 INFO - 'TMOUT': '86400', 14:48:30 INFO - 'USER': 'cltbld', 14:48:30 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', 14:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:30 INFO - '_': '/tools/buildbot/bin/python'} 14:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:48:31 INFO - Cleaning up... 14:48:31 INFO - Return code: 0 14:48:31 INFO - Running post-action listener: _resource_record_post_action 14:48:31 INFO - Running post-action listener: _start_resource_monitoring 14:48:31 INFO - Starting resource monitoring. 14:48:31 INFO - [mozharness: 2017-09-16 21:48:31.149407Z] Finished create-virtualenv step (success) 14:48:31 INFO - [mozharness: 2017-09-16 21:48:31.149909Z] Running install step. 14:48:31 INFO - Running pre-action listener: _resource_record_pre_action 14:48:31 INFO - Running main action method: install 14:48:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:31 INFO - Reading from file tmpfile_stdout 14:48:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:48:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:48:31 INFO - Reading from file tmpfile_stdout 14:48:31 INFO - Output received: 14:48:31 INFO - Usage: mozinstall [options] installer 14:48:31 INFO - Options: 14:48:31 INFO - -h, --help show this help message and exit 14:48:31 INFO - -d DEST, --destination=DEST 14:48:31 INFO - Directory to install application into. [default: 14:48:31 INFO - "/builds/slave/test"] 14:48:31 INFO - --app=APP Application being installed. [default: firefox] 14:48:31 INFO - mkdir: /builds/slave/test/build/application 14:48:31 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'] 14:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:48:49 INFO - Reading from file tmpfile_stdout 14:48:49 INFO - Output received: 14:48:49 INFO - /builds/slave/test/build/application/firefox/firefox 14:48:49 INFO - Running post-action listener: _resource_record_post_action 14:48:49 INFO - [mozharness: 2017-09-16 21:48:49.272420Z] Finished install step (success) 14:48:49 INFO - [mozharness: 2017-09-16 21:48:49.272671Z] Running setup-mitmproxy step. 14:48:49 INFO - Running pre-action listener: _resource_record_pre_action 14:48:49 INFO - Running main action method: setup_mitmproxy 14:48:49 INFO - Skipping: mitmproxy is not required 14:48:49 INFO - Running post-action listener: _resource_record_post_action 14:48:49 INFO - [mozharness: 2017-09-16 21:48:49.273801Z] Finished setup-mitmproxy step (success) 14:48:49 INFO - [mozharness: 2017-09-16 21:48:49.274022Z] Running run-tests step. 14:48:49 INFO - Running pre-action listener: _resource_record_pre_action 14:48:49 INFO - Running pre-action listener: _set_gcov_prefix 14:48:49 INFO - Running main action method: run_tests 14:48:49 WARNING - Try message not found. 14:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:48:49 INFO - Python 2.7.3 14:48:49 INFO - Return code: 0 14:48:49 INFO - grabbing minidump binary from tooltool 14:48: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')]} 14:48:49 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 0x29b7090>, '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 0x29b7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:48:49 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 14:48:49 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 14:48:49 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 14:48:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:48:49 INFO - Return code: 0 14:48:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:48:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:48:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:48:49 INFO - ENV: RUST_BACKTRACE is now full 14:48:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:48:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 14:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 14:48:49 INFO - Using env: {'DISPLAY': ':0', 14:48:49 INFO - 'HOME': '/home/cltbld', 14:48:49 INFO - 'LANG': 'en_US.UTF-8', 14:48:49 INFO - 'LANGUAGE': 'en_US:en', 14:48:49 INFO - 'LOGNAME': 'cltbld', 14:48:49 INFO - 'MAIL': '/var/mail/cltbld', 14:48:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:48:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:49 INFO - 'MOZ_NO_REMOTE': '1', 14:48:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:49 INFO - 'NO_EM_RESTART': '1', 14:48:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:49 INFO - 'PWD': '/builds/slave/test', 14:48:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:48:49 INFO - 'RUST_BACKTRACE': 'full', 14:48:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:48:49 INFO - 'SHELL': '/bin/bash', 14:48:49 INFO - 'SHLVL': '1', 14:48:49 INFO - 'TERM': 'linux', 14:48:49 INFO - 'TMOUT': '86400', 14:48:49 INFO - 'USER': 'cltbld', 14:48:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', 14:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:49 INFO - '_': '/tools/buildbot/bin/python'} 14:48:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 14:48:49 INFO - mozversion application_buildid: 20170916205151 14:48:49 INFO - mozversion application_changeset: 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 14:48:49 INFO - mozversion application_display_name: Nightly 14:48:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:48:49 INFO - mozversion application_name: Firefox 14:48:49 INFO - mozversion application_remotingname: firefox 14:48:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:48:49 INFO - mozversion application_vendor: Mozilla 14:48:49 INFO - mozversion application_version: 57.0a1 14:48:49 INFO - mozversion platform_buildid: 20170916205151 14:48:49 INFO - mozversion platform_changeset: 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 14:48:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:48:49 INFO - mozversion platform_version: 57.0a1 14:48:49 INFO - using testdate: 1505598529 14:48:49 INFO - actual date: 1505598529 14:48:49 INFO - starting webserver on 'localhost:60208' 14:48:49 INFO - SUITE-START | Running 2 tests 14:48:49 INFO - TEST-START | dromaeo_css 14:48:49 INFO - Initialising browser for dromaeo_css test... 14:48:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60208/getInfo.html -profile /tmp/tmp9BOaY3/profile 14:48:49 INFO - TEST-INFO | started process 8925 (/builds/slave/test/build/application/firefox/firefox http://localhost:60208/getInfo.html) 14:48:55 INFO - TEST-INFO | 8925: exit 0 14:48:55 INFO - Browser initialized. 14:48:55 INFO - Running cycle 1/1 for dromaeo_css test... 14:48:55 INFO - Using env: {'DISPLAY': ':0', 14:48:55 INFO - 'HOME': '/home/cltbld', 14:48:55 INFO - 'JSGC_DISABLE_POISONING': '1', 14:48:55 INFO - 'LANG': 'en_US.UTF-8', 14:48:55 INFO - 'LANGUAGE': 'en_US:en', 14:48:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:48:55 INFO - 'LOGNAME': 'cltbld', 14:48:55 INFO - 'MAIL': '/var/mail/cltbld', 14:48:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:48:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:48:55 INFO - 'MOZ_CRASHREPORTER': '1', 14:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:48:55 INFO - 'MOZ_NO_REMOTE': '1', 14:48:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:55 INFO - 'NO_EM_RESTART': '1', 14:48:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:55 INFO - 'PWD': '/builds/slave/test', 14:48:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:48:55 INFO - 'RUST_BACKTRACE': 'full', 14:48:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:48:55 INFO - 'SHELL': '/bin/bash', 14:48:55 INFO - 'SHLVL': '1', 14:48:55 INFO - 'TERM': 'linux', 14:48:55 INFO - 'TMOUT': '86400', 14:48:55 INFO - 'USER': 'cltbld', 14:48:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', 14:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:55 INFO - '_': '/tools/buildbot/bin/python'} 14:48:55 INFO - TEST-INFO | started process 9158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9BOaY3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:56 INFO - PID 9158 | 14:48:56 INFO - PID 9158 | (/builds/slave/test/build/application/firefox/firefox:9207): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:48:56 INFO - PID 9158 | 14:49:06 INFO - PID 9158 | RSS: Main: 154550272 14:49:06 INFO - PID 9158 | 14:52:03 INFO - PID 9158 | Cycle 1(1): loaded http://localhost:60208/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60208/tests/dromaeo/cssquery-ext.html) 14:52:04 INFO - PID 9158 | RSS: Main: 155021312 14:52:04 INFO - PID 9158 | 14:55:06 INFO - PID 9158 | Cycle 1(1): loaded http://localhost:60208/tests/dromaeo/cssquery-ext.html (next: http://localhost:60208/tests/dromaeo/cssquery-jquery.html) 14:55:07 INFO - PID 9158 | RSS: Main: 155320320 14:55:07 INFO - PID 9158 | 14:58:08 INFO - PID 9158 | Cycle 1(1): loaded http://localhost:60208/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60208/tests/dromaeo/cssquery-mootools.html) 14:58:09 INFO - PID 9158 | RSS: Main: 157474816 14:58:09 INFO - PID 9158 | 15:01:10 INFO - PID 9158 | Cycle 1(1): loaded http://localhost:60208/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60208/tests/dromaeo/cssquery-prototype.html) 15:01:11 INFO - PID 9158 | RSS: Main: 155725824 15:01:11 INFO - PID 9158 | 15:04:14 INFO - PID 9158 | Cycle 1(1): loaded http://localhost:60208/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60208/tests/dromaeo/cssquery-yui.html) 15:04:15 INFO - PID 9158 | RSS: Main: 156635136 15:04:15 INFO - PID 9158 | 15:07:17 INFO - PID 9158 | Cycle 1(1): loaded http://localhost:60208/tests/dromaeo/cssquery-yui.html (next: http://localhost:60208/tests/dromaeo/cssquery-dojo.html) 15:07:17 INFO - PID 9158 | RSS: Main: 159588352 15:07:17 INFO - PID 9158 | 15:07:17 INFO - PID 9158 | __start_tp_report 15:07:17 INFO - PID 9158 | _x_x_mozilla_page_load 15:07:17 INFO - PID 9158 | _x_x_mozilla_page_load_details 15:07:17 INFO - PID 9158 | |i|pagename|runs| 15:07:17 INFO - PID 9158 | |0;dojo.html;3093.7370323522487;3113.532970054492;3114.205877501237;3140.3091319909613;3161.2887100402427;6344.460720838729;6353.809385718424;6376.681165941707;6423.550351475393;6430.164078669773;6100.267967843865;6202.348753380887;6230.065490176465;6250.874982500359;6255.718492667829;5677.8580535486635;5786.942130578704;5830.32951210612;5845.0647896336595;5881.470667639912;5837.649741015532;5895.64626122434;5896.23348964634;5911.73397197125;5925.111233315016;1316.4158622523896;5682.460166284217;5714.799982000631;5719.628224165437;5855.882882342329;5778.624389414675;5785.971070144665;5833.50415214703;5860.17957485948;5868.618539794899;5740.913886291709;5749.453801888814;5836.095405212199;5838.824835254949;5852.619579727304;6258.812235632939;6286.842828929268;6306.558540902139;6337.588056776295;6342.460890824285;6700.664966751691;6735.326467353275;6780.660966951682;6783.389494945429;6809.659517024129;6552.213734351861;6660.56706314088;6681.632510211936;6696.497762667771;6699.229588597325;6089.421504957022;6140.232470941132;6161.845953851145;6166.229221347332;6166.84582885427;6786.423154031864;6793.796186114425;6798.04827324175;6801.4898882584;6802.591844489297;6573.737050517926;6666.733330666816;6711.3288671132495;6716.5634233774645;6717.731290748413;6708.865822683519;6716.361945615159;6801.013852991288;6804.557703749339;6806.659667016629;6512.120863683437;6664.200295964515;6668.799936001928;6734.158230221223;6739.123913891162;6608.603483790892;6692.966535167293;6736.393724564813;6784.932150678529;6790.151231096113;5364.22218778275;5380.488853558905;5382.4886635769535;5392.73036348181;5399.406065332811;4590.380298659638;4609.9308510372375;4653.86038418848;4672.719636821802;4675.906481870344;5689.857753556112;5772.595918285764;5832.387599302097;5901.468867801918;5916.852078697981;6664.866702666017;6681.298463661343;6683.799486015428;6701.229358623723;6713.69788359525;5891.23413956183;5891.675957822361;5904.7342869570975;5908.438698323653;5921.792737254175;5716.314042314865;5783.929972954933;5848.824535263949;5868.09044598088;5870.970645146833;6545.280019197884;6556.147700798866;6563;6647.4349680276755;6659.400653941072;6726.39462448382;6735.124433823669;6752.628605426847;6760.560563563353;6761.763338283136;6448.193975753031;6565.982272747732;6625.105610742681;6625.4037136657935;6631.171103612049;6599.868002640016;6604.735810567524;6617.272100069084;6694.564853284521;6699.0621313015245;6578.111954886029;6700;6710.094137291599;6803.013563033233;6827.658617069027;6511.120998665119;6519.217693876575;6519.282878883224;6539.803805885831;6558.901616475852;6404.967975160094;6493.772717954849;6567.2447668516825;6580.21037475506;6588.703508342041;6439.259485159267;6441.13044738973;6502.837429064311;6504.60972341661;6512.34876512345;6452.967735161482;6512.5766825156215;6531.150950376421;6572.34276572339;6632.635205063575;6291.087792270004;6404.039394090923;6406.647634380154;6414.871702565829;6415.8716825662295 15:07:17 INFO - PID 9158 | |1;ext.html;863.1066845814582;883.5847151838638;890.3811850763718;891.9197272245497;893.5264309915743;38957.22085558287;39765;42566.51017214398;42622.99999999996;42915.57084429155;39846.20307593854;40020;40028.59971400285;40106.59893401065;40119;6969.581825090486;7058.047163632921;7060.7175712971675;7063.223045464994;7065.823354416155;7782.494137881048;7951.20487951206;7958.283754462097;7964.362850971937;7966.044074711014;7932.643031063587;7986.361091112697;7991.081025682034;7993.400494962872;8002.039755229381;7790.337821285198;7911.327537159348;7964.800879978018;7977;7979.162187970295;7822.295993360568;7885.093214280374;7893.684252629888;7899.605019748989;7900.486468379594;37764.81117594394;37996.43005354922;38025.80987095075;38248;38254.61745382538;3550.5916819565564;3581.6418358164237;3587.5694916609914;3589.174489867319;3596.1549035976523;31635.367292654017;31717.84141079303;31747;31783.682163178302;31814;5247.606429517763;5272.156454967187;5274.841754747364;5282.260483532308;5288.153895376721;180485.9999999987;180559;181758;182500;182844;48881.75559122253;48981.26528102082;49028;49246.75376623165;49334.506654933706;43614.78192609017;44146.558534414246;50393.74015649638;51041.23438148356;51131.233031504555;16567.917160414363;16593.751093733605;16650.58373540671;16706.916465417595;16751.6649667006;13668.658283542793;13762.24307663068;13768.449262029406;13773.104748191336;13776;14076.788848167285;14100.294985250697;14106.224157671426;14112.576622701336;14245;5758.107493338539;5814.30228372598;5833.270841144857;5834.795782147605;5895.764169433174;1014.9188064954786;1019.5463018956493;1027.9074883260394;1035.7307100154014;1040.287403128859;22733.318000460014;22962.540749184922;23050.65424018641;23093.307200784002;23237.76762232356;1121.9214654974237;1126.7915435644268;1132.7564573616712;1133.455941148237;1146.5356530605118;12069.57756478519;12266.570670026505;12286.938565307295;12299;12369.196002259825;213753;214294;214500;214719;215775;52430.737846311284;52552.474475254756;52719.47280527222;52719.47280527222;52907.73546132322;1457.2640816387657;1463.677990842013;1481.525911708243;1482.5330021043337;1485.7622780355307;21866.781332186474;22419.887900561047;22557.661635075157;22622.321330360115;22769.544609108056;37286.44070339001;37391.439128413636;37424.438633421065;37451.250974980896;37456;182105;182410;182531;182587;182706;33758.3248335027;34972.825135874155;36705.816470917474;36805;36886.44670330001;46267.3059904095;47308.344207952556;47327.98497397453;47342.28986565136;47451;34279;34440.48339274963;34725.30549389048;34846;35252.64747352596;33300.1674958128;33512.49731254082;33523.329533409684;33601;34154.65845341515;37209.62790372062;37580.81209593934;37647.24705505929;37651.43522847105;37664.81167594254;33049.669503304656;33051.33897321992;33074.33851323008;33249.50125748164;33687.32625347529;23616.645750314103;24567.877160614797;24667.629985549873;24752.628710569716;24785.50428991374 15:07:17 INFO - PID 9158 | |2;jquery.html;539.8797495197466;562.1230879827469;564.9322081350239;580.2167074449493;586.0710773424124;22291.55416891663;23033.654495182564;23061.308160755183;23066.538669226604;23067.538649227004;23464.17875374362;24666.13668521602;24696.62955055671;24976.125835595758;25150.87424562879;6322.399372059647;6461.6446095464735;6482.870342593145;6487.059376390421;6497.545171837974;6348.84127896804;6360.427561519462;6459.612423254596;6466.870662586745;6636.767713130042;6588.901166482507;6596.901046484307;6599.307072757363;6599.571027883197;6602.570832895871;6527.216733991928;6561.3438656134485;6567.868642627121;6578.177727784027;6581.736730530797;6062.333143354227;6081.300650425169;6101.694915254264;6131.264248290189;6133.1106989486725;27048;27877.303067423272;28199.295017624518;28345.716542834514;28377.432451350858;2055.403932859469;2081.6773400123006;2096.895155242232;2098.8740675559516;2102.653062244743;19185.712214316798;19714.605707885905;19715;19715;19759.703604445946;2316.5830150572892;2350.189184731265;2385.4990452004927;2395.2215529952837;2426.041713523166;116363;121216;135600;135668;140002.29998850042;14136.787948180785;14487.565373038826;14535.927320363331;14651.263927698368;14684;22642.886785566297;22653.43366415853;22726.772732272464;22747.772522274896;22786.544269114856;10015.649452269136;10213.182945364353;10252.667882937925;10296.948515257376;10329.380237185642;9489.478078705737;9537.666181683746;9561.235101192027;9582.568784404719;9643.566039528238;8735.737927862174;8804;8853.468791872509;8891.155340242667;9123.726288211365;2505.260948020338;2511.9874400628246;2528.8229823912147;2600.609908513738;2602.1542998525556;965.9806803863884;978.2125389061731;981.7741919358588;982.7788747531748;997.9750506237402;18577.628447430976;18637;18708.53228669267;18902.243910243713;19241;1028.3572767020612;1033.405791669793;1042.2183362478142;1043.1289872956168;1048.3762161513887;10290.794184116425;10380.273380863418;10461.05850473461;10508.054275115124;10510.632127875488;431808;440510;450703;460832;462406;112136;113056;113290;115005.4249728746;115907.42046289715;1130.7512347283748;1151.5221183208876;1170.1925671286785;1171.0455978377595;1177.4348312809727;16897.577560560592;16931;17187.742183867504;17404.651906961535;17754.467365979042;53743.731281343345;55274;55889.16166257428;56288.71855640696;57044;68043.3195668037;68642.31357686559;69144.6542767283;69187;69447;13882.51411200603;13980.440782368998;14022.158670479805;14168.574942751733;14178.574642760734;21432.357029289145;21846.344609661737;21934;21934.670979935632;21978.780212197675;16664.25010874538;16817.243224055193;17066.48800535986;17073.573160670585;17206.225719842387;15148.848511514743;15226.46707365237;15624.609384765472;16091.195440227708;16101.355945762507;17589.912050440176;17631.471055868344;17677.469675909742;17912.373066942593;17954.281828727228;13755.243461609707;13798.586042418743;13815.654608634864;13889.305534723426;13915.721685566434;17066.14669266507;17199.484015479557;17302.22140003728;17426.651466970336;17446.214920328868 15:07:17 INFO - PID 9158 | |3;mootools.html;1296.8767967043132;1390.3882291791604;1394.532831501447;1400.7968844517552;1401.6636007358234;14817.481388151404;15424.92287538562;15498.302576384061;15511;15522.068675879455;15221;15327.386904523833;15341.079535227866;15444.61388465289;15469.45856895009;2685.1810197889636;2717.021872126038;2750.339918419585;2766.073365422586;2768.861556922156;2707.390837061665;2717.4836781011645;2725.9863700681467;2729.0857562716515;2731.098737416648;2408.0969636386353;2469.6665950096776;2473.987630061847;2475.2945410557995;2478.764517370856;2561.3212498687863;2588.6246494258417;2589.559774838282;2592.4555843272747;2593.818432709711;2573.819832611718;2577.1753039027517;2590.119359417807;2590.7927365810688;2591.4687489064695;14664.486742964053;14670.119792812358;14728.337224824909;14757.26213689322;14778.187199704013;7655.2344765523;7966.960165199195;8008.199180082003;8012.519248845029;8017.118117007125;5402.216678581583;5503.422140675251;5724.341700704431;5755.971220143914;5772.105323674795;1881.416760804155;1898.4399602117408;1909.4844392014218;1953.3163392812544;1966.410076976901;22352.88823555888;23127.884360578257;23215.071397144093;26381.07666231692;26457.074002410016;6705.664716764142;7264.927350726531;7292.781216563406;7357.117145942414;7497.625118744041;20378.286759963332;20427.285045023353;20429.284975025803;20455.693164602544;20472.181112755323;8229.25936665691;8400.789980250544;8407.495550267004;8521.318294536422;8539.786505337417;7462.365698915653;7470.402367810562;7491.550506969599;7507.211742766931;7509.812254693677;5445.2921120254905;5792.536597072224;5797.101449275369;5837.67892765902;5979.1629171915965;1779.0837718574944;1803.8556915446995;1804.2692709452692;1807.647508735784;1854.4436668999515;861.6079683743882;868.9739307820649;877.3551439691821;885.9988213318908;894.1282249806387;8673.262772664268;8848.336374771918;8890.710846927159;8917.598708058153;8953.955230223808;711.6619605687257;712.4905692429937;714.1287629092499;725.0429433148299;734.3097488360924;4456.955430445654;4490.191765482245;4507.211238033331;4535.274356103007;4618.49196588375;20864.26975055866;21455.785442145378;21571.2450064247;21695;21765.347039588836;17623.471295861145;18886.90556547236;19164.04179791005;21286.36140915775;21623.67564486534;11116.722081947853;11245.15661325404;11476.770464590829;11503.827442588536;11597.6520704379;8922.330825188006;8943.150400711922;8952.462852228888;8989.640414383613;8992;17407.91296043512;17771.289148434436;17826.5543361417;18006;18232.088395580435;18795.34216302423;18978.051097444797;19155.90422047881;19381.61236775285;19387.709184361964;11896.76206475883;11973.401329933642;12059.51761929513;12091.81862272049;12102.636920892388;13103.60689179326;13223.603291901258;13234.073614846868;13261.469541218243;13322.733545329233;11318.094552435621;11479.08167346627;11545.307281563133;11586.594469193538;11698.76602467929;10977.28647637901;11124.777504449703;11254.662360129209;11335.376554289593;11347.716307092389;9665.90334096678;9728.805423891341;9772.071653192936;9773.41359518431;9788.461634610165;6759.898601520883;6783.084283621648;6797.456203503807;6830.487713421613;6846.075779769667;6760.526763126534;6781.966090169518;6786.253512113565;6814.795556133324;6836.38472537474 15:07:17 INFO - PID 9158 | |4;prototype.html;501.41810332310484;530.7531997621106;531.9468053194684;532.0312655382962;532.65377504622;6289.176138919708;6340.809775706731;6360.332165122665;6365.777197798078;6471.158749362577;6247.219097612799;6285.025820997753;6295.590786598867;6328.841778955529;6337.714802833872;5193;5250.238715386276;5277.044854881259;5306.151015837467;5312.787488500475;5243.239730239113;5304.20436934459;5338.225957236198;5340.839774806762;5349.09065458871;4860.513948605147;4924.827631032915;5006.524380183895;5012.298278241049;5033.773480193382;4924.556789888891;4973.651844370896;4985.900281994358;5034.09386310464;5035.924461133086;4490.348899409567;4491.191585514606;4500.144972455223;4504.234280172379;4511.6165125964335;6001.459868611846;6136.140940268366;6198.171539395889;6241.906371404432;6258.123862659231;5673.432656734335;5735.741891614845;5738.971305143447;5739.651181972233;5793.7972170974235;6512.5766825156215;6532.7713530026695;6575.3095924927675;6614.140161778938;6634.341414646338;4900.26496025599;4934.309196712463;4943.851684449436;4961.305417241589;4972.105021096201;6632.336766323378;6763.830904227384;6771.627560484122;6869.381755642016;7006.159260888726;4993.700377977333;5008;5023.824166154167;5038.118329292359;5059.848204553869;5066.974665126724;5103.668261562986;5105.01356706331;5112.156494178419;5131.7177555234075;5648.096304591246;5701.372848986608;5722.141678748138;5728.856778580569;5768.682722450221;6656.8668626627195;6695.866082678319;6710.798676039727;6735.764248251287;6740.494462915301;1767.7978974297343;1768.8319609637065;1770.5396596884902;1777.235788610884;1785.7589225454658;1173.16705139352;1225.6384366611871;1231.975360492803;1237.566851601932;1248.4257241668934;5714.79998200061;5787.421257874263;5827.679477628772;5858.50202732764;5909.852253693606;6654.73381064752;6693.330666933268;6722.663866806738;6818.386345228953;6868.896966545506;5615.382307946123;5638.746256418471;5658.7170641467765;5670.914936275959;5764.193012978187;3541.5041894134843;3606.7294952878115;3615.9096022599647;3630;3636.6726994570618;6589.341065893373;6662.83342916431;6673.766418175341;6688.29772873851;6731.831704207336;6541.672916354259;6891.414229790524;6913.446924246048;6918.481113916477;7012.582073293792;6522.010786710099;6555;6567.343265673395;6594.472442204612;6595.769148079794;6619.933800661932;6650.334966503311;6658.83352916181;6748.628825414453;6775.220849602359;6597.439217666552;6614.140161778938;6670.466362690876;6694.3933455969245;6746.190457144978;6387.297397286202;6409.359064093554;6419.432227109193;6559.180102487189;6619.371159739817;5006.798368391487;5025.346704928336;5029.346184995927;5033.823816166417;5037.345145131109;6466.741330346734;6503.707333169924;6532.150820393318;6866.862662746817;6880.69036893351;6343.175387199634;6418.6469744164515;6471.967640161769;6475.546711730133;6478;6524.445422139172;6536.346365363425;6573.375529324707;6599.8020059398295;6613.875641141114;6436.871262574816;6443.355664433707;6447.774327898689;6500.577462464925;6508.219013718384;6421.839454013687;6585.703643335965;6607.438367738796;6645.833854153491;6655.667216639245;6374.513939563667;6423.389777971085;6437.806865794034;6458;6490.123833282447 15:07:17 INFO - PID 9158 | |5;yui.html;889.9110088991101;912.7626817027573;918.8529835226365;922.5710044829153;928.4754113925634;17990.640187196248;18528.0735963202;18584.53538661531;18639.534011649717;18645.533861653465;16925.830741692578;17029.574260643458;17090.401835935714;17105.82894171058;17137.657246855055;942.6182396129561;951.2960409297104;952.3190918493276;956.206348730552;956.4548207521715;990.2424645146468;992.9553170107363;993.7465946183713;994.5425104451961;994.9005099490065;941.7880976780239;1021.6628512590864;1023.8464230365468;1026.5944951744093;1037.123630532203;1006.5118417567473;1009.7122320138762;1013.3514550687565;1013.4679293370965;1024.5235965276145;716.6667499612705;737.4542838299674;740.9036825212742;740.970361185552;752.5710345103239;20023.699644505345;20289.884056376894;20332.898335508376;20369.79630203694;20421.795782042285;21204.893975530176;21351.25270615521;21882.23412180566;22124.446888827748;22143.44641383962;16210.594735131599;16331.510054698378;16380.672386552322;16514.6697066058;16599.087050212234;3803.0112170835505;3803.2013277211818;3827.311084004878;3829.7319187656876;3833.3291673957224;99796.81392248992;139655.30172349175;139874;141572;142493;16804.411845585346;17380.913095434695;17485.213165407586;17528.47414577539;17543.473695789147;31507.84246078755;32317.676823231468;32420.675793242237;32459.675403246136;32607.347853042807;9247.861282080774;9469.573869175903;9471.47906865129;9541.3321067526;9542.42745435276;4408.779561021936;4468.4414448193975;4481.395011673448;4491.348754430589;4495.280755079171;5480.424555421703;5594.41258667834;5597.328320601554;5597.888042239132;5623.465770751772;1066.7759770448138;1127.644791890552;1131.2081542919825;1140.0765380042192;1144.1247445704043;680.557637535596;694.1912671737471;698.2563569798149;698.5703792167781;705.6753893209078;11820.468078936297;11910.46402911871;12315.4458049388;12360.505579776709;12560.371981400893;682.952193346471;687.2577616174519;695.5791745993702;707.211459222973;709.5068927095722;5602.355729091125;5629.296337957755;5639.943600564024;5705.515031222392;5737.196792449061;120935.39532302282;124844;125689;128075;131390.34304828415;108096;111710.44144779224;111966.44016780028;114000;114358;92972.53513732388;93215;95907.52046239724;97593;97669;10262.127719143957;10577.947110264708;10612.575496980344;10613.416262105658;10774.730631733955;43684;44025;44336.77831610821;44737.32894006527;44836.551634483236;55727.721361392934;55860;56710;56852.71573642271;58371.70814145902;15173.089614623157;15352;15384.230788460756;15489.690206196039;15496.225188740293;17061.573460663087;17088.145592720564;17296.913515432847;17434.302627894744;17490.650186996445;13892.444302227797;13954;14024.158550487004;14088.36602352876;14099.718005640036;16070.919645401698;16305.836941630907;16328.510144695678;16503.257353418885;16505.33978640841;15909.443169489012;16148.67702645964;16351;16376.590585235464;16407.507774766775;11019.338839669645;11279.661610151708;11287.04060154896;11356.432178391213;11403.144764142888;12389.680753937726;12436.626901192978;12461.940735037624;12568.622941311774;12614.810777838156 15:07:17 INFO - PID 9158 | __end_tp_report 15:07:17 INFO - PID 9158 | __start_cc_report 15:07:17 INFO - PID 9158 | _x_x_mozilla_cycle_collect,289 15:07:17 INFO - PID 9158 | __end_cc_report 15:07:17 INFO - PID 9158 | __startTimestamp1505599637291__endTimestamp 15:07:17 INFO - PID 9158 | 15:07:17 INFO - PID 9158 | ------- Summary: start ------- 15:07:17 INFO - PID 9158 | Number of tests: 6 15:07:17 INFO - PID 9158 | 15:07:17 INFO - PID 9158 | [#0] dojo.html Cycles:165 Average:6163.93 Median:6441.13 stddev:822.29 (12.8%) stddev-sans-first:788.75 15:07:17 INFO - PID 9158 | Values: 3093.7 3113.5 3114.2 3140.3 3161.3 6344.5 6353.8 6376.7 6423.6 6430.2 6100.3 6202.3 6230.1 6250.9 6255.7 5677.9 5786.9 5830.3 5845.1 5881.5 5837.6 5895.6 5896.2 5911.7 5925.1 1316.4 5682.5 5714.8 5719.6 5855.9 5778.6 5786.0 5833.5 5860.2 5868.6 5740.9 5749.5 5836.1 5838.8 5852.6 6258.8 6286.8 6306.6 6337.6 6342.5 6700.7 6735.3 6780.7 6783.4 6809.7 6552.2 6660.6 6681.6 6696.5 6699.2 6089.4 6140.2 6161.8 6166.2 6166.8 6786.4 6793.8 6798.0 6801.5 6802.6 6573.7 6666.7 6711.3 6716.6 6717.7 6708.9 6716.4 6801.0 6804.6 6806.7 6512.1 6664.2 6668.8 6734.2 6739.1 6608.6 6693.0 6736.4 6784.9 6790.2 5364.2 5380.5 5382.5 5392.7 5399.4 4590.4 4609.9 4653.9 4672.7 4675.9 5689.9 5772.6 5832.4 5901.5 5916.9 6664.9 6681.3 6683.8 6701.2 6713.7 5891.2 5891.7 5904.7 5908.4 5921.8 5716.3 5783.9 5848.8 5868.1 5871.0 6545.3 6556.1 6563.0 6647.4 6659.4 6726.4 6735.1 6752.6 6760.6 6761.8 6448.2 6566.0 6625.1 6625.4 6631.2 6599.9 6604.7 6617.3 6694.6 6699.1 6578.1 6700.0 6710.1 6803.0 6827.7 6511.1 6519.2 6519.3 6539.8 6558.9 6405.0 6493.8 6567.2 6580.2 6588.7 6439.3 6441.1 6502.8 6504.6 6512.3 6453.0 6512.6 6531.2 6572.3 6632.6 6291.1 6404.0 6406.6 6414.9 6415.9 15:07:17 INFO - PID 9158 | 15:07:17 INFO - PID 9158 | [#1] ext.html Cycles:180 Average:36774.18 Median:3592.66 stddev:50005.82 (1391.9%) stddev-sans-first:50073.40 15:07:17 INFO - PID 9158 | Values: 863.1 883.6 890.4 891.9 893.5 38957.2 39765.0 42566.5 42623.0 42915.6 39846.2 40020.0 40028.6 40106.6 40119.0 6969.6 7058.0 7060.7 7063.2 7065.8 7782.5 7951.2 7958.3 7964.4 7966.0 7932.6 7986.4 7991.1 7993.4 8002.0 7790.3 7911.3 7964.8 7977.0 7979.2 7822.3 7885.1 7893.7 7899.6 7900.5 37764.8 37996.4 38025.8 38248.0 38254.6 3550.6 3581.6 3587.6 3589.2 3596.2 31635.4 31717.8 31747.0 31783.7 31814.0 5247.6 5272.2 5274.8 5282.3 5288.2 180486.0 180559.0 181758.0 182500.0 182844.0 48881.8 48981.3 49028.0 49246.8 49334.5 43614.8 44146.6 50393.7 51041.2 51131.2 16567.9 16593.8 16650.6 16706.9 16751.7 13668.7 13762.2 13768.4 13773.1 13776.0 14076.8 14100.3 14106.2 14112.6 14245.0 5758.1 5814.3 5833.3 5834.8 5895.8 1014.9 1019.5 1027.9 1035.7 1040.3 22733.3 22962.5 23050.7 23093.3 23237.8 1121.9 1126.8 1132.8 1133.5 1146.5 12069.6 12266.6 12286.9 12299.0 12369.2 213753.0 214294.0 214500.0 214719.0 215775.0 52430.7 52552.5 52719.5 52719.5 52907.7 1457.3 1463.7 1481.5 1482.5 1485.8 21866.8 22419.9 22557.7 22622.3 22769.5 37286.4 37391.4 37424.4 37451.3 37456.0 182105.0 182410.0 182531.0 182587.0 182706.0 33758.3 34972.8 36705.8 36805.0 36886.4 46267.3 47308.3 47328.0 47342.3 47451.0 34279.0 34440.5 34725.3 34846.0 35252.6 33300.2 33512.5 33523.3 33601.0 34154.7 37209.6 37580.8 37647.2 37651.4 37664.8 33049.7 33051.3 33074.3 33249.5 33687.3 23616.6 24567.9 24667.6 24752.6 24785.5 15:07:17 INFO - PID 9158 | 15:07:17 INFO - PID 9158 | [#2] jquery.html Cycles:180 Average:32921.04 Median:22467.22 stddev:76037.69 (338.4%) stddev-sans-first:76212.13 15:07:17 INFO - PID 9158 | Values: 539.9 562.1 564.9 580.2 586.1 22291.6 23033.7 23061.3 23066.5 23067.5 23464.2 24666.1 24696.6 24976.1 25150.9 6322.4 6461.6 6482.9 6487.1 6497.5 6348.8 6360.4 6459.6 6466.9 6636.8 6588.9 6596.9 6599.3 6599.6 6602.6 6527.2 6561.3 6567.9 6578.2 6581.7 6062.3 6081.3 6101.7 6131.3 6133.1 27048.0 27877.3 28199.3 28345.7 28377.4 2055.4 2081.7 2096.9 2098.9 2102.7 19185.7 19714.6 19715.0 19715.0 19759.7 2316.6 2350.2 2385.5 2395.2 2426.0 116363.0 121216.0 135600.0 135668.0 140002.3 14136.8 14487.6 14535.9 14651.3 14684.0 22642.9 22653.4 22726.8 22747.8 22786.5 10015.6 10213.2 10252.7 10296.9 10329.4 9489.5 9537.7 9561.2 9582.6 9643.6 8735.7 8804.0 8853.5 8891.2 9123.7 2505.3 2512.0 2528.8 2600.6 2602.2 966.0 978.2 981.8 982.8 998.0 18577.6 18637.0 18708.5 18902.2 19241.0 1028.4 1033.4 1042.2 1043.1 1048.4 10290.8 10380.3 10461.1 10508.1 10510.6 431808.0 440510.0 450703.0 460832.0 462406.0 112136.0 113056.0 113290.0 115005.4 115907.4 1130.8 1151.5 1170.2 1171.0 1177.4 16897.6 16931.0 17187.7 17404.7 17754.5 53743.7 55274.0 55889.2 56288.7 57044.0 68043.3 68642.3 69144.7 69187.0 69447.0 13882.5 13980.4 14022.2 14168.6 14178.6 21432.4 21846.3 21934.0 21934.7 21978.8 16664.3 16817.2 17066.5 17073.6 17206.2 15148.8 15226.5 15624.6 16091.2 16101.4 17589.9 17631.5 17677.5 17912.4 17954.3 13755.2 13798.6 13815.7 13889.3 13915.7 17066.1 17199.5 17302.2 17426.7 17446.2 15:07:17 INFO - PID 9158 | 15:07:17 INFO - PID 9158 | [#3] mootools.html Cycles:180 Average:9324.20 Median:2582.90 stddev:6544.50 (253.4%) stddev-sans-first:6535.06 15:07:17 INFO - PID 9158 | Values: 1296.9 1390.4 1394.5 1400.8 1401.7 14817.5 15424.9 15498.3 15511.0 15522.1 15221.0 15327.4 15341.1 15444.6 15469.5 2685.2 2717.0 2750.3 2766.1 2768.9 2707.4 2717.5 2726.0 2729.1 2731.1 2408.1 2469.7 2474.0 2475.3 2478.8 2561.3 2588.6 2589.6 2592.5 2593.8 2573.8 2577.2 2590.1 2590.8 2591.5 14664.5 14670.1 14728.3 14757.3 14778.2 7655.2 7967.0 8008.2 8012.5 8017.1 5402.2 5503.4 5724.3 5756.0 5772.1 1881.4 1898.4 1909.5 1953.3 1966.4 22352.9 23127.9 23215.1 26381.1 26457.1 6705.7 7264.9 7292.8 7357.1 7497.6 20378.3 20427.3 20429.3 20455.7 20472.2 8229.3 8400.8 8407.5 8521.3 8539.8 7462.4 7470.4 7491.6 7507.2 7509.8 5445.3 5792.5 5797.1 5837.7 5979.2 1779.1 1803.9 1804.3 1807.6 1854.4 861.6 869.0 877.4 886.0 894.1 8673.3 8848.3 8890.7 8917.6 8954.0 711.7 712.5 714.1 725.0 734.3 4457.0 4490.2 4507.2 4535.3 4618.5 20864.3 21455.8 21571.2 21695.0 21765.3 17623.5 18886.9 19164.0 21286.4 21623.7 11116.7 11245.2 11476.8 11503.8 11597.7 8922.3 8943.2 8952.5 8989.6 8992.0 17407.9 17771.3 17826.6 18006.0 18232.1 18795.3 18978.1 19155.9 19381.6 19387.7 11896.8 11973.4 12059.5 12091.8 12102.6 13103.6 13223.6 13234.1 13261.5 13322.7 11318.1 11479.1 11545.3 11586.6 11698.8 10977.3 11124.8 11254.7 11335.4 11347.7 9665.9 9728.8 9772.1 9773.4 9788.5 6759.9 6783.1 6797.5 6830.5 6846.1 6760.5 6782.0 6786.3 6814.8 6836.4 15:07:17 INFO - PID 9158 | 15:07:17 INFO - PID 9158 | [#4] prototype.html Cycles:180 Average:5554.19 Median:6271.57 stddev:1545.06 (24.6%) stddev-sans-first:1502.13 15:07:17 INFO - PID 9158 | Values: 501.4 530.8 531.9 532.0 532.7 6289.2 6340.8 6360.3 6365.8 6471.2 6247.2 6285.0 6295.6 6328.8 6337.7 5193.0 5250.2 5277.0 5306.2 5312.8 5243.2 5304.2 5338.2 5340.8 5349.1 4860.5 4924.8 5006.5 5012.3 5033.8 4924.6 4973.7 4985.9 5034.1 5035.9 4490.3 4491.2 4500.1 4504.2 4511.6 6001.5 6136.1 6198.2 6241.9 6258.1 5673.4 5735.7 5739.0 5739.7 5793.8 6512.6 6532.8 6575.3 6614.1 6634.3 4900.3 4934.3 4943.9 4961.3 4972.1 6632.3 6763.8 6771.6 6869.4 7006.2 4993.7 5008.0 5023.8 5038.1 5059.8 5067.0 5103.7 5105.0 5112.2 5131.7 5648.1 5701.4 5722.1 5728.9 5768.7 6656.9 6695.9 6710.8 6735.8 6740.5 1767.8 1768.8 1770.5 1777.2 1785.8 1173.2 1225.6 1232.0 1237.6 1248.4 5714.8 5787.4 5827.7 5858.5 5909.9 6654.7 6693.3 6722.7 6818.4 6868.9 5615.4 5638.7 5658.7 5670.9 5764.2 3541.5 3606.7 3615.9 3630.0 3636.7 6589.3 6662.8 6673.8 6688.3 6731.8 6541.7 6891.4 6913.4 6918.5 7012.6 6522.0 6555.0 6567.3 6594.5 6595.8 6619.9 6650.3 6658.8 6748.6 6775.2 6597.4 6614.1 6670.5 6694.4 6746.2 6387.3 6409.4 6419.4 6559.2 6619.4 5006.8 5025.3 5029.3 5033.8 5037.3 6466.7 6503.7 6532.2 6866.9 6880.7 6343.2 6418.6 6472.0 6475.5 6478.0 6524.4 6536.3 6573.4 6599.8 6613.9 6436.9 6443.4 6447.8 6500.6 6508.2 6421.8 6585.7 6607.4 6645.8 6655.7 6374.5 6423.4 6437.8 6458.0 6490.1 15:07:17 INFO - PID 9158 | 15:07:17 INFO - PID 9158 | [#5] yui.html Cycles:180 Average:24274.02 Median:18612.03 stddev:35288.67 (189.6%) stddev-sans-first:35343.98 15:07:17 INFO - PID 9158 | Values: 889.9 912.8 918.9 922.6 928.5 17990.6 18528.1 18584.5 18639.5 18645.5 16925.8 17029.6 17090.4 17105.8 17137.7 942.6 951.3 952.3 956.2 956.5 990.2 993.0 993.7 994.5 994.9 941.8 1021.7 1023.8 1026.6 1037.1 1006.5 1009.7 1013.4 1013.5 1024.5 716.7 737.5 740.9 741.0 752.6 20023.7 20289.9 20332.9 20369.8 20421.8 21204.9 21351.3 21882.2 22124.4 22143.4 16210.6 16331.5 16380.7 16514.7 16599.1 3803.0 3803.2 3827.3 3829.7 3833.3 99796.8 139655.3 139874.0 141572.0 142493.0 16804.4 17380.9 17485.2 17528.5 17543.5 31507.8 32317.7 32420.7 32459.7 32607.3 9247.9 9469.6 9471.5 9541.3 9542.4 4408.8 4468.4 4481.4 4491.3 4495.3 5480.4 5594.4 5597.3 5597.9 5623.5 1066.8 1127.6 1131.2 1140.1 1144.1 680.6 694.2 698.3 698.6 705.7 11820.5 11910.5 12315.4 12360.5 12560.4 683.0 687.3 695.6 707.2 709.5 5602.4 5629.3 5639.9 5705.5 5737.2 120935.4 124844.0 125689.0 128075.0 131390.3 108096.0 111710.4 111966.4 114000.0 114358.0 92972.5 93215.0 95907.5 97593.0 97669.0 10262.1 10577.9 10612.6 10613.4 10774.7 43684.0 44025.0 44336.8 44737.3 44836.6 55727.7 55860.0 56710.0 56852.7 58371.7 15173.1 15352.0 15384.2 15489.7 15496.2 17061.6 17088.1 17296.9 17434.3 17490.7 13892.4 13954.0 14024.2 14088.4 14099.7 16070.9 16305.8 16328.5 16503.3 16505.3 15909.4 16148.7 16351.0 16376.6 16407.5 11019.3 11279.7 11287.0 11356.4 11403.1 12389.7 12436.6 12461.9 12568.6 12614.8 15:07:17 INFO - PID 9158 | -------- Summary: end -------- 15:07:17 INFO - PID 9158 | 15:07:18 INFO - TEST-INFO | 9158: exit 0 15:07:18 INFO - TEST-OK | dromaeo_css | took 1108389ms 15:07:18 INFO - TEST-START | kraken 15:07:18 INFO - Initialising browser for kraken test... 15:07:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60208/getInfo.html -profile /tmp/tmprjzOX7/profile 15:07:18 INFO - TEST-INFO | started process 9529 (/builds/slave/test/build/application/firefox/firefox http://localhost:60208/getInfo.html) 15:07:23 INFO - TEST-INFO | 9529: exit 0 15:07:23 INFO - Browser initialized. 15:07:23 INFO - Running cycle 1/1 for kraken test... 15:07:23 INFO - Using env: {'DISPLAY': ':0', 15:07:23 INFO - 'HOME': '/home/cltbld', 15:07:23 INFO - 'JSGC_DISABLE_POISONING': '1', 15:07:23 INFO - 'LANG': 'en_US.UTF-8', 15:07:23 INFO - 'LANGUAGE': 'en_US:en', 15:07:23 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:07:23 INFO - 'LOGNAME': 'cltbld', 15:07:23 INFO - 'MAIL': '/var/mail/cltbld', 15:07:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:07:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:07:23 INFO - 'MOZ_CRASHREPORTER': '1', 15:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:23 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:07:23 INFO - 'MOZ_NO_REMOTE': '1', 15:07:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:07:23 INFO - 'NO_EM_RESTART': '1', 15:07:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:23 INFO - 'PWD': '/builds/slave/test', 15:07:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:07:23 INFO - 'RUST_BACKTRACE': 'full', 15:07:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:07:23 INFO - 'SHELL': '/bin/bash', 15:07:23 INFO - 'SHLVL': '1', 15:07:23 INFO - 'TERM': 'linux', 15:07:23 INFO - 'TMOUT': '86400', 15:07:23 INFO - 'USER': 'cltbld', 15:07:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563', 15:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:23 INFO - '_': '/tools/buildbot/bin/python'} 15:07:23 INFO - TEST-INFO | started process 9763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprjzOX7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:07:24 INFO - PID 9763 | 15:07:24 INFO - PID 9763 | (/builds/slave/test/build/application/firefox/firefox:9812): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:07:24 INFO - PID 9763 | 15:07:34 INFO - PID 9763 | RSS: Main: 155090944 15:07:34 INFO - PID 9763 | 15:07:37 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60208/tests/kraken/driver.html?testName=audio-beat-detection) 15:07:38 INFO - PID 9763 | RSS: Main: 159850496 15:07:38 INFO - PID 9763 | 15:07:41 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60208/tests/kraken/driver.html?testName=audio-dft) 15:07:41 INFO - PID 9763 | RSS: Main: 159883264 15:07:41 INFO - PID 9763 | 15:07:44 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60208/tests/kraken/driver.html?testName=audio-fft) 15:07:45 INFO - PID 9763 | RSS: Main: 156565504 15:07:45 INFO - PID 9763 | 15:07:47 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60208/tests/kraken/driver.html?testName=audio-oscillator) 15:07:47 INFO - PID 9763 | RSS: Main: 157704192 15:07:47 INFO - PID 9763 | 15:07:50 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60208/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:07:50 INFO - PID 9763 | RSS: Main: 157847552 15:07:50 INFO - PID 9763 | 15:07:53 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60208/tests/kraken/driver.html?testName=imaging-darkroom) 15:07:54 INFO - PID 9763 | RSS: Main: 160186368 15:07:54 INFO - PID 9763 | 15:07:58 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60208/tests/kraken/driver.html?testName=imaging-desaturate) 15:07:58 INFO - PID 9763 | RSS: Main: 160542720 15:07:58 INFO - PID 9763 | 15:08:01 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60208/tests/kraken/driver.html?testName=json-parse-financial) 15:08:02 INFO - PID 9763 | RSS: Main: 160571392 15:08:02 INFO - PID 9763 | 15:08:03 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60208/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:08:04 INFO - PID 9763 | RSS: Main: 160374784 15:08:04 INFO - PID 9763 | 15:08:06 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:08:06 INFO - PID 9763 | RSS: Main: 160399360 15:08:06 INFO - PID 9763 | 15:08:08 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:08:09 INFO - PID 9763 | RSS: Main: 157257728 15:08:09 INFO - PID 9763 | 15:08:12 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:08:12 INFO - PID 9763 | RSS: Main: 157794304 15:08:12 INFO - PID 9763 | 15:08:15 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:08:16 INFO - PID 9763 | RSS: Main: 157937664 15:08:16 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60208/tests/kraken/driver.html?testName=ai-astar) 15:08:18 INFO - PID 9763 | RSS: Main: 159338496 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | __start_tp_report 15:08:18 INFO - PID 9763 | _x_x_mozilla_page_load 15:08:18 INFO - PID 9763 | _x_x_mozilla_page_load_details 15:08:18 INFO - PID 9763 | |i|pagename|runs| 15:08:18 INFO - PID 9763 | |0;ai-astar;110;107;105;107;108;100;111;106;108;108 15:08:18 INFO - PID 9763 | |1;audio-beat-detection;116;122;120;149;119;116;120;124;151;114 15:08:18 INFO - PID 9763 | |2;audio-dft;163;161;163;162;160;164;162;163;163;168 15:08:18 INFO - PID 9763 | |3;audio-fft;73;73;76;74;73;77;74;74;73;73 15:08:18 INFO - PID 9763 | |4;audio-oscillator;80;80;79;78;78;78;78;79;78;78 15:08:18 INFO - PID 9763 | |5;imaging-gaussian-blur;114;113;113;113;113;114;114;113;113;115 15:08:18 INFO - PID 9763 | |6;imaging-darkroom;153;148;147;147;148;149;150;148;148;148 15:08:18 INFO - PID 9763 | |7;imaging-desaturate;100;95;96;95;96;94;99;99;99;99 15:08:18 INFO - PID 9763 | |8;json-parse-financial;54;55;54;55;55;55;55;53;54;55 15:08:18 INFO - PID 9763 | |9;json-stringify-tinderbox;37;37;37;45;37;37;38;37;36;37 15:08:18 INFO - PID 9763 | |10;stanford-crypto-aes;77;75;74;73;82;76;74;72;75;77 15:08:18 INFO - PID 9763 | |11;stanford-crypto-ccm;120;110;119;117;117;111;111;109;116;111 15:08:18 INFO - PID 9763 | |12;stanford-crypto-pbkdf2;172;175;175;168;169;189;168;166;166;176 15:08:18 INFO - PID 9763 | |13;stanford-crypto-sha256-iterative;70;63;67;69;64;65;64;69;70;63 15:08:18 INFO - PID 9763 | __end_tp_report 15:08:18 INFO - PID 9763 | __start_cc_report 15:08:18 INFO - PID 9763 | _x_x_mozilla_cycle_collect,747 15:08:18 INFO - PID 9763 | __end_cc_report 15:08:18 INFO - PID 9763 | __startTimestamp1505599698416__endTimestamp 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | ------- Summary: start ------- 15:08:18 INFO - PID 9763 | Number of tests: 14 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#0] ai-astar Cycles:10 Average:107.00 Median:108.00 stddev:3.02 (2.8%) stddev-sans-first:3.00 15:08:18 INFO - PID 9763 | Values: 110.0 107.0 105.0 107.0 108.0 100.0 111.0 106.0 108.0 108.0 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:121.00 stddev:13.46 (11.1%) stddev-sans-first:13.87 15:08:18 INFO - PID 9763 | Values: 116.0 122.0 120.0 149.0 119.0 116.0 120.0 124.0 151.0 114.0 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:2.13 (1.3%) stddev-sans-first:2.26 15:08:18 INFO - PID 9763 | Values: 163.0 161.0 163.0 162.0 160.0 164.0 162.0 163.0 163.0 168.0 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#3] audio-fft Cycles:10 Average:74.00 Median:74.00 stddev:1.41 (1.9%) stddev-sans-first:1.45 15:08:18 INFO - PID 9763 | Values: 73.0 73.0 76.0 74.0 73.0 77.0 74.0 74.0 73.0 73.0 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:78.50 stddev:0.84 (1.1%) stddev-sans-first:0.73 15:08:18 INFO - PID 9763 | Values: 80.0 80.0 79.0 78.0 78.0 78.0 78.0 79.0 78.0 78.0 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:113.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 15:08:18 INFO - PID 9763 | Values: 114.0 113.0 113.0 113.0 113.0 114.0 114.0 113.0 113.0 115.0 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.00 stddev:1.78 (1.2%) stddev-sans-first:0.93 15:08:18 INFO - PID 9763 | Values: 153.0 148.0 147.0 147.0 148.0 149.0 150.0 148.0 148.0 148.0 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:97.50 stddev:2.20 (2.3%) stddev-sans-first:2.09 15:08:18 INFO - PID 9763 | Values: 100.0 95.0 96.0 95.0 96.0 94.0 99.0 99.0 99.0 99.0 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:0.71 (1.3%) stddev-sans-first:0.73 15:08:18 INFO - PID 9763 | Values: 54.0 55.0 54.0 55.0 55.0 55.0 55.0 53.0 54.0 55.0 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:37.00 stddev:2.57 (7.0%) stddev-sans-first:2.71 15:08:18 INFO - PID 9763 | Values: 37.0 37.0 37.0 45.0 37.0 37.0 38.0 37.0 36.0 37.0 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.50 stddev:2.80 (3.7%) stddev-sans-first:2.92 15:08:18 INFO - PID 9763 | Values: 77.0 75.0 74.0 73.0 82.0 76.0 74.0 72.0 75.0 77.0 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#11] stanford-crypto-ccm Cycles:10 Average:114.10 Median:116.50 stddev:4.09 (3.5%) stddev-sans-first:3.75 15:08:18 INFO - PID 9763 | Values: 120.0 110.0 119.0 117.0 117.0 111.0 111.0 109.0 116.0 111.0 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:173.50 stddev:6.95 (4.0%) stddev-sans-first:7.37 15:08:18 INFO - PID 9763 | Values: 172.0 175.0 175.0 168.0 169.0 189.0 168.0 166.0 166.0 176.0 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:68.00 stddev:2.91 (4.3%) stddev-sans-first:2.78 15:08:18 INFO - PID 9763 | Values: 70.0 63.0 67.0 69.0 64.0 65.0 64.0 69.0 70.0 63.0 15:08:18 INFO - PID 9763 | -------- Summary: end -------- 15:08:18 INFO - PID 9763 | 15:08:18 INFO - PID 9763 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:08:19 INFO - TEST-INFO | 9763: exit 0 15:08:19 INFO - TEST-OK | kraken | took 61062ms 15:08:19 INFO - SUITE-END | took 1169s 15:08:19 INFO - Completed test suite (00:19:29) 15:08:19 INFO - javascript benchmark 15:08:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8487.424828586707, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.7370323522487, 3113.532970054492, 3114.205877501237, 3140.3091319909613, 3161.2887100402427, 6344.460720838729, 6353.809385718424, 6376.681165941707, 6423.550351475393, 6430.164078669773, 6100.267967843865, 6202.348753380887, 6230.065490176465, 6250.874982500359, 6255.718492667829, 5677.8580535486635, 5786.942130578704, 5830.32951210612, 5845.0647896336595, 5881.470667639912, 5837.649741015532, 5895.64626122434, 5896.23348964634, 5911.73397197125, 5925.111233315016, 1316.4158622523896, 5682.460166284217, 5714.799982000631, 5719.628224165437, 5855.882882342329, 5778.624389414675, 5785.971070144665, 5833.50415214703, 5860.17957485948, 5868.618539794899, 5740.913886291709, 5749.453801888814, 5836.095405212199, 5838.824835254949, 5852.619579727304, 6258.812235632939, 6286.842828929268, 6306.558540902139, 6337.588056776295, 6342.460890824285, 6700.664966751691, 6735.326467353275, 6780.660966951682, 6783.389494945429, 6809.659517024129, 6552.213734351861, 6660.56706314088, 6681.632510211936, 6696.497762667771, 6699.229588597325, 6089.421504957022, 6140.232470941132, 6161.845953851145, 6166.229221347332, 6166.84582885427, 6786.423154031864, 6793.796186114425, 6798.04827324175, 6801.4898882584, 6802.591844489297, 6573.737050517926, 6666.733330666816, 6711.3288671132495, 6716.5634233774645, 6717.731290748413, 6708.865822683519, 6716.361945615159, 6801.013852991288, 6804.557703749339, 6806.659667016629, 6512.120863683437, 6664.200295964515, 6668.799936001928, 6734.158230221223, 6739.123913891162, 6608.603483790892, 6692.966535167293, 6736.393724564813, 6784.932150678529, 6790.151231096113, 5364.22218778275, 5380.488853558905, 5382.4886635769535, 5392.73036348181, 5399.406065332811, 4590.380298659638, 4609.9308510372375, 4653.86038418848, 4672.719636821802, 4675.906481870344, 5689.857753556112, 5772.595918285764, 5832.387599302097, 5901.468867801918, 5916.852078697981, 6664.866702666017, 6681.298463661343, 6683.799486015428, 6701.229358623723, 6713.69788359525, 5891.23413956183, 5891.675957822361, 5904.7342869570975, 5908.438698323653, 5921.792737254175, 5716.314042314865, 5783.929972954933, 5848.824535263949, 5868.09044598088, 5870.970645146833, 6545.280019197884, 6556.147700798866, 6563.0, 6647.4349680276755, 6659.400653941072, 6726.39462448382, 6735.124433823669, 6752.628605426847, 6760.560563563353, 6761.763338283136, 6448.193975753031, 6565.982272747732, 6625.105610742681, 6625.4037136657935, 6631.171103612049, 6599.868002640016, 6604.735810567524, 6617.272100069084, 6694.564853284521, 6699.0621313015245, 6578.111954886029, 6700.0, 6710.094137291599, 6803.013563033233, 6827.658617069027, 6511.120998665119, 6519.217693876575, 6519.282878883224, 6539.803805885831, 6558.901616475852, 6404.967975160094, 6493.772717954849, 6567.2447668516825, 6580.21037475506, 6588.703508342041, 6439.259485159267, 6441.13044738973, 6502.837429064311, 6504.60972341661, 6512.34876512345, 6452.967735161482, 6512.5766825156215, 6531.150950376421, 6572.34276572339, 6632.635205063575, 6291.087792270004, 6404.039394090923, 6406.647634380154, 6414.871702565829, 6415.8716825662295], "value": 6104.020660473886, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.1066845814582, 883.5847151838638, 890.3811850763718, 891.9197272245497, 893.5264309915743, 38957.22085558287, 39765.0, 42566.51017214398, 42622.99999999996, 42915.57084429155, 39846.20307593854, 40020.0, 40028.59971400285, 40106.59893401065, 40119.0, 6969.581825090486, 7058.047163632921, 7060.7175712971675, 7063.223045464994, 7065.823354416155, 7782.494137881048, 7951.20487951206, 7958.283754462097, 7964.362850971937, 7966.044074711014, 7932.643031063587, 7986.361091112697, 7991.081025682034, 7993.400494962872, 8002.039755229381, 7790.337821285198, 7911.327537159348, 7964.800879978018, 7977.0, 7979.162187970295, 7822.295993360568, 7885.093214280374, 7893.684252629888, 7899.605019748989, 7900.486468379594, 37764.81117594394, 37996.43005354922, 38025.80987095075, 38248.0, 38254.61745382538, 3550.5916819565564, 3581.6418358164237, 3587.5694916609914, 3589.174489867319, 3596.1549035976523, 31635.367292654017, 31717.84141079303, 31747.0, 31783.682163178302, 31814.0, 5247.606429517763, 5272.156454967187, 5274.841754747364, 5282.260483532308, 5288.153895376721, 180485.9999999987, 180559.0, 181758.0, 182500.0, 182844.0, 48881.75559122253, 48981.26528102082, 49028.0, 49246.75376623165, 49334.506654933706, 43614.78192609017, 44146.558534414246, 50393.74015649638, 51041.23438148356, 51131.233031504555, 16567.917160414363, 16593.751093733605, 16650.58373540671, 16706.916465417595, 16751.6649667006, 13668.658283542793, 13762.24307663068, 13768.449262029406, 13773.104748191336, 13776.0, 14076.788848167285, 14100.294985250697, 14106.224157671426, 14112.576622701336, 14245.0, 5758.107493338539, 5814.30228372598, 5833.270841144857, 5834.795782147605, 5895.764169433174, 1014.9188064954786, 1019.5463018956493, 1027.9074883260394, 1035.7307100154014, 1040.287403128859, 22733.318000460014, 22962.540749184922, 23050.65424018641, 23093.307200784002, 23237.76762232356, 1121.9214654974237, 1126.7915435644268, 1132.7564573616712, 1133.455941148237, 1146.5356530605118, 12069.57756478519, 12266.570670026505, 12286.938565307295, 12299.0, 12369.196002259825, 213753.0, 214294.0, 214500.0, 214719.0, 215775.0, 52430.737846311284, 52552.474475254756, 52719.47280527222, 52719.47280527222, 52907.73546132322, 1457.2640816387657, 1463.677990842013, 1481.525911708243, 1482.5330021043337, 1485.7622780355307, 21866.781332186474, 22419.887900561047, 22557.661635075157, 22622.321330360115, 22769.544609108056, 37286.44070339001, 37391.439128413636, 37424.438633421065, 37451.250974980896, 37456.0, 182105.0, 182410.0, 182531.0, 182587.0, 182706.0, 33758.3248335027, 34972.825135874155, 36705.816470917474, 36805.0, 36886.44670330001, 46267.3059904095, 47308.344207952556, 47327.98497397453, 47342.28986565136, 47451.0, 34279.0, 34440.48339274963, 34725.30549389048, 34846.0, 35252.64747352596, 33300.1674958128, 33512.49731254082, 33523.329533409684, 33601.0, 34154.65845341515, 37209.62790372062, 37580.81209593934, 37647.24705505929, 37651.43522847105, 37664.81167594254, 33049.669503304656, 33051.33897321992, 33074.33851323008, 33249.50125748164, 33687.32625347529, 23616.645750314103, 24567.877160614797, 24667.629985549873, 24752.628710569716, 24785.50428991374], "value": 17311.177434438137, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.8797495197466, 562.1230879827469, 564.9322081350239, 580.2167074449493, 586.0710773424124, 22291.55416891663, 23033.654495182564, 23061.308160755183, 23066.538669226604, 23067.538649227004, 23464.17875374362, 24666.13668521602, 24696.62955055671, 24976.125835595758, 25150.87424562879, 6322.399372059647, 6461.6446095464735, 6482.870342593145, 6487.059376390421, 6497.545171837974, 6348.84127896804, 6360.427561519462, 6459.612423254596, 6466.870662586745, 6636.767713130042, 6588.901166482507, 6596.901046484307, 6599.307072757363, 6599.571027883197, 6602.570832895871, 6527.216733991928, 6561.3438656134485, 6567.868642627121, 6578.177727784027, 6581.736730530797, 6062.333143354227, 6081.300650425169, 6101.694915254264, 6131.264248290189, 6133.1106989486725, 27048.0, 27877.303067423272, 28199.295017624518, 28345.716542834514, 28377.432451350858, 2055.403932859469, 2081.6773400123006, 2096.895155242232, 2098.8740675559516, 2102.653062244743, 19185.712214316798, 19714.605707885905, 19715.0, 19715.0, 19759.703604445946, 2316.5830150572892, 2350.189184731265, 2385.4990452004927, 2395.2215529952837, 2426.041713523166, 116363.0, 121216.0, 135600.0, 135668.0, 140002.29998850042, 14136.787948180785, 14487.565373038826, 14535.927320363331, 14651.263927698368, 14684.0, 22642.886785566297, 22653.43366415853, 22726.772732272464, 22747.772522274896, 22786.544269114856, 10015.649452269136, 10213.182945364353, 10252.667882937925, 10296.948515257376, 10329.380237185642, 9489.478078705737, 9537.666181683746, 9561.235101192027, 9582.568784404719, 9643.566039528238, 8735.737927862174, 8804.0, 8853.468791872509, 8891.155340242667, 9123.726288211365, 2505.260948020338, 2511.9874400628246, 2528.8229823912147, 2600.609908513738, 2602.1542998525556, 965.9806803863884, 978.2125389061731, 981.7741919358588, 982.7788747531748, 997.9750506237402, 18577.628447430976, 18637.0, 18708.53228669267, 18902.243910243713, 19241.0, 1028.3572767020612, 1033.405791669793, 1042.2183362478142, 1043.1289872956168, 1048.3762161513887, 10290.794184116425, 10380.273380863418, 10461.05850473461, 10508.054275115124, 10510.632127875488, 431808.0, 440510.0, 450703.0, 460832.0, 462406.0, 112136.0, 113056.0, 113290.0, 115005.4249728746, 115907.42046289715, 1130.7512347283748, 1151.5221183208876, 1170.1925671286785, 1171.0455978377595, 1177.4348312809727, 16897.577560560592, 16931.0, 17187.742183867504, 17404.651906961535, 17754.467365979042, 53743.731281343345, 55274.0, 55889.16166257428, 56288.71855640696, 57044.0, 68043.3195668037, 68642.31357686559, 69144.6542767283, 69187.0, 69447.0, 13882.51411200603, 13980.440782368998, 14022.158670479805, 14168.574942751733, 14178.574642760734, 21432.357029289145, 21846.344609661737, 21934.0, 21934.670979935632, 21978.780212197675, 16664.25010874538, 16817.243224055193, 17066.48800535986, 17073.573160670585, 17206.225719842387, 15148.848511514743, 15226.46707365237, 15624.609384765472, 16091.195440227708, 16101.355945762507, 17589.912050440176, 17631.471055868344, 17677.469675909742, 17912.373066942593, 17954.281828727228, 13755.243461609707, 13798.586042418743, 13815.654608634864, 13889.305534723426, 13915.721685566434, 17066.14669266507, 17199.484015479557, 17302.22140003728, 17426.651466970336, 17446.214920328868], "value": 11652.35409665557, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.8767967043132, 1390.3882291791604, 1394.532831501447, 1400.7968844517552, 1401.6636007358234, 14817.481388151404, 15424.92287538562, 15498.302576384061, 15511.0, 15522.068675879455, 15221.0, 15327.386904523833, 15341.079535227866, 15444.61388465289, 15469.45856895009, 2685.1810197889636, 2717.021872126038, 2750.339918419585, 2766.073365422586, 2768.861556922156, 2707.390837061665, 2717.4836781011645, 2725.9863700681467, 2729.0857562716515, 2731.098737416648, 2408.0969636386353, 2469.6665950096776, 2473.987630061847, 2475.2945410557995, 2478.764517370856, 2561.3212498687863, 2588.6246494258417, 2589.559774838282, 2592.4555843272747, 2593.818432709711, 2573.819832611718, 2577.1753039027517, 2590.119359417807, 2590.7927365810688, 2591.4687489064695, 14664.486742964053, 14670.119792812358, 14728.337224824909, 14757.26213689322, 14778.187199704013, 7655.2344765523, 7966.960165199195, 8008.199180082003, 8012.519248845029, 8017.118117007125, 5402.216678581583, 5503.422140675251, 5724.341700704431, 5755.971220143914, 5772.105323674795, 1881.416760804155, 1898.4399602117408, 1909.4844392014218, 1953.3163392812544, 1966.410076976901, 22352.88823555888, 23127.884360578257, 23215.071397144093, 26381.07666231692, 26457.074002410016, 6705.664716764142, 7264.927350726531, 7292.781216563406, 7357.117145942414, 7497.625118744041, 20378.286759963332, 20427.285045023353, 20429.284975025803, 20455.693164602544, 20472.181112755323, 8229.25936665691, 8400.789980250544, 8407.495550267004, 8521.318294536422, 8539.786505337417, 7462.365698915653, 7470.402367810562, 7491.550506969599, 7507.211742766931, 7509.812254693677, 5445.2921120254905, 5792.536597072224, 5797.101449275369, 5837.67892765902, 5979.1629171915965, 1779.0837718574944, 1803.8556915446995, 1804.2692709452692, 1807.647508735784, 1854.4436668999515, 861.6079683743882, 868.9739307820649, 877.3551439691821, 885.9988213318908, 894.1282249806387, 8673.262772664268, 8848.336374771918, 8890.710846927159, 8917.598708058153, 8953.955230223808, 711.6619605687257, 712.4905692429937, 714.1287629092499, 725.0429433148299, 734.3097488360924, 4456.955430445654, 4490.191765482245, 4507.211238033331, 4535.274356103007, 4618.49196588375, 20864.26975055866, 21455.785442145378, 21571.2450064247, 21695.0, 21765.347039588836, 17623.471295861145, 18886.90556547236, 19164.04179791005, 21286.36140915775, 21623.67564486534, 11116.722081947853, 11245.15661325404, 11476.770464590829, 11503.827442588536, 11597.6520704379, 8922.330825188006, 8943.150400711922, 8952.462852228888, 8989.640414383613, 8992.0, 17407.91296043512, 17771.289148434436, 17826.5543361417, 18006.0, 18232.088395580435, 18795.34216302423, 18978.051097444797, 19155.90422047881, 19381.61236775285, 19387.709184361964, 11896.76206475883, 11973.401329933642, 12059.51761929513, 12091.81862272049, 12102.636920892388, 13103.60689179326, 13223.603291901258, 13234.073614846868, 13261.469541218243, 13322.733545329233, 11318.094552435621, 11479.08167346627, 11545.307281563133, 11586.594469193538, 11698.76602467929, 10977.28647637901, 11124.777504449703, 11254.662360129209, 11335.376554289593, 11347.716307092389, 9665.90334096678, 9728.805423891341, 9772.071653192936, 9773.41359518431, 9788.461634610165, 6759.898601520883, 6783.084283621648, 6797.456203503807, 6830.487713421613, 6846.075779769667, 6760.526763126534, 6781.966090169518, 6786.253512113565, 6814.795556133324, 6836.38472537474], "value": 6647.112628725561, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.41810332310484, 530.7531997621106, 531.9468053194684, 532.0312655382962, 532.65377504622, 6289.176138919708, 6340.809775706731, 6360.332165122665, 6365.777197798078, 6471.158749362577, 6247.219097612799, 6285.025820997753, 6295.590786598867, 6328.841778955529, 6337.714802833872, 5193.0, 5250.238715386276, 5277.044854881259, 5306.151015837467, 5312.787488500475, 5243.239730239113, 5304.20436934459, 5338.225957236198, 5340.839774806762, 5349.09065458871, 4860.513948605147, 4924.827631032915, 5006.524380183895, 5012.298278241049, 5033.773480193382, 4924.556789888891, 4973.651844370896, 4985.900281994358, 5034.09386310464, 5035.924461133086, 4490.348899409567, 4491.191585514606, 4500.144972455223, 4504.234280172379, 4511.6165125964335, 6001.459868611846, 6136.140940268366, 6198.171539395889, 6241.906371404432, 6258.123862659231, 5673.432656734335, 5735.741891614845, 5738.971305143447, 5739.651181972233, 5793.7972170974235, 6512.5766825156215, 6532.7713530026695, 6575.3095924927675, 6614.140161778938, 6634.341414646338, 4900.26496025599, 4934.309196712463, 4943.851684449436, 4961.305417241589, 4972.105021096201, 6632.336766323378, 6763.830904227384, 6771.627560484122, 6869.381755642016, 7006.159260888726, 4993.700377977333, 5008.0, 5023.824166154167, 5038.118329292359, 5059.848204553869, 5066.974665126724, 5103.668261562986, 5105.01356706331, 5112.156494178419, 5131.7177555234075, 5648.096304591246, 5701.372848986608, 5722.141678748138, 5728.856778580569, 5768.682722450221, 6656.8668626627195, 6695.866082678319, 6710.798676039727, 6735.764248251287, 6740.494462915301, 1767.7978974297343, 1768.8319609637065, 1770.5396596884902, 1777.235788610884, 1785.7589225454658, 1173.16705139352, 1225.6384366611871, 1231.975360492803, 1237.566851601932, 1248.4257241668934, 5714.79998200061, 5787.421257874263, 5827.679477628772, 5858.50202732764, 5909.852253693606, 6654.73381064752, 6693.330666933268, 6722.663866806738, 6818.386345228953, 6868.896966545506, 5615.382307946123, 5638.746256418471, 5658.7170641467765, 5670.914936275959, 5764.193012978187, 3541.5041894134843, 3606.7294952878115, 3615.9096022599647, 3630.0, 3636.6726994570618, 6589.341065893373, 6662.83342916431, 6673.766418175341, 6688.29772873851, 6731.831704207336, 6541.672916354259, 6891.414229790524, 6913.446924246048, 6918.481113916477, 7012.582073293792, 6522.010786710099, 6555.0, 6567.343265673395, 6594.472442204612, 6595.769148079794, 6619.933800661932, 6650.334966503311, 6658.83352916181, 6748.628825414453, 6775.220849602359, 6597.439217666552, 6614.140161778938, 6670.466362690876, 6694.3933455969245, 6746.190457144978, 6387.297397286202, 6409.359064093554, 6419.432227109193, 6559.180102487189, 6619.371159739817, 5006.798368391487, 5025.346704928336, 5029.346184995927, 5033.823816166417, 5037.345145131109, 6466.741330346734, 6503.707333169924, 6532.150820393318, 6866.862662746817, 6880.69036893351, 6343.175387199634, 6418.6469744164515, 6471.967640161769, 6475.546711730133, 6478.0, 6524.445422139172, 6536.346365363425, 6573.375529324707, 6599.8020059398295, 6613.875641141114, 6436.871262574816, 6443.355664433707, 6447.774327898689, 6500.577462464925, 6508.219013718384, 6421.839454013687, 6585.703643335965, 6607.438367738796, 6645.833854153491, 6655.667216639245, 6374.513939563667, 6423.389777971085, 6437.806865794034, 6458.0, 6490.123833282447], "value": 5100.2216344626295, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.9110088991101, 912.7626817027573, 918.8529835226365, 922.5710044829153, 928.4754113925634, 17990.640187196248, 18528.0735963202, 18584.53538661531, 18639.534011649717, 18645.533861653465, 16925.830741692578, 17029.574260643458, 17090.401835935714, 17105.82894171058, 17137.657246855055, 942.6182396129561, 951.2960409297104, 952.3190918493276, 956.206348730552, 956.4548207521715, 990.2424645146468, 992.9553170107363, 993.7465946183713, 994.5425104451961, 994.9005099490065, 941.7880976780239, 1021.6628512590864, 1023.8464230365468, 1026.5944951744093, 1037.123630532203, 1006.5118417567473, 1009.7122320138762, 1013.3514550687565, 1013.4679293370965, 1024.5235965276145, 716.6667499612705, 737.4542838299674, 740.9036825212742, 740.970361185552, 752.5710345103239, 20023.699644505345, 20289.884056376894, 20332.898335508376, 20369.79630203694, 20421.795782042285, 21204.893975530176, 21351.25270615521, 21882.23412180566, 22124.446888827748, 22143.44641383962, 16210.594735131599, 16331.510054698378, 16380.672386552322, 16514.6697066058, 16599.087050212234, 3803.0112170835505, 3803.2013277211818, 3827.311084004878, 3829.7319187656876, 3833.3291673957224, 99796.81392248992, 139655.30172349175, 139874.0, 141572.0, 142493.0, 16804.411845585346, 17380.913095434695, 17485.213165407586, 17528.47414577539, 17543.473695789147, 31507.84246078755, 32317.676823231468, 32420.675793242237, 32459.675403246136, 32607.347853042807, 9247.861282080774, 9469.573869175903, 9471.47906865129, 9541.3321067526, 9542.42745435276, 4408.779561021936, 4468.4414448193975, 4481.395011673448, 4491.348754430589, 4495.280755079171, 5480.424555421703, 5594.41258667834, 5597.328320601554, 5597.888042239132, 5623.465770751772, 1066.7759770448138, 1127.644791890552, 1131.2081542919825, 1140.0765380042192, 1144.1247445704043, 680.557637535596, 694.1912671737471, 698.2563569798149, 698.5703792167781, 705.6753893209078, 11820.468078936297, 11910.46402911871, 12315.4458049388, 12360.505579776709, 12560.371981400893, 682.952193346471, 687.2577616174519, 695.5791745993702, 707.211459222973, 709.5068927095722, 5602.355729091125, 5629.296337957755, 5639.943600564024, 5705.515031222392, 5737.196792449061, 120935.39532302282, 124844.0, 125689.0, 128075.0, 131390.34304828415, 108096.0, 111710.44144779224, 111966.44016780028, 114000.0, 114358.0, 92972.53513732388, 93215.0, 95907.52046239724, 97593.0, 97669.0, 10262.127719143957, 10577.947110264708, 10612.575496980344, 10613.416262105658, 10774.730631733955, 43684.0, 44025.0, 44336.77831610821, 44737.32894006527, 44836.551634483236, 55727.721361392934, 55860.0, 56710.0, 56852.71573642271, 58371.70814145902, 15173.089614623157, 15352.0, 15384.230788460756, 15489.690206196039, 15496.225188740293, 17061.573460663087, 17088.145592720564, 17296.913515432847, 17434.302627894744, 17490.650186996445, 13892.444302227797, 13954.0, 14024.158550487004, 14088.36602352876, 14099.718005640036, 16070.919645401698, 16305.836941630907, 16328.510144695678, 16503.257353418885, 16505.33978640841, 15909.443169489012, 16148.67702645964, 16351.0, 16376.590585235464, 16407.507774766775, 11019.338839669645, 11279.661610151708, 11287.04060154896, 11356.432178391213, 11403.144764142888, 12389.680753937726, 12436.626901192978, 12461.940735037624, 12568.622941311774, 12614.810777838156], "value": 8954.715837490525, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 105.0, 107.0, 108.0, 100.0, 111.0, 106.0, 108.0, 108.0], "value": 107.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 122.0, 120.0, 149.0, 119.0, 116.0, 120.0, 124.0, 151.0, 114.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 162.0, 160.0, 164.0, 162.0, 163.0, 163.0, 168.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 76.0, 74.0, 73.0, 77.0, 74.0, 74.0, 73.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 78.0, 78.0, 78.0, 78.0, 79.0, 78.0, 78.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 148.0, 147.0, 147.0, 148.0, 149.0, 150.0, 148.0, 148.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 96.0, 95.0, 96.0, 94.0, 99.0, 99.0, 99.0, 99.0], "value": 97.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 55.0, 55.0, 55.0, 55.0, 53.0, 54.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 45.0, 37.0, 37.0, 38.0, 37.0, 36.0, 37.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 73.0, 82.0, 76.0, 74.0, 72.0, 75.0, 77.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 110.0, 119.0, 117.0, 117.0, 111.0, 111.0, 109.0, 116.0, 111.0], "value": 114.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 175.0, 168.0, 169.0, 189.0, 168.0, 166.0, 166.0, 176.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 63.0, 67.0, 69.0, 64.0, 65.0, 64.0, 69.0, 70.0, 63.0], "value": 66.4, "unit": "score"}]}]} 15:08:19 INFO - Return code: 0 15:08:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:08:19 INFO - # TBPL SUCCESS # 15:08:19 INFO - Running post-action listener: _package_coverage_data 15:08:19 INFO - Running post-action listener: _resource_record_post_action 15:08:19 INFO - [mozharness: 2017-09-16 22:08:19.698502Z] Finished run-tests step (success) 15:08:19 INFO - Running post-run listener: _resource_record_post_run 15:08:19 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 12288; Write bytes: 340750336; Read time: 320; Write time: 171504 15:08:19 INFO - TinderboxPrint: CPU usage
13.1% 15:08:19 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 320 15:08:19 INFO - TinderboxPrint: I/O write bytes / time
340,750,336 / 171,504 15:08:19 INFO - TinderboxPrint: CPU idle
8,231.8 (86.9%) 15:08:19 INFO - TinderboxPrint: CPU user
1,191.2 (12.6%) 15:08:19 INFO - TinderboxPrint: Swap in / out
0 / 0 15:08:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13307904; Read time: 0; Write time: 1224 15:08:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:08:19 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 8192; Write bytes: 327442432; Read time: 308; Write time: 170280 15:08:20 INFO - Running post-run listener: _upload_blobber_files 15:08:20 INFO - Blob upload gear active. 15:08:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:08:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:08:20 INFO - (blobuploader) - INFO - Open directory for files ... 15:08:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:08:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:08:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:21 INFO - (blobuploader) - INFO - Done attempting. 15:08:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:08:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:08:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:22 INFO - (blobuploader) - INFO - Done attempting. 15:08:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:08:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:08:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:29 INFO - (blobuploader) - INFO - Done attempting. 15:08:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:08:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:08:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:30 INFO - (blobuploader) - INFO - Done attempting. 15:08:30 INFO - (blobuploader) - INFO - Iteration through files over. 15:08:30 INFO - Return code: 0 15:08:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:08:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:08:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e5cf1b64cc3304383ee0ad4985f080a3d913d9970b86636d1133a813df71d35ecf206b0e46e12515b0530deb62d8342c6eee76079b471b4772330c0dd26376c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d43fe2ec068b67ab79bf5228b376a6010160fffa6dcf7f55e06eefd23e424f61fca6782b0056d1a24149cf201989feeb3546a980558ad0637786c336429c772d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70e3a0da385d6eaaa771a6cadc8e6b57e1530180441b6f834aa7ab6c8b06686d15e20e238e96e93a4843347df8b601911e9b72267ac36d4ff18b9f6a6caf5c00", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e48e8df58a621c32de270ec66da574ae9e51ad5e5636aed0c2e0dbab8a16336932bd4395cd20be1c57e95e3b3f7c1f22ba0d45686c0437a212bda0ad4a4f213"} 15:08:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:08:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:08:30 INFO - Contents: 15:08:30 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e5cf1b64cc3304383ee0ad4985f080a3d913d9970b86636d1133a813df71d35ecf206b0e46e12515b0530deb62d8342c6eee76079b471b4772330c0dd26376c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d43fe2ec068b67ab79bf5228b376a6010160fffa6dcf7f55e06eefd23e424f61fca6782b0056d1a24149cf201989feeb3546a980558ad0637786c336429c772d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70e3a0da385d6eaaa771a6cadc8e6b57e1530180441b6f834aa7ab6c8b06686d15e20e238e96e93a4843347df8b601911e9b72267ac36d4ff18b9f6a6caf5c00", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e48e8df58a621c32de270ec66da574ae9e51ad5e5636aed0c2e0dbab8a16336932bd4395cd20be1c57e95e3b3f7c1f22ba0d45686c0437a212bda0ad4a4f213"} 15:08:30 INFO - Running post-run listener: copy_logs_to_upload_dir 15:08:30 INFO - Copying logs to upload dir... 15:08:30 INFO - mkdir: /builds/slave/test/build/upload/logs 15:08:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.253320 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-16 15:08:30.427926) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 15:08:30.435527) ========= 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=a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e5cf1b64cc3304383ee0ad4985f080a3d913d9970b86636d1133a813df71d35ecf206b0e46e12515b0530deb62d8342c6eee76079b471b4772330c0dd26376c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d43fe2ec068b67ab79bf5228b376a6010160fffa6dcf7f55e06eefd23e424f61fca6782b0056d1a24149cf201989feeb3546a980558ad0637786c336429c772d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70e3a0da385d6eaaa771a6cadc8e6b57e1530180441b6f834aa7ab6c8b06686d15e20e238e96e93a4843347df8b601911e9b72267ac36d4ff18b9f6a6caf5c00", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e48e8df58a621c32de270ec66da574ae9e51ad5e5636aed0c2e0dbab8a16336932bd4395cd20be1c57e95e3b3f7c1f22ba0d45686c0437a212bda0ad4a4f213"} build_url:https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e5cf1b64cc3304383ee0ad4985f080a3d913d9970b86636d1133a813df71d35ecf206b0e46e12515b0530deb62d8342c6eee76079b471b4772330c0dd26376c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d43fe2ec068b67ab79bf5228b376a6010160fffa6dcf7f55e06eefd23e424f61fca6782b0056d1a24149cf201989feeb3546a980558ad0637786c336429c772d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70e3a0da385d6eaaa771a6cadc8e6b57e1530180441b6f834aa7ab6c8b06686d15e20e238e96e93a4843347df8b601911e9b72267ac36d4ff18b9f6a6caf5c00", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e48e8df58a621c32de270ec66da574ae9e51ad5e5636aed0c2e0dbab8a16336932bd4395cd20be1c57e95e3b3f7c1f22ba0d45686c0437a212bda0ad4a4f213"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 15:08:30.466399) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:08:30.466709) ========= 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=a0d2d2de893abaa8702a9954000001a7-1505598470.2190-1404915563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:08:30.547040) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 15:08:30.550360) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 15:08:30.550678) ========= ========= Total master_lag: 0.18 =========