builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-028 starttime: 1505957315.84 results: success (0) revision: 61340c7debf6dccec3b863d1bc00426feac42fe7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:35.836013) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:35.836455) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:35.836762) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:35.857582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:35.857955) ========= 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=836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 18:28:35-- 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% 227M=0s 2017-09-20 18:28:35 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:36.018706) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:36.019042) ========= 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=836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018054 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:36.068546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:36.068889) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 61340c7debf6dccec3b863d1bc00426feac42fe7 --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 61340c7debf6dccec3b863d1bc00426feac42fe7 --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=836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 18:28:36,077 truncating revision to first 12 chars 2017-09-20 18:28:36,077 Setting DEBUG logging. 2017-09-20 18:28:36,077 attempt 1/10 2017-09-20 18:28:36,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/61340c7debf6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 18:28:36,463 unpacking tar archive at: mozilla-central-61340c7debf6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.691198 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:36.776356) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:36.779698) ========= script_repo_revision: 61340c7debf6dccec3b863d1bc00426feac42fe7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:36.780141) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:36.780420) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 18:28:36.794452) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-20 18:28:36.794886) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:28:36 INFO - MultiFileLogger online at 20170920 18:28:36 in /builds/slave/test 18:28:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:28:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:28:36 INFO - {'append_to_log': False, 18:28:36 INFO - 'base_work_dir': '/builds/slave/test', 18:28:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:28:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:28:36 INFO - 'branch': 'Firefox-Non-PGO', 18:28:36 INFO - 'buildbot_json_path': 'buildprops.json', 18:28:36 INFO - 'code_coverage': False, 18:28:36 INFO - 'config_files': ('talos/linux_config.py',), 18:28:36 INFO - 'default_actions': ('clobber', 18:28:36 INFO - 'read-buildbot-config', 18:28:36 INFO - 'download-and-extract', 18:28:36 INFO - 'populate-webroot', 18:28:36 INFO - 'create-virtualenv', 18:28:36 INFO - 'install', 18:28:36 INFO - 'setup-mitmproxy', 18:28:36 INFO - 'run-tests'), 18:28:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:28:36 INFO - 'disable_ccov_upload': False, 18:28:36 INFO - 'disable_stylo': False, 18:28:36 INFO - 'download_minidump_stackwalk': True, 18:28:36 INFO - 'download_symbols': 'ondemand', 18:28:36 INFO - 'enable_stylo': False, 18:28:36 INFO - 'enable_webrender': False, 18:28:36 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:28:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:28:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:28:36 INFO - 'gecko_profile': False, 18:28:36 INFO - 'gecko_profile_interval': 0, 18:28:36 INFO - 'installer_path': 'installer.exe', 18:28:36 INFO - 'log_level': 'info', 18:28:36 INFO - 'log_name': 'talos', 18:28:36 INFO - 'log_to_console': True, 18:28:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:28:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:28:36 INFO - 'opt_config_files': (), 18:28:36 INFO - 'pip_index': False, 18:28:36 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 18:28:36 INFO - 'system_bits': '32', 18:28:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:28:36 INFO - 'title': 'talos-linux64-ix-028', 18:28:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:28:36 INFO - 'use_talos_json': True, 18:28:36 INFO - 'verify': 'False', 18:28:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:28:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:28:36 INFO - 'work_dir': 'build'} 18:28:36 INFO - [mozharness: 2017-09-21 01:28:36.947779Z] Running clobber step. 18:28:36 INFO - Running pre-action listener: _resource_record_pre_action 18:28:36 INFO - Running main action method: clobber 18:28:36 INFO - rmtree: /builds/slave/test/build 18:28:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:28:38 INFO - Running post-action listener: _resource_record_post_action 18:28:38 INFO - [mozharness: 2017-09-21 01:28:38.087033Z] Finished clobber step (success) 18:28:38 INFO - [mozharness: 2017-09-21 01:28:38.087131Z] Running read-buildbot-config step. 18:28:38 INFO - Running pre-action listener: _resource_record_pre_action 18:28:38 INFO - Running main action method: read_buildbot_config 18:28:38 INFO - Using buildbot properties: 18:28:38 INFO - { 18:28:38 INFO - "project": "", 18:28:38 INFO - "product": "firefox", 18:28:38 INFO - "who": "kwierso@gmail.com", 18:28:38 INFO - "installer_path": "public/build/target.tar.bz2", 18:28:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 18:28:38 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:28:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 18:28:38 INFO - "stage_platform": "linux64", 18:28:38 INFO - "basedir": "/builds/slave/test", 18:28:38 INFO - "buildnumber": 51, 18:28:38 INFO - "platform": "ubuntu64_hw", 18:28:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:28:38 INFO - "slavebuilddir": "test", 18:28:38 INFO - "taskId": "Qd3vaxfwQCqX-8TYKbCCSA", 18:28:38 INFO - "branch": "mozilla-central", 18:28:38 INFO - "script_repo_revision": "production", 18:28:38 INFO - "revision": "61340c7debf6dccec3b863d1bc00426feac42fe7", 18:28:38 INFO - "slavename": "talos-linux64-ix-028", 18:28:38 INFO - "repo_path": "mozilla-central" 18:28:38 INFO - } 18:28:38 INFO - Finding installer, test and symbols from parent task. 18:28:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qd3vaxfwQCqX-8TYKbCCSA'}, attempt #1 18:28:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qd3vaxfwQCqX-8TYKbCCSA'}, attempt #1 18:28:39 INFO - Task dependencies: YpEoj-OJRvCSQ0IhvHvM7g 18:28:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g'}, attempt #1 18:28:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.tar.bz2 18:28:39 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.test_packages.json 18:28:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.crashreporter-symbols.zip 18:28:39 INFO - Running post-action listener: _resource_record_post_action 18:28:39 INFO - [mozharness: 2017-09-21 01:28:39.490141Z] Finished read-buildbot-config step (success) 18:28:39 INFO - [mozharness: 2017-09-21 01:28:39.490359Z] Running download-and-extract step. 18:28:39 INFO - Running pre-action listener: _resource_record_pre_action 18:28:39 INFO - Running main action method: download_and_extract 18:28:39 INFO - mkdir: /builds/slave/test/build/tests 18:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:39 INFO - trying https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.test_packages.json 18:28:39 INFO - Downloading https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:28:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:28:40 INFO - Downloaded 989 bytes. 18:28:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:28:40 INFO - Using the following test package requirements: 18:28:40 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:28:40 INFO - u'common': [u'target.common.tests.zip'], 18:28:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:28:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:28:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:28:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:28:40 INFO - u'mozbase': [u'target.common.tests.zip'], 18:28:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:28:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:28:40 INFO - u'web-platform': [u'target.common.tests.zip', 18:28:40 INFO - u'target.web-platform.tests.tar.gz'], 18:28:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:28:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 18:28:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.common.tests.zip 18:28:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:28:40 INFO - Fetch https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.common.tests.zip into memory 18:28:41 INFO - Content-Length response header: 54733806 18:28:41 INFO - Bytes received: 54733806 18:28:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.talos.tests.zip 18:28:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:28:51 INFO - Fetch https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.talos.tests.zip into memory 18:28:52 INFO - Content-Length response header: 14512509 18:28:52 INFO - Bytes received: 14512509 18:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:52 INFO - trying https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.tar.bz2 18:28:52 INFO - Downloading https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:28:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:28:54 INFO - Downloaded 61663650 bytes. 18:28:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.tar.bz2 18:28:54 INFO - mkdir: /builds/slave/test/properties 18:28:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:28:54 INFO - Writing to file /builds/slave/test/properties/build_url 18:28:54 INFO - Contents: 18:28:54 INFO - build_url:https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.tar.bz2 18:28:54 INFO - Running post-action listener: _resource_record_post_action 18:28:54 INFO - Running post-action listener: find_tests_for_verification 18:28:54 INFO - Running post-action listener: set_extra_try_arguments 18:28:54 INFO - [mozharness: 2017-09-21 01:28:54.059305Z] Finished download-and-extract step (success) 18:28:54 INFO - [mozharness: 2017-09-21 01:28:54.059448Z] Running populate-webroot step. 18:28:54 INFO - Running pre-action listener: _resource_record_pre_action 18:28:54 INFO - Running main action method: populate_webroot 18:28:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:28:54 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:28:54 INFO - 'tests': ['tresize', 18:28:54 INFO - 'tcanvasmark']}, 18:28:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:28:54 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:28:54 INFO - 'tests': ['dromaeo_css', 18:28:54 INFO - 'kraken']}, 18:28:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:28:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:28:54 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:28:54 INFO - 'talos_options': ['--disable-stylo'], 18:28:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:28:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:28:54 INFO - 'tests': ['damp', 'tps']}, 18:28:54 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:28:54 INFO - 'talos_options': ['--disable-stylo'], 18:28:54 INFO - 'tests': ['damp', 'tps']}, 18:28:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:28:54 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:28:54 INFO - 'tests': ['dromaeo_dom']}, 18:28:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:28:54 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:28:54 INFO - 'tests': ['basic_compositor_video', 18:28:54 INFO - 'glvideo']}, 18:28:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:28:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:28:54 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:28:54 INFO - 'talos_options': ['--disable-stylo'], 18:28:54 INFO - 'tests': ['ts_paint_webext', 18:28:54 INFO - 'tp5o_webext']}, 18:28:54 INFO - 'other-e10s': {'tests': ['a11yr', 18:28:54 INFO - 'ts_paint', 18:28:54 INFO - 'tpaint', 18:28:54 INFO - 'sessionrestore', 18:28:54 INFO - 'sessionrestore_many_windows', 18:28:54 INFO - 'sessionrestore_no_auto_restore', 18:28:54 INFO - 'tabpaint']}, 18:28:54 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:28:54 INFO - 'tests': ['a11yr', 18:28:54 INFO - 'ts_paint', 18:28:54 INFO - 'tpaint', 18:28:54 INFO - 'sessionrestore', 18:28:54 INFO - 'sessionrestore_many_windows', 18:28:54 INFO - 'sessionrestore_no_auto_restore', 18:28:54 INFO - 'tabpaint']}, 18:28:54 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 18:28:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 18:28:54 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:28:54 INFO - 'tests': ['perf_reftest_singletons']}, 18:28:54 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:28:54 INFO - 'tests': ['bloom_basic']}, 18:28:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:28:54 INFO - 'tsvgr_opacity', 18:28:54 INFO - 'tart', 18:28:54 INFO - 'tscrollx', 18:28:54 INFO - 'tsvg_static']}, 18:28:54 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:28:54 INFO - 'tests': ['tsvgx', 18:28:54 INFO - 'tsvgr_opacity', 18:28:54 INFO - 'tart', 18:28:54 INFO - 'tscrollx', 18:28:54 INFO - 'tsvg_static']}, 18:28:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:28:54 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:28:54 INFO - 'talos_options': ['--disable-stylo'], 18:28:54 INFO - 'tests': ['tp5o']}, 18:28:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:28:54 INFO - 'talos_options': ['--mitmproxy', 18:28:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:28:54 INFO - '--firstNonBlankPaint'], 18:28:54 INFO - 'tests': ['tp6_google', 18:28:54 INFO - 'tp6_youtube', 18:28:54 INFO - 'tp6_amazon', 18:28:54 INFO - 'tp6_facebook']}, 18:28:54 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:28:54 INFO - 'talos_options': ['--disable-stylo', 18:28:54 INFO - '--mitmproxy', 18:28:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:28:54 INFO - '--firstNonBlankPaint'], 18:28:54 INFO - 'tests': ['tp6_google', 18:28:54 INFO - 'tp6_youtube', 18:28:54 INFO - 'tp6_amazon', 18:28:54 INFO - 'tp6_facebook']}, 18:28:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:28:54 INFO - 'talos_options': ['--stylo-threads=1', 18:28:54 INFO - '--mitmproxy', 18:28:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:28:54 INFO - '--firstNonBlankPaint'], 18:28:54 INFO - 'tests': ['tp6_google', 18:28:54 INFO - 'tp6_youtube', 18:28:54 INFO - 'tp6_amazon', 18:28:54 INFO - 'tp6_facebook']}, 18:28:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:28:54 INFO - 'talos_options': ['--xperf_path', 18:28:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:28:54 INFO - 'tests': ['tp5n']}, 18:28:54 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:28:54 INFO - 'talos_options': ['--disable-stylo', 18:28:54 INFO - '--xperf_path', 18:28:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:28:54 INFO - 'tests': ['tp5n']}}} 18:28:54 INFO - Running post-action listener: _resource_record_post_action 18:28:54 INFO - [mozharness: 2017-09-21 01:28:54.076199Z] Finished populate-webroot step (success) 18:28:54 INFO - [mozharness: 2017-09-21 01:28:54.076288Z] Running create-virtualenv step. 18:28:54 INFO - Running pre-action listener: _resource_record_pre_action 18:28:54 INFO - Running main action method: create_virtualenv 18:28:54 INFO - Creating virtualenv /builds/slave/test/build/venv 18:28:54 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:28:54 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:28:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:28:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:28:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:28:54 INFO - Installing distribute.............................................................................................................................................................................................done. 18:28:54 INFO - Installing pip...............done. 18:28:54 INFO - Return code: 0 18:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:28:55 INFO - Reading from file tmpfile_stdout 18:28:55 INFO - Output received: 18:28:55 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:28:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:28: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')]} 18:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28: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')]} 18:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84090>, '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 0xe84d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7ef90>, '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': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', '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 18:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:28:55 INFO - Using env: {'DISPLAY': ':0', 18:28:55 INFO - 'HOME': '/home/cltbld', 18:28:55 INFO - 'LANG': 'en_US.UTF-8', 18:28:55 INFO - 'LANGUAGE': 'en_US:en', 18:28:55 INFO - 'LOGNAME': 'cltbld', 18:28:55 INFO - 'MAIL': '/var/mail/cltbld', 18:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:55 INFO - 'MOZ_NO_REMOTE': '1', 18:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:55 INFO - 'NO_EM_RESTART': '1', 18:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:55 INFO - 'PWD': '/builds/slave/test', 18:28:55 INFO - 'SHELL': '/bin/bash', 18:28:55 INFO - 'SHLVL': '1', 18:28:55 INFO - 'TERM': 'linux', 18:28:55 INFO - 'TMOUT': '86400', 18:28:55 INFO - 'USER': 'cltbld', 18:28:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', 18:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:55 INFO - '_': '/tools/buildbot/bin/python'} 18:28:56 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:28:56 INFO - Downloading/unpacking pip>=1.5 18:28:56 INFO - Running setup.py egg_info for package pip 18:28:56 INFO - warning: no files found matching 'pip/cacert.pem' 18:28:56 INFO - warning: no files found matching '*.html' under directory 'docs' 18:28:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:28:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:28:56 INFO - Installing collected packages: pip 18:28:56 INFO - Found existing installation: pip 1.1 18:28:56 INFO - Uninstalling pip: 18:28:56 INFO - Successfully uninstalled pip 18:28:56 INFO - Running setup.py install for pip 18:28:56 INFO - warning: no files found matching 'pip/cacert.pem' 18:28:56 INFO - warning: no files found matching '*.html' under directory 'docs' 18:28:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:28:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:28:56 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:28:56 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:28:56 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:28:56 INFO - Successfully installed pip 18:28:56 INFO - Cleaning up... 18:28:56 INFO - Return code: 0 18:28:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84090>, '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 0xe84d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7ef90>, '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': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', '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 18:28:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:28:56 INFO - Using env: {'DISPLAY': ':0', 18:28:56 INFO - 'HOME': '/home/cltbld', 18:28:56 INFO - 'LANG': 'en_US.UTF-8', 18:28:56 INFO - 'LANGUAGE': 'en_US:en', 18:28:56 INFO - 'LOGNAME': 'cltbld', 18:28:56 INFO - 'MAIL': '/var/mail/cltbld', 18:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:56 INFO - 'MOZ_NO_REMOTE': '1', 18:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:56 INFO - 'NO_EM_RESTART': '1', 18:28:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:56 INFO - 'PWD': '/builds/slave/test', 18:28:56 INFO - 'SHELL': '/bin/bash', 18:28:56 INFO - 'SHLVL': '1', 18:28:56 INFO - 'TERM': 'linux', 18:28:56 INFO - 'TMOUT': '86400', 18:28:56 INFO - 'USER': 'cltbld', 18:28:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', 18:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:56 INFO - '_': '/tools/buildbot/bin/python'} 18:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:56 INFO - Downloading/unpacking psutil>=3.1.1 18:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:28:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:28:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:28:57 INFO - Installing collected packages: psutil 18:28:57 INFO - Running setup.py install for psutil 18:28:57 INFO - building 'psutil._psutil_linux' extension 18:28:57 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 18:28:57 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 18:28:58 INFO - building 'psutil._psutil_posix' extension 18:28:58 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 18:28:58 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 18:28:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:28:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:28:58 INFO - Successfully installed psutil 18:28:58 INFO - Cleaning up... 18:28:58 INFO - Return code: 0 18:28:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84090>, '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 0xe84d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7ef90>, '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': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', '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 18:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:28:58 INFO - Using env: {'DISPLAY': ':0', 18:28:58 INFO - 'HOME': '/home/cltbld', 18:28:58 INFO - 'LANG': 'en_US.UTF-8', 18:28:58 INFO - 'LANGUAGE': 'en_US:en', 18:28:58 INFO - 'LOGNAME': 'cltbld', 18:28:58 INFO - 'MAIL': '/var/mail/cltbld', 18:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:58 INFO - 'MOZ_NO_REMOTE': '1', 18:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:58 INFO - 'NO_EM_RESTART': '1', 18:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:58 INFO - 'PWD': '/builds/slave/test', 18:28:58 INFO - 'SHELL': '/bin/bash', 18:28:58 INFO - 'SHLVL': '1', 18:28:58 INFO - 'TERM': 'linux', 18:28:58 INFO - 'TMOUT': '86400', 18:28:58 INFO - 'USER': 'cltbld', 18:28:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', 18:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:58 INFO - '_': '/tools/buildbot/bin/python'} 18:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:28:59 INFO - Installing collected packages: mozsystemmonitor 18:28:59 INFO - Running setup.py install for mozsystemmonitor 18:29:00 INFO - Successfully installed mozsystemmonitor 18:29:00 INFO - Cleaning up... 18:29:00 INFO - Return code: 0 18:29:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:29:00 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')]} 18:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:00 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')]} 18:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:00 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 0xb141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84090>, '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 0xe84d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7ef90>, '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': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', '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 18:29:00 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 18:29:00 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 18:29:00 INFO - Using env: {'DISPLAY': ':0', 18:29:00 INFO - 'HOME': '/home/cltbld', 18:29:00 INFO - 'LANG': 'en_US.UTF-8', 18:29:00 INFO - 'LANGUAGE': 'en_US:en', 18:29:00 INFO - 'LOGNAME': 'cltbld', 18:29:00 INFO - 'MAIL': '/var/mail/cltbld', 18:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:00 INFO - 'MOZ_NO_REMOTE': '1', 18:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:00 INFO - 'NO_EM_RESTART': '1', 18:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:00 INFO - 'PWD': '/builds/slave/test', 18:29:00 INFO - 'SHELL': '/bin/bash', 18:29:00 INFO - 'SHLVL': '1', 18:29:00 INFO - 'TERM': 'linux', 18:29:00 INFO - 'TMOUT': '86400', 18:29:00 INFO - 'USER': 'cltbld', 18:29:00 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', 18:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:00 INFO - '_': '/tools/buildbot/bin/python'} 18:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:01 INFO - Downloading/unpacking jsonschema==2.5.1 18:29:01 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 18:29:01 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 18:29:01 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 18:29:01 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 18:29:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:29:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:29:02 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 18:29:02 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 18:29:02 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 18:29:02 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 18:29:02 INFO - Downloading functools32-3.2.3-2.tar.gz 18:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:29:02 INFO - warning: no files found matching '*.txt' 18:29:02 INFO - no previously-included directories found matching 'build' 18:29:02 INFO - no previously-included directories found matching 'dist' 18:29:02 INFO - no previously-included directories found matching '.git*' 18:29:02 INFO - Installing collected packages: jsonschema, functools32 18:29:02 INFO - Running setup.py install for functools32 18:29:02 INFO - warning: no files found matching '*.txt' 18:29:02 INFO - no previously-included directories found matching 'build' 18:29:02 INFO - no previously-included directories found matching 'dist' 18:29:02 INFO - no previously-included directories found matching '.git*' 18:29:03 INFO - Successfully installed jsonschema functools32 18:29:03 INFO - Cleaning up... 18:29:03 INFO - Return code: 0 18:29:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:29:03 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')]} 18:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:03 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')]} 18:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:03 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 0xb141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84090>, '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 0xe84d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7ef90>, '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': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', '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 18:29:03 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 18:29:03 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 18:29:03 INFO - Using env: {'DISPLAY': ':0', 18:29:03 INFO - 'HOME': '/home/cltbld', 18:29:03 INFO - 'LANG': 'en_US.UTF-8', 18:29:03 INFO - 'LANGUAGE': 'en_US:en', 18:29:03 INFO - 'LOGNAME': 'cltbld', 18:29:03 INFO - 'MAIL': '/var/mail/cltbld', 18:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:03 INFO - 'MOZ_NO_REMOTE': '1', 18:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:03 INFO - 'NO_EM_RESTART': '1', 18:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:03 INFO - 'PWD': '/builds/slave/test', 18:29:03 INFO - 'SHELL': '/bin/bash', 18:29:03 INFO - 'SHLVL': '1', 18:29:03 INFO - 'TERM': 'linux', 18:29:03 INFO - 'TMOUT': '86400', 18:29:03 INFO - 'USER': 'cltbld', 18:29:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', 18:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:03 INFO - '_': '/tools/buildbot/bin/python'} 18:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:29:03 INFO - Cleaning up... 18:29:03 INFO - Return code: 0 18:29:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:29:03 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')]} 18:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:03 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')]} 18:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:03 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 0xb141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84090>, '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 0xe84d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7ef90>, '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': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', '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 18:29:03 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 18:29:03 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 18:29:03 INFO - Using env: {'DISPLAY': ':0', 18:29:03 INFO - 'HOME': '/home/cltbld', 18:29:03 INFO - 'LANG': 'en_US.UTF-8', 18:29:03 INFO - 'LANGUAGE': 'en_US:en', 18:29:03 INFO - 'LOGNAME': 'cltbld', 18:29:03 INFO - 'MAIL': '/var/mail/cltbld', 18:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:03 INFO - 'MOZ_NO_REMOTE': '1', 18:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:03 INFO - 'NO_EM_RESTART': '1', 18:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:03 INFO - 'PWD': '/builds/slave/test', 18:29:03 INFO - 'SHELL': '/bin/bash', 18:29:03 INFO - 'SHLVL': '1', 18:29:03 INFO - 'TERM': 'linux', 18:29:03 INFO - 'TMOUT': '86400', 18:29:03 INFO - 'USER': 'cltbld', 18:29:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', 18:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:03 INFO - '_': '/tools/buildbot/bin/python'} 18:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:05 INFO - Downloading/unpacking blobuploader==1.2.4 18:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:06 INFO - Downloading blobuploader-1.2.4.tar.gz 18:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:29:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:29:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:29:07 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 18:29:07 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 18:29:07 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 18:29:07 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 18:29:07 INFO - Downloading docopt-0.6.1.tar.gz 18:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:29:07 INFO - Installing collected packages: blobuploader, requests, docopt 18:29:07 INFO - Running setup.py install for blobuploader 18:29:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:29:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:29:07 INFO - Running setup.py install for requests 18:29:07 INFO - Running setup.py install for docopt 18:29:07 INFO - Successfully installed blobuploader requests docopt 18:29:07 INFO - Cleaning up... 18:29:07 INFO - Return code: 0 18:29:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:07 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 0xb141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84090>, '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 0xe84d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7ef90>, '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': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', '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 18:29:07 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 18:29:07 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 18:29:07 INFO - Using env: {'DISPLAY': ':0', 18:29:07 INFO - 'HOME': '/home/cltbld', 18:29:07 INFO - 'LANG': 'en_US.UTF-8', 18:29:07 INFO - 'LANGUAGE': 'en_US:en', 18:29:07 INFO - 'LOGNAME': 'cltbld', 18:29:07 INFO - 'MAIL': '/var/mail/cltbld', 18:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:07 INFO - 'MOZ_NO_REMOTE': '1', 18:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:07 INFO - 'NO_EM_RESTART': '1', 18:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:07 INFO - 'PWD': '/builds/slave/test', 18:29:07 INFO - 'SHELL': '/bin/bash', 18:29:07 INFO - 'SHLVL': '1', 18:29:07 INFO - 'TERM': 'linux', 18:29:07 INFO - 'TMOUT': '86400', 18:29:07 INFO - 'USER': 'cltbld', 18:29:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', 18:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:07 INFO - '_': '/tools/buildbot/bin/python'} 18:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:29:08 INFO - Running setup.py (path:/tmp/pip-APvyYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:29:08 INFO - Running setup.py (path:/tmp/pip-PcE2Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:29:08 INFO - Running setup.py (path:/tmp/pip-TlG5RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:29:08 INFO - Running setup.py (path:/tmp/pip-sHCOtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:29:08 INFO - Running setup.py (path:/tmp/pip-Qgf2Nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:29:08 INFO - Running setup.py (path:/tmp/pip-FGnT8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:29:08 INFO - Running setup.py (path:/tmp/pip-7yRavI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:29:08 INFO - Running setup.py (path:/tmp/pip-EqlukL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:29:08 INFO - Running setup.py (path:/tmp/pip-hFtMdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:29:08 INFO - Running setup.py (path:/tmp/pip-AkZe5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:29:08 INFO - Running setup.py (path:/tmp/pip-XWawxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:29:08 INFO - Running setup.py (path:/tmp/pip-gQErdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:29:09 INFO - Running setup.py (path:/tmp/pip-zrrwC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:29:09 INFO - Running setup.py (path:/tmp/pip-RDxBCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:09 INFO - Running setup.py (path:/tmp/pip-TBHcHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:29:09 INFO - Running setup.py (path:/tmp/pip-olTkC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:29:09 INFO - Running setup.py (path:/tmp/pip-tvw0eB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:29:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:29:09 INFO - Running setup.py install for manifestparser 18:29:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:29:09 INFO - Running setup.py install for mozcrash 18:29:09 INFO - Running setup.py install for mozdebug 18:29:09 INFO - Running setup.py install for mozdevice 18:29:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:29:09 INFO - Running setup.py install for mozfile 18:29:09 INFO - Running setup.py install for mozhttpd 18:29:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:29:09 INFO - Running setup.py install for mozinfo 18:29:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:29:10 INFO - Running setup.py install for mozInstall 18:29:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:29:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:29:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:29:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:29:10 INFO - Running setup.py install for mozleak 18:29:10 INFO - Running setup.py install for mozlog 18:29:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:29:10 INFO - Running setup.py install for moznetwork 18:29:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:29:10 INFO - Running setup.py install for mozprocess 18:29:10 INFO - Running setup.py install for mozprofile 18:29:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:29:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:29:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:29:10 INFO - Running setup.py install for mozrunner 18:29:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:29:10 INFO - Running setup.py install for mozscreenshot 18:29:10 INFO - Running setup.py install for moztest 18:29:11 INFO - Running setup.py install for mozversion 18:29:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:29:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:29:11 INFO - Cleaning up... 18:29:11 INFO - Return code: 0 18:29:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:29: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')]} 18:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29: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')]} 18:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:11 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 0xb141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84090>, '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 0xe84d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7ef90>, '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': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', '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 18:29:11 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 18:29:11 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 18:29:11 INFO - Using env: {'DISPLAY': ':0', 18:29:11 INFO - 'HOME': '/home/cltbld', 18:29:11 INFO - 'LANG': 'en_US.UTF-8', 18:29:11 INFO - 'LANGUAGE': 'en_US:en', 18:29:11 INFO - 'LOGNAME': 'cltbld', 18:29:11 INFO - 'MAIL': '/var/mail/cltbld', 18:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:11 INFO - 'MOZ_NO_REMOTE': '1', 18:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:11 INFO - 'NO_EM_RESTART': '1', 18:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:11 INFO - 'PWD': '/builds/slave/test', 18:29:11 INFO - 'SHELL': '/bin/bash', 18:29:11 INFO - 'SHLVL': '1', 18:29:11 INFO - 'TERM': 'linux', 18:29:11 INFO - 'TMOUT': '86400', 18:29:11 INFO - 'USER': 'cltbld', 18:29:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', 18:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:11 INFO - '_': '/tools/buildbot/bin/python'} 18:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:29:11 INFO - Running setup.py (path:/tmp/pip-YE9ERZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:29:11 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)) 18:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:29:11 INFO - Running setup.py (path:/tmp/pip-9oUHXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:29:11 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)) 18:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:29:11 INFO - Running setup.py (path:/tmp/pip-gfFulk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:29:11 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)) 18:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:29:11 INFO - Running setup.py (path:/tmp/pip-iioPxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:29:11 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)) 18:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:29:11 INFO - Running setup.py (path:/tmp/pip-_Irq5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:29:11 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)) 18:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:29:11 INFO - Running setup.py (path:/tmp/pip-Ma8NUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:29:11 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)) 18:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:29:11 INFO - Running setup.py (path:/tmp/pip-hVDzyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:29:11 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)) 18:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:29:11 INFO - Running setup.py (path:/tmp/pip-zrLpju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:29:11 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)) 18:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:29:11 INFO - Running setup.py (path:/tmp/pip-ZweYEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:29:11 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)) 18:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:29:11 INFO - Running setup.py (path:/tmp/pip-S5GmUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:29:12 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)) 18:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:29:12 INFO - Running setup.py (path:/tmp/pip-2JSZlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:29:12 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)) 18:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:29:12 INFO - Running setup.py (path:/tmp/pip-23UDgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:29:12 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)) 18:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:29:12 INFO - Running setup.py (path:/tmp/pip-DiOQXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:29:12 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)) 18:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:29:12 INFO - Running setup.py (path:/tmp/pip-4Mw4aK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:29:12 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)) 18:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:12 INFO - Running setup.py (path:/tmp/pip-CSlUt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:12 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)) 18:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:29:12 INFO - Running setup.py (path:/tmp/pip-JOtcrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:29:12 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)) 18:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:29:12 INFO - Running setup.py (path:/tmp/pip-AvNczK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:29:12 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)) 18:29:12 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)) 18:29:12 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)) 18:29:12 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)) 18:29:12 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)) 18:29:12 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)) 18:29:12 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)) 18:29:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:29:12 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 18:29:12 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 18:29:12 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 18:29:12 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 18:29:13 INFO - Downloading blessings-1.6.tar.gz 18:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:29:13 INFO - Installing collected packages: blessings 18:29:13 INFO - Running setup.py install for blessings 18:29:13 INFO - Successfully installed blessings 18:29:13 INFO - Cleaning up... 18:29:13 INFO - Return code: 0 18:29:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:29:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:29:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:29:14 INFO - Reading from file tmpfile_stdout 18:29:14 INFO - Current package versions: 18:29:14 INFO - argparse == 1.2.1 18:29:14 INFO - blessings == 1.6 18:29:14 INFO - blobuploader == 1.2.4 18:29:14 INFO - docopt == 0.6.1 18:29:14 INFO - functools32 == 3.2.3-2 18:29:14 INFO - jsonschema == 2.5.1 18:29:14 INFO - manifestparser == 1.1 18:29:14 INFO - mozInstall == 1.13 18:29:14 INFO - mozcrash == 1.0 18:29:14 INFO - mozdebug == 0.1 18:29:14 INFO - mozdevice == 0.51 18:29:14 INFO - mozfile == 1.2 18:29:14 INFO - mozhttpd == 0.7 18:29:14 INFO - mozinfo == 0.10 18:29:14 INFO - mozleak == 0.1 18:29:14 INFO - mozlog == 3.5 18:29:14 INFO - moznetwork == 0.27 18:29:14 INFO - mozprocess == 0.25 18:29:14 INFO - mozprofile == 0.28 18:29:14 INFO - mozrunner == 6.13 18:29:14 INFO - mozscreenshot == 0.1 18:29:14 INFO - mozsystemmonitor == 0.3 18:29:14 INFO - moztest == 0.8 18:29:14 INFO - mozversion == 1.4 18:29:14 INFO - psutil == 3.1.1 18:29:14 INFO - requests == 1.2.3 18:29:14 INFO - wsgiref == 0.1.2 18:29:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:29:14 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')]} 18:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:14 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')]} 18:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:14 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 0xb141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84090>, '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 0xe84d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7ef90>, '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': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', '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 18:29:14 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 18:29:14 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 18:29:14 INFO - Using env: {'DISPLAY': ':0', 18:29:14 INFO - 'HOME': '/home/cltbld', 18:29:14 INFO - 'LANG': 'en_US.UTF-8', 18:29:14 INFO - 'LANGUAGE': 'en_US:en', 18:29:14 INFO - 'LOGNAME': 'cltbld', 18:29:14 INFO - 'MAIL': '/var/mail/cltbld', 18:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:14 INFO - 'MOZ_NO_REMOTE': '1', 18:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:14 INFO - 'NO_EM_RESTART': '1', 18:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:14 INFO - 'PWD': '/builds/slave/test', 18:29:14 INFO - 'SHELL': '/bin/bash', 18:29:14 INFO - 'SHLVL': '1', 18:29:14 INFO - 'TERM': 'linux', 18:29:14 INFO - 'TMOUT': '86400', 18:29:14 INFO - 'USER': 'cltbld', 18:29:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', 18:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:14 INFO - '_': '/tools/buildbot/bin/python'} 18:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:14 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)) 18:29:14 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)) 18:29:14 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)) 18:29:14 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)) 18:29:14 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)) 18:29:14 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)) 18:29:14 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)) 18:29:14 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)) 18:29:14 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)) 18:29:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:29:14 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 18:29:14 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 18:29:14 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 18:29:14 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 18:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:29:15 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)) 18:29:15 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)) 18:29:15 INFO - Installing collected packages: simplejson 18:29:15 INFO - Running setup.py install for simplejson 18:29:15 INFO - building 'simplejson._speedups' extension 18:29:15 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 18:29:16 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 18:29:16 INFO - Successfully installed simplejson 18:29:16 INFO - Cleaning up... 18:29:16 INFO - Return code: 0 18:29:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:16 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 0xb141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84090>, '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 0xe84d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7ef90>, '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': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', '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 18:29:16 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 18:29:16 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 18:29:16 INFO - Using env: {'DISPLAY': ':0', 18:29:16 INFO - 'HOME': '/home/cltbld', 18:29:16 INFO - 'LANG': 'en_US.UTF-8', 18:29:16 INFO - 'LANGUAGE': 'en_US:en', 18:29:16 INFO - 'LOGNAME': 'cltbld', 18:29:16 INFO - 'MAIL': '/var/mail/cltbld', 18:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:16 INFO - 'MOZ_NO_REMOTE': '1', 18:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:16 INFO - 'NO_EM_RESTART': '1', 18:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:16 INFO - 'PWD': '/builds/slave/test', 18:29:16 INFO - 'SHELL': '/bin/bash', 18:29:16 INFO - 'SHLVL': '1', 18:29:16 INFO - 'TERM': 'linux', 18:29:16 INFO - 'TMOUT': '86400', 18:29:16 INFO - 'USER': 'cltbld', 18:29:16 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', 18:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:16 INFO - '_': '/tools/buildbot/bin/python'} 18:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:29:16 INFO - Cleaning up... 18:29:16 INFO - Return code: 0 18:29:16 INFO - Running post-action listener: _resource_record_post_action 18:29:16 INFO - Running post-action listener: _start_resource_monitoring 18:29:16 INFO - Starting resource monitoring. 18:29:16 INFO - [mozharness: 2017-09-21 01:29:16.963103Z] Finished create-virtualenv step (success) 18:29:16 INFO - [mozharness: 2017-09-21 01:29:16.963614Z] Running install step. 18:29:16 INFO - Running pre-action listener: _resource_record_pre_action 18:29:16 INFO - Running main action method: install 18:29:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:29:17 INFO - Reading from file tmpfile_stdout 18:29:17 INFO - Detecting whether we're running mozinstall >=1.0... 18:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:29:17 INFO - Reading from file tmpfile_stdout 18:29:17 INFO - Output received: 18:29:17 INFO - Usage: mozinstall [options] installer 18:29:17 INFO - Options: 18:29:17 INFO - -h, --help show this help message and exit 18:29:17 INFO - -d DEST, --destination=DEST 18:29:17 INFO - Directory to install application into. [default: 18:29:17 INFO - "/builds/slave/test"] 18:29:17 INFO - --app=APP Application being installed. [default: firefox] 18:29:17 INFO - mkdir: /builds/slave/test/build/application 18:29:17 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'] 18:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:29:35 INFO - Reading from file tmpfile_stdout 18:29:35 INFO - Output received: 18:29:35 INFO - /builds/slave/test/build/application/firefox/firefox 18:29:35 INFO - Running post-action listener: _resource_record_post_action 18:29:35 INFO - [mozharness: 2017-09-21 01:29:35.104285Z] Finished install step (success) 18:29:35 INFO - [mozharness: 2017-09-21 01:29:35.104604Z] Running setup-mitmproxy step. 18:29:35 INFO - Running pre-action listener: _resource_record_pre_action 18:29:35 INFO - Running main action method: setup_mitmproxy 18:29:35 INFO - Skipping: mitmproxy is not required 18:29:35 INFO - Running post-action listener: _resource_record_post_action 18:29:35 INFO - [mozharness: 2017-09-21 01:29:35.105735Z] Finished setup-mitmproxy step (success) 18:29:35 INFO - [mozharness: 2017-09-21 01:29:35.105955Z] Running run-tests step. 18:29:35 INFO - Running pre-action listener: _resource_record_pre_action 18:29:35 INFO - Running pre-action listener: _set_gcov_prefix 18:29:35 INFO - Running main action method: run_tests 18:29:35 WARNING - Try message not found. 18:29:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:29:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:29:35 INFO - Python 2.7.3 18:29:35 INFO - Return code: 0 18:29:35 INFO - grabbing minidump binary from tooltool 18:29:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:35 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 0xe84090>, '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 0xe84d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7ef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:29:35 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 18:29:35 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 18:29:35 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 18:29:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:29:35 INFO - Return code: 0 18:29:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:29:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:29:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:29:35 INFO - ENV: RUST_BACKTRACE is now full 18:29:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:29:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:29:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 18:29:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 18:29:35 INFO - Using env: {'DISPLAY': ':0', 18:29:35 INFO - 'HOME': '/home/cltbld', 18:29:35 INFO - 'LANG': 'en_US.UTF-8', 18:29:35 INFO - 'LANGUAGE': 'en_US:en', 18:29:35 INFO - 'LOGNAME': 'cltbld', 18:29:35 INFO - 'MAIL': '/var/mail/cltbld', 18:29:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:29:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:35 INFO - 'MOZ_NO_REMOTE': '1', 18:29:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:35 INFO - 'NO_EM_RESTART': '1', 18:29:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:35 INFO - 'PWD': '/builds/slave/test', 18:29:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:29:35 INFO - 'RUST_BACKTRACE': 'full', 18:29:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:29:35 INFO - 'SHELL': '/bin/bash', 18:29:35 INFO - 'SHLVL': '1', 18:29:35 INFO - 'TERM': 'linux', 18:29:35 INFO - 'TMOUT': '86400', 18:29:35 INFO - 'USER': 'cltbld', 18:29:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', 18:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:35 INFO - '_': '/tools/buildbot/bin/python'} 18:29:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 18:29:35 INFO - mozversion application_buildid: 20170921001837 18:29:35 INFO - mozversion application_changeset: 61340c7debf6dccec3b863d1bc00426feac42fe7 18:29:35 INFO - mozversion application_display_name: Nightly 18:29:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:29:35 INFO - mozversion application_name: Firefox 18:29:35 INFO - mozversion application_remotingname: firefox 18:29:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:29:35 INFO - mozversion application_vendor: Mozilla 18:29:35 INFO - mozversion application_version: 57.0a1 18:29:35 INFO - mozversion platform_buildid: 20170921001837 18:29:35 INFO - mozversion platform_changeset: 61340c7debf6dccec3b863d1bc00426feac42fe7 18:29:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:29:35 INFO - mozversion platform_version: 57.0a1 18:29:35 INFO - using testdate: 1505957375 18:29:35 INFO - actual date: 1505957375 18:29:35 INFO - starting webserver on 'localhost:58660' 18:29:35 INFO - SUITE-START | Running 2 tests 18:29:35 INFO - TEST-START | dromaeo_css 18:29:35 INFO - Initialising browser for dromaeo_css test... 18:29:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58660/getInfo.html -profile /tmp/tmpPL9KJQ/profile 18:29:35 INFO - TEST-INFO | started process 28160 (/builds/slave/test/build/application/firefox/firefox http://localhost:58660/getInfo.html) 18:29:41 INFO - TEST-INFO | 28160: exit 0 18:29:41 INFO - Browser initialized. 18:29:41 INFO - Running cycle 1/1 for dromaeo_css test... 18:29:41 INFO - Using env: {'DISPLAY': ':0', 18:29:41 INFO - 'HOME': '/home/cltbld', 18:29:41 INFO - 'JSGC_DISABLE_POISONING': '1', 18:29:41 INFO - 'LANG': 'en_US.UTF-8', 18:29:41 INFO - 'LANGUAGE': 'en_US:en', 18:29:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:29:41 INFO - 'LOGNAME': 'cltbld', 18:29:41 INFO - 'MAIL': '/var/mail/cltbld', 18:29:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:29:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:29:41 INFO - 'MOZ_CRASHREPORTER': '1', 18:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:29:41 INFO - 'MOZ_NO_REMOTE': '1', 18:29:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:41 INFO - 'NO_EM_RESTART': '1', 18:29:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:41 INFO - 'PWD': '/builds/slave/test', 18:29:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:29:41 INFO - 'RUST_BACKTRACE': 'full', 18:29:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:29:41 INFO - 'SHELL': '/bin/bash', 18:29:41 INFO - 'SHLVL': '1', 18:29:41 INFO - 'STYLO_FORCE_DISABLED': '1', 18:29:41 INFO - 'TERM': 'linux', 18:29:41 INFO - 'TMOUT': '86400', 18:29:41 INFO - 'USER': 'cltbld', 18:29:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', 18:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:41 INFO - '_': '/tools/buildbot/bin/python'} 18:29:41 INFO - TEST-INFO | started process 28389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPL9KJQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:29:42 INFO - PID 28389 | 18:29:42 INFO - PID 28389 | (/builds/slave/test/build/application/firefox/firefox:28437): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:29:42 INFO - PID 28389 | 18:29:52 INFO - PID 28389 | RSS: Main: 156418048 18:29:52 INFO - PID 28389 | 18:32:50 INFO - PID 28389 | Cycle 1(1): loaded http://localhost:58660/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58660/tests/dromaeo/cssquery-ext.html) 18:32:51 INFO - PID 28389 | RSS: Main: 155303936 18:32:51 INFO - PID 28389 | 18:35:53 INFO - PID 28389 | Cycle 1(1): loaded http://localhost:58660/tests/dromaeo/cssquery-ext.html (next: http://localhost:58660/tests/dromaeo/cssquery-jquery.html) 18:35:54 INFO - PID 28389 | RSS: Main: 154812416 18:35:54 INFO - PID 28389 | 18:38:55 INFO - PID 28389 | Cycle 1(1): loaded http://localhost:58660/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58660/tests/dromaeo/cssquery-mootools.html) 18:38:56 INFO - PID 28389 | RSS: Main: 157360128 18:38:56 INFO - PID 28389 | 18:41:58 INFO - PID 28389 | Cycle 1(1): loaded http://localhost:58660/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58660/tests/dromaeo/cssquery-prototype.html) 18:41:58 INFO - PID 28389 | RSS: Main: 156057600 18:41:58 INFO - PID 28389 | 18:45:02 INFO - PID 28389 | Cycle 1(1): loaded http://localhost:58660/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58660/tests/dromaeo/cssquery-yui.html) 18:45:02 INFO - PID 28389 | RSS: Main: 157106176 18:45:02 INFO - PID 28389 | 18:48:04 INFO - PID 28389 | Cycle 1(1): loaded http://localhost:58660/tests/dromaeo/cssquery-yui.html (next: http://localhost:58660/tests/dromaeo/cssquery-dojo.html) 18:48:04 INFO - PID 28389 | RSS: Main: 159629312 18:48:04 INFO - PID 28389 | 18:48:04 INFO - PID 28389 | __start_tp_report 18:48:04 INFO - PID 28389 | _x_x_mozilla_page_load 18:48:04 INFO - PID 28389 | _x_x_mozilla_page_load_details 18:48:04 INFO - PID 28389 | |i|pagename|runs| 18:48:04 INFO - PID 28389 | |0;dojo.html;3132.357866637339;3153.3377990621966;3162.7153556179937;3163.114327988164;3169.809811411315;6225.3463386344465;6297.905531417033;6324.652144132071;6335.714892829822;6443.35566443356;6291.968540157292;6303.275123360815;6313.652749098797;6339.429451349378;6351.142595749572;5736.2256095427;5803.796867109652;5808.4191580842;5861.3552509223955;5974.3428222895445;5893.204417403638;5904;5913.201717768089;5928.940710592882;5939.168516407706;5839.299284085916;5870.853228669296;5935.050391937291;5950.523958083343;5964.821055368324;5255.1640340218955;5627.2684551008515;5749.425057494259;5755.338136114358;5883.941160588382;5818.5926985111055;5820.243368362128;5882.529397648178;5892.793752218652;5896.262967129109;6099.48154406876;6118.632882027093;6333.80998570039;6393.520485963525;6403.455706264973;6698.631575263358;6710.865782684319;6712.194536655584;6715.664216789141;6735.595864248161;6841.760538381132;6861.725530978755;6873.793786186372;6890.93109068913;6944.201416837078;6315.463185629227;6315.74737010519;6400.263969643504;6402.743890244385;6404.647744374058;6792.286809884989;6891.827704307432;6926.134233220848;6990.056342393712;7082.92917070833;6574.474042076622;6628.072069910217;6629.171353580802;6654.767083152066;6657.933420665731;6670.533062685566;6696.46428285736;6725.159355080615;6731.798046058626;6739.224989126314;6743.865122697617;6750.459963202932;6762.087118238975;6784.151981002375;6791.558548694319;6725.125733654691;6732.461403087741;6732.932670673231;6791.320867913268;6846.931530684629;5210.791568337224;5271.789128434896;5284.969430960926;5355.464453554613;5383;4620.029793743284;4653.557911998355;4671.205894997858;4718.787654555554;4749.240121580599;5832.62087964281;5833.095870140135;5835.67903765297;5840.707964601838;5845.327787304429;6794.762183323659;6812.318768123148;6854.451643868479;6861.416779573792;6884.277150899184;5789.015867302569;5798.623089499169;5856.648601083949;5859.355470898197;5861.648301101947;5664.065429204217;5744.167095771173;5757.510611598061;5763.884722305615;5769.134629805562;6499;6520.673966301666;6533.314002029813;6550.8362290943105;6670.132882725215;6748.426383757435;6881.793546193622;6885.345892140239;6897.310268973263;6897.55165914214;6525.771597994048;6540.803775886731;6557.803265902031;6617.139771829824;6628.900566491603;6494.2856285807575;6601.108850305147;6610.570312929644;6724.293949135466;6811.89782153278;6653.201615806134;6659.567128136656;6670.366315200048;6837.179538455417;6848.794536163923;6641.800745977628;6649.667516624053;6662.800115996528;6677.399034086956;6686.69909854048;6571.57284776488;6596.241432235354;6647.6676166192465;6678.933210668026;6685.03067055284;6503.089567460464;6519.217693876765;6571.769988050395;6591.868162636816;6607.438367738796;6488.318726533646;6538.8365290868105;6664.733410663519;6708.496862735216;6725.125733654593;6365.745370185141;6404.359564043559;6488.545801793829;6496.187976502937;6519.641419721961 18:48:04 INFO - PID 28389 | |1;ext.html;834.3992325525619;861.328164032055;884.8672699095135;893.3478560650728;894.9194572488475;37608.43587346189;40129.799351003276;40148.19703605926;40155.799221003894;40224.396634050514;37011.81494092526;37274;37379.81310093446;37424.81287593565;37428.81285593575;7122.323379278961;7258.709651613929;7259.310365515294;7260;7261.092363454568;7176.748813791518;7250.637468126599;7256.709731610729;7260.891086633705;7265.527740696838;7856.25365590268;8010.639521221559;8012.479188852735;8038.477498962578;8042.638081286356;7875.488093273948;7950.801229969239;7953.801154971115;7955.920440795576;7985.680572777082;7235.855282894366;7664.961675191644;7705.4220933430215;7728.613569321511;7822.591933451977;36415.08962275938;36694.08264793375;36714.8164259177;36808;36815.26369472622;3439.2605589798313;3455.879044233465;3469.930601387958;3501.107217659506;3503.9824800876086;30271.394572108653;30334.241643958856;30476.390472190655;30584;30637.38725225483;5121.308623335839;5163.586913046947;5172.974135129338;5182.481751824787;5191.896162076775;191950;193199;193742;193913;194538;48173.75913120412;48428.27357589639;48509.27236091461;48787.26819097716;48885.266720999214;49442.75278623584;49674.503254966985;49788.502114978386;49922.75038624856;49924;15560.84439155594;15847.762283565755;15872;15943.20283985796;15989.440369587008;13182.802257965946;13203.66990825237;13238.007149463829;13245.801312980313;13273.070885038147;14116;14183;14265.42938282478;14353;14393.352299146563;5622.240997465372;5657.8019769307875;5691.402402747652;5762.222100016528;5786;988.1205726903062;991.9008099190023;995.9402435853872;1002.4486532407146;1004.924630652704;21272.680909786366;21927.2325468611;21939.341819745434;22003.669944950838;22143.77856221417;1088.816922071258;1095.8520599719095;1096.413418820927;1107.2636696596835;1118.6196693124377;11720.23818451815;11775.28179670674;11876;11884.524619015143;12084.962886104155;222244;223172;223946;224135;224266;44674.32988505175;45383;50198.49801501938;51123.233151502754;51298;1414.5175217493438;1437.3029080895758;1448.9927550362393;1454.316471258507;1457.234951650392;26678.59982100309;26783.7321626789;26787.86606066957;27266.863665681543;27546.173614791587;36233.09417264589;36258.637413625525;36286.27427451489;36296;36347.63652363548;194092;194739;194752;194943;195696;32522.186945326557;32667.509987349735;32843.17892052718;32975.835120824246;33056.50415243725;39271;41418.1361838712;41640.3753943685;41671.58328416798;41817;30392;30494.542581860846;30872.69127308698;30966.69033309638;31027.844860775553;30444.543331849596;30460.695393045786;30526.542101868046;30687.2328191797;30698.846505767327;34706;34753.13117172091;34942;35010;35191;30118.54822177625;30212.24469388283;30299.697003029687;30399.54400684036;30665.386692266475;20948.266810661553;21196.682049769573;21362.359129226148;21391.78608213898;21447.034883430595 18:48:04 INFO - PID 28389 | |2;jquery.html;567.2625586737244;580.9419058094188;586.5395664403443;595.1816252652605;602.3614968133777;22668.319950401474;23471.178508752197;23509.529809403823;23530.76469235307;23558.5288294234;24106;25616;26047.348816279555;26246.868765656192;26288.342791430223;6381.744730210798;6574.309697481767;6581.506387020969;6583.473322134242;6593.637349945751;6288.434040936315;6520.771772987946;6568.573042752229;6570.342965703439;6587.736490540373;6549.672516374186;6555.344465553454;6556.541042127053;6558.639274839882;6562.44219241365;6582.506312026593;6585.670716464206;6586.077949087132;6587.736490540373;6589.802305930806;5890.499307558863;6128.38716128388;6138.7237574309265;6139.87720245597;6157.876842463125;29170.562441563394;29566.70433295661;29599;29606.111816645534;29687.554686679716;2043.6730123180369;2070.027087268981;2070.5444802143656;2076.5743022680313;2077;19319.80680193194;19635.41093767189;19765.9011704942;19867.30464433738;20334.89832550828;2328.4993726348916;2341.2390972933863;2353.2940117964713;2407.3861165402886;2412.65016572596;118016;123629.38185309016;127216;131444;133324;21188.682169767464;21226.25708100209;22366.664500032188;22600.321990340315;22789.772102278766;42525.36211956823;42564.36153457701;42602.14795704069;42676.359854602204;42731;11634.6509604712;11812.173147879566;11864.762704745857;11870.525178992917;12220.938895305644;9914.206863450907;9966.651167209113;10077.143442807443;10085.848712269322;10101.848472272923;11527.48126334317;11546.59586914454;11567.479463424166;11702.069158588907;11743.706407339885;4027.91944161121;4171.49942006955;4257.297545904891;4400.69195156336;4413.367054189906;951.690700522333;954.5305400057708;963.643451922793;966.9468179250209;984.0651381187901;19254.133563989373;19385.321513746952;19428.708569371473;19579.510512237022;20016.399508014783;1018.9847152292722;1029.5727273181546;1033.813913495578;1034.6016783538241;1038.693585392311;10645.627403040857;10792.730181745363;10798.892011079946;10799.946000269949;10923.836142457869;472567;478997;481511;481892;492818;107600.4619976895;109178.45410772895;111507.4424627888;111660.44169779262;112613;1054.5992522841425;1094.5238821112841;1141.6004398460473;1162.8372027916098;1191.4876603060768;20926;20962.056707447897;21008.579828403654;21023.369298921058;21031.89484052631;54458.7277063628;54605.18092228699;54788.178177326576;55205.17192242039;55707.72146139244;65716.67141664261;66787.66606166938;69722.65138674476;70850;70920;20368.490787729832;20543.8972805135;20670.069846856626;20775.8961205193;21109.57780844344;23230.535389292458;23342;23361;23688;23785.286441406784;18611.348602798837;18659.253629854655;18902.14940327661;19014.14436350395;19036.238550457827;16442.177891105635;16546.83453165453;16557.83442165563;16908.830911691217;17201.913990429966;18982.905085474486;19259.711104333164;19330.323438679578;19435.3197638082;19436;20180.495487612927;20253;20267.797322026592;20346.491337716674;20470.283540076027;18413.907930460264;18580.535486612942;18581.814181858008;18763;18768.436946891616 18:48:04 INFO - PID 28389 | |3;mootools.html;1333.1867560787919;1395.553422904671;1403.8455769865307;1404.466302804934;1406.0930699698692;15149.166795826226;15710.528684139466;15823.97144185627;15843;15890;15446;15476.226188690576;15529.922350388233;15581.220938953036;15604.375824966988;2810.8875644974178;2838.304615369232;2879.84160871152;2880.6975267596913;2888.393437378153;2770.8476033818233;2801.3696918193446;2810.3817160224717;2812.086072026589;2812.3531587734833;2688.1801050679537;2819.5488721804513;2880.3663194097267;2890.3496713239565;2890.638670166229;2824.6610406751115;2824.6751623563346;2879.337752316958;2881.7550508206828;2883.0341835485137;2776.9028084016963;2797.510435673749;2801.831890086581;2807.298175456136;2873.9281517962218;15112.546623601309;15202.087874727442;15210.771838422432;15215.467458639005;15221.695566088727;8329.708460203863;8592.527410992392;8620.568971551398;8620.65517379304;8647.524386158759;5478.835634930959;5635.549156067505;5735.254416925773;5800.303963524362;5825.7378417971295;2001.599680063993;2007.929722459707;2034.6134234495398;2059.5366042640435;2086.9060892259886;26960.73039269602;27154;27806.721932780816;27821.721782782115;27831;7579;7670.961645191738;7708.768736937901;7897.775844744074;7942.841143177104;20979.895100524398;21018.894905525376;21034.42241831838;21035.15859365639;21063.578728425346;8527.232549070613;8608.268297194809;8645.394822362374;8647.654093836301;8648.870266946002;7532;7672.539647621161;7715.537067775951;7808.804779880435;7813;5750.741216645261;5866.911996320058;5918.408159184133;5978.641281523122;5994;1833.6516061948187;1886.7830199526957;1909.2649330007769;1915.8658893877296;1943.8444924406015;887.573964497045;902.6750369866843;917.8760867282965;921.5944984206927;934.3506263147184;7822.256885595859;7905.288524032865;7921.920780792234;7940.602969851484;7973.441859069925;678.2335960364757;687.4775170870174;695.3984803145242;695.9930400696029;699.1540236314116;5193.480651934777;5285.1543753000105;5379.757910894019;5442.292501974718;5527.281453411031;21369.252076177258;21472.4631884201;21632.35102946914;22232.110715571194;22436.10255589758;21033.68449473259;21800.672989905164;21940.232091876707;21983.450413739465;22045.779542204695;11349.773004539862;11369.2609980351;11372;11387.975082242638;11439;8181.304589109992;8213.630386632736;8478.83042339162;8483.533405662747;8491.19333663301;18328.63342733111;19023.239070437026;19059.523511911757;19137;19212.423627291202;19480.220791168194;19500.122494488067;19572.60854782868;19591.902040490277;19700.90149549243;12575.182613130117;12649.810252846399;12677.30274834893;12710.046746493865;12737.745245095231;14112.647183820487;14170.220637865017;14176.716465670836;14206.857931420553;14263.928680356532;11355.261907975955;11529.769404611692;11529.942350288195;11727.296362218294;11844;11157.27477713946;11373.43132843338;11456.541738330374;11463.598774042868;11669.474873630877;10210;10419.583216671552;10428.217883658908;10432.478376081013;10459.110975566859;6617.338266173344;6707.195136583641;6727.831804204934;6738.59568425896;6835.008923705936;7225.891611625935;7226.638668066471;7245.891311630225;7274.305902077879;7306.7077316906725 18:48:04 INFO - PID 28389 | |4;prototype.html;500.04102653209964;520.7708608212389;523.9633225674204;531.0732771314057;531.5773959702037;6369.554131210817;6370.649614271213;6442.5182208092165;6455.483561315095;6455.838604034901;6248.718807653655;6284.3087260401435;6305.590136641115;6315.273743519485;6348.873022539547;4933.531314525115;5084.3136176616235;5207.218917162418;5222.399424066224;5282.683039017652;5030.899382012358;5067.442581316052;5077.416097148838;5088.669236499634;5145.276332428641;5024.82413115541;5043.747812609373;5054.267131265964;5063.215201643751;5085;5061.266116413136;5084.389873215201;5110.335656364686;5112.616553758483;5119.462456442057;4607.281703794777;4607.953920460786;4618.607418369443;4619.122366750306;4625.676202665814;6186.81439556814;6221.346758590328;6263.371523403902;6265.686715664198;6326.620402775849;5707.828765137053;5756.553464777453;5790.33411157718;5819.156222347779;5834.5624078194305;6540.640264785435;6555.672736178635;6612.2726500084955;6698.866022679519;6700.430463410616;4933.210686290176;4949.950500495021;4979.925301120486;5002.474740152305;5016.824411145629;6604.50466215031;6804.183497980224;6822.795316140524;6923.619200943946;7014.859702806018;5105.8555406729265;5127.6154288428515;5134.383873935077;5137.871553211125;5142.1772516397195;5161.922571161435;5185.611079169077;5190.351206099238;5190.858011237598;5201.609879259071;5805.593608447452;5821.18503409523;5821.854453638608;5831.446012628793;5837.941620583825;6654.467642588678;6702.290915816533;6718.529702920749;6740.292269311652;6778.3221677831825;1770.3715181110779;1779.1104447776113;1785.8213579037772;1803.3778346470447;1804.4316040447218;1197.199866660304;1248.4194849395076;1257.2456526084277;1258.8867001969866;1259.5276771210797;5717;5726.627769194989;5734.225879506297;5754.827355179351;5780.040672139514;6747.797566073025;6771.864562708718;6799.524033317719;6828.283030281848;6830.180378354629;5749.281339832521;5752.223449834302;5790.623609465456;5794.478496935211;5811.3026436827;3498.8775392861126;3544.8404821783083;3562.91092722684;3584.4981702561663;3659.9268014639556;6294.653794041372;6384.872302553923;6422.944657709581;6527.412532872065;6532.346765323429;6786.830329241809;6880.279930017496;6927.272636373108;6953.687084081229;6957.79126626202;6390.712417941204;6391.872162556816;6423.743050277936;6481.99529072985;6520.576162549419;6598.358403565075;6656.600603963778;6668.43318317929;6717.1267735194115;6722.529422940347;6680.766173183915;6706.765263215764;6767.25560188369;6787.185537735306;6838.965805170942;6529;6542.149520562297;6566.0479230510355;6596.439302659328;6613.867722645617;5084.466131056334;5112.923306150485;5132.230165475059;5133.230015497706;5138.280640710229;6493.675316234264;6726.856434406065;6738.191417029988;6761.315083279526;6923.203831559234;6434.356564343529;6623.933760662332;6627.834304142242;6637.568558043712;6666.866662666816;6519.706613202512;6564.4420224281475;6602.801915942529;6608.041833934149;6620.801375958729;6279.937200627935;6379.3301703320485;6496.278486201255;6501.512386570931;6545.705443254969;6602.613451175115;6653.500987425866;6694.732210711517;6744.629045402354;6755.459563235027;6417.935820641734;6474.417302442803;6495.870082598416;6509;6531.444827189742 18:48:04 INFO - PID 28389 | |5;yui.html;900.149358855881;916.408916249019;929.2240978782712;932.9906700932988;943.396226415094;17873.374431894885;18106.728399074007;18265.543361415956;18279.26882924685;18281.54296142597;16333.918330408362;17001.14994250289;17043.403480878173;17064.573385665364;17091.059991700484;961.9326647134703;975.4683697384942;976.584951395654;979.5836769373024;980.0297705271765;953.2421724728822;982.3761911186413;993.4784238274891;993.508213434351;995.0248756218909;1041.1722680469045;1043.504335440667;1051.479517638766;1052.8420736889489;1053.157474020784;1034.8033873564036;1036.8289232276666;1046.2885238038132;1050.4695128959827;1050.6007717067541;773.2383602151876;774.5623722596715;776.1539921485552;778.0352363069809;778.9454738168331;16761.66476670472;18241.543961400937;18348.35780747681;18431.078446077776;18452.53868653281;21421.14315427381;21788;22089.558208835893;22169.334919952267;22212.333629991124;17416.30334786607;17481.737773933273;17540.122993850255;17575.29698812046;17626.647467050716;3778.886633401002;3803.1062700265416;3806.6764325032404;3811.542614886204;3812.7902965336893;143168;143656;143709;143974;144142;16889.662206755795;17144.828551714323;17352.04563749006;17364.218610162574;17540.122993850255;31598.210044748605;32171.195720107185;32188.517172242435;32213.677863221536;32247.51628725571;8053.395995300376;8346.624401901929;8398.790030249293;8400.495970241805;8411.116832732598;4328.43730315057;4374.868753937387;4430.534793846664;4436.844710435119;4442.622377097983;5372.8656783579945;5504.256925315111;5540.501354878081;5565.081761509306;5590.776368945197;1008.0776089877826;1021.9744506387251;1028.5782829040058;1039.2050081687514;1041.7083216699336;678.8981652752127;695.2213520856571;703.8064532253671;712.056525104239;716.1263258824226;11550.711232219262;11851.585194518151;12098.516059357704;12292.078094142797;12554.874451255553;685.5578152091972;687.4672129099888;701.7614011236102;702.2485940044104;707.7310621963724;5590.608657393944;5601.60788744784;5604.6917419542315;5673.546116310686;5752.654840709487;122295;125172;126328;130114;130357.34821325833;107516;108293;109843.45078274717;110869;111530;96361.51819240859;97076.51461742788;98446;99301;100727;10214.43820589845;10351.171906247633;10491.94754026225;10570.630027948984;10737.248392612442;45157;45637;46317.768411157725;46836.7658161707;47197.29204062011;56795;57557.19178252995;57631;60289.39710602838;60863;14977.475788347356;15291.770623440434;15327;15357.692846143238;15363;17420.216090276223;17737.467875963743;17787.46637600874;17798.644027119128;17850.732239016164;14993.475228366955;15007.924960375129;15180.772288415903;15216.771748424004;15283.46507872219;15569.221538923235;15703;15719.607009824846;15724.449644262397;15798.36806527772;15244.085354878744;15393.230338483256;15394.46119385861;15476.380944762084;15675.529734107995;12338.75322493563;12578.371081445708;12633.431495582905;12652.620421387373;12671;11625.825612615987;11832.645020649394;11841;12032.338221397556;12101.455434505293 18:48:04 INFO - PID 28389 | __end_tp_report 18:48:04 INFO - PID 28389 | __start_cc_report 18:48:04 INFO - PID 28389 | _x_x_mozilla_cycle_collect,280 18:48:04 INFO - PID 28389 | __end_cc_report 18:48:04 INFO - PID 28389 | __startTimestamp1505958484507__endTimestamp 18:48:04 INFO - PID 28389 | 18:48:04 INFO - PID 28389 | ------- Summary: start ------- 18:48:04 INFO - PID 28389 | Number of tests: 6 18:48:04 INFO - PID 28389 | 18:48:04 INFO - PID 28389 | [#0] dojo.html Cycles:165 Average:6229.53 Median:6503.09 stddev:750.77 (11.5%) stddev-sans-first:712.67 18:48:04 INFO - PID 28389 | Values: 3132.4 3153.3 3162.7 3163.1 3169.8 6225.3 6297.9 6324.7 6335.7 6443.4 6292.0 6303.3 6313.7 6339.4 6351.1 5736.2 5803.8 5808.4 5861.4 5974.3 5893.2 5904.0 5913.2 5928.9 5939.2 5839.3 5870.9 5935.1 5950.5 5964.8 5255.2 5627.3 5749.4 5755.3 5883.9 5818.6 5820.2 5882.5 5892.8 5896.3 6099.5 6118.6 6333.8 6393.5 6403.5 6698.6 6710.9 6712.2 6715.7 6735.6 6841.8 6861.7 6873.8 6890.9 6944.2 6315.5 6315.7 6400.3 6402.7 6404.6 6792.3 6891.8 6926.1 6990.1 7082.9 6574.5 6628.1 6629.2 6654.8 6657.9 6670.5 6696.5 6725.2 6731.8 6739.2 6743.9 6750.5 6762.1 6784.2 6791.6 6725.1 6732.5 6732.9 6791.3 6846.9 5210.8 5271.8 5285.0 5355.5 5383.0 4620.0 4653.6 4671.2 4718.8 4749.2 5832.6 5833.1 5835.7 5840.7 5845.3 6794.8 6812.3 6854.5 6861.4 6884.3 5789.0 5798.6 5856.6 5859.4 5861.6 5664.1 5744.2 5757.5 5763.9 5769.1 6499.0 6520.7 6533.3 6550.8 6670.1 6748.4 6881.8 6885.3 6897.3 6897.6 6525.8 6540.8 6557.8 6617.1 6628.9 6494.3 6601.1 6610.6 6724.3 6811.9 6653.2 6659.6 6670.4 6837.2 6848.8 6641.8 6649.7 6662.8 6677.4 6686.7 6571.6 6596.2 6647.7 6678.9 6685.0 6503.1 6519.2 6571.8 6591.9 6607.4 6488.3 6538.8 6664.7 6708.5 6725.1 6365.7 6404.4 6488.5 6496.2 6519.6 18:48:04 INFO - PID 28389 | 18:48:04 INFO - PID 28389 | [#1] ext.html Cycles:180 Average:36716.45 Median:34729.57 stddev:52899.57 (152.3%) stddev-sans-first:52979.35 18:48:04 INFO - PID 28389 | Values: 834.4 861.3 884.9 893.3 894.9 37608.4 40129.8 40148.2 40155.8 40224.4 37011.8 37274.0 37379.8 37424.8 37428.8 7122.3 7258.7 7259.3 7260.0 7261.1 7176.7 7250.6 7256.7 7260.9 7265.5 7856.3 8010.6 8012.5 8038.5 8042.6 7875.5 7950.8 7953.8 7955.9 7985.7 7235.9 7665.0 7705.4 7728.6 7822.6 36415.1 36694.1 36714.8 36808.0 36815.3 3439.3 3455.9 3469.9 3501.1 3504.0 30271.4 30334.2 30476.4 30584.0 30637.4 5121.3 5163.6 5173.0 5182.5 5191.9 191950.0 193199.0 193742.0 193913.0 194538.0 48173.8 48428.3 48509.3 48787.3 48885.3 49442.8 49674.5 49788.5 49922.8 49924.0 15560.8 15847.8 15872.0 15943.2 15989.4 13182.8 13203.7 13238.0 13245.8 13273.1 14116.0 14183.0 14265.4 14353.0 14393.4 5622.2 5657.8 5691.4 5762.2 5786.0 988.1 991.9 995.9 1002.4 1004.9 21272.7 21927.2 21939.3 22003.7 22143.8 1088.8 1095.9 1096.4 1107.3 1118.6 11720.2 11775.3 11876.0 11884.5 12085.0 222244.0 223172.0 223946.0 224135.0 224266.0 44674.3 45383.0 50198.5 51123.2 51298.0 1414.5 1437.3 1449.0 1454.3 1457.2 26678.6 26783.7 26787.9 27266.9 27546.2 36233.1 36258.6 36286.3 36296.0 36347.6 194092.0 194739.0 194752.0 194943.0 195696.0 32522.2 32667.5 32843.2 32975.8 33056.5 39271.0 41418.1 41640.4 41671.6 41817.0 30392.0 30494.5 30872.7 30966.7 31027.8 30444.5 30460.7 30526.5 30687.2 30698.8 34706.0 34753.1 34942.0 35010.0 35191.0 30118.5 30212.2 30299.7 30399.5 30665.4 20948.3 21196.7 21362.4 21391.8 21447.0 18:48:04 INFO - PID 28389 | 18:48:04 INFO - PID 28389 | [#2] jquery.html Cycles:180 Average:35361.49 Median:22483.49 stddev:80511.68 (358.1%) stddev-sans-first:80695.15 18:48:04 INFO - PID 28389 | Values: 567.3 580.9 586.5 595.2 602.4 22668.3 23471.2 23509.5 23530.8 23558.5 24106.0 25616.0 26047.3 26246.9 26288.3 6381.7 6574.3 6581.5 6583.5 6593.6 6288.4 6520.8 6568.6 6570.3 6587.7 6549.7 6555.3 6556.5 6558.6 6562.4 6582.5 6585.7 6586.1 6587.7 6589.8 5890.5 6128.4 6138.7 6139.9 6157.9 29170.6 29566.7 29599.0 29606.1 29687.6 2043.7 2070.0 2070.5 2076.6 2077.0 19319.8 19635.4 19765.9 19867.3 20334.9 2328.5 2341.2 2353.3 2407.4 2412.7 118016.0 123629.4 127216.0 131444.0 133324.0 21188.7 21226.3 22366.7 22600.3 22789.8 42525.4 42564.4 42602.1 42676.4 42731.0 11634.7 11812.2 11864.8 11870.5 12220.9 9914.2 9966.7 10077.1 10085.8 10101.8 11527.5 11546.6 11567.5 11702.1 11743.7 4027.9 4171.5 4257.3 4400.7 4413.4 951.7 954.5 963.6 966.9 984.1 19254.1 19385.3 19428.7 19579.5 20016.4 1019.0 1029.6 1033.8 1034.6 1038.7 10645.6 10792.7 10798.9 10799.9 10923.8 472567.0 478997.0 481511.0 481892.0 492818.0 107600.5 109178.5 111507.4 111660.4 112613.0 1054.6 1094.5 1141.6 1162.8 1191.5 20926.0 20962.1 21008.6 21023.4 21031.9 54458.7 54605.2 54788.2 55205.2 55707.7 65716.7 66787.7 69722.7 70850.0 70920.0 20368.5 20543.9 20670.1 20775.9 21109.6 23230.5 23342.0 23361.0 23688.0 23785.3 18611.3 18659.3 18902.1 19014.1 19036.2 16442.2 16546.8 16557.8 16908.8 17201.9 18982.9 19259.7 19330.3 19435.3 19436.0 20180.5 20253.0 20267.8 20346.5 20470.3 18413.9 18580.5 18581.8 18763.0 18768.4 18:48:04 INFO - PID 28389 | 18:48:04 INFO - PID 28389 | [#3] mootools.html Cycles:180 Average:9713.10 Median:27814.22 stddev:6937.20 (24.9%) stddev-sans-first:6928.09 18:48:04 INFO - PID 28389 | Values: 1333.2 1395.6 1403.8 1404.5 1406.1 15149.2 15710.5 15824.0 15843.0 15890.0 15446.0 15476.2 15529.9 15581.2 15604.4 2810.9 2838.3 2879.8 2880.7 2888.4 2770.8 2801.4 2810.4 2812.1 2812.4 2688.2 2819.5 2880.4 2890.3 2890.6 2824.7 2824.7 2879.3 2881.8 2883.0 2776.9 2797.5 2801.8 2807.3 2873.9 15112.5 15202.1 15210.8 15215.5 15221.7 8329.7 8592.5 8620.6 8620.7 8647.5 5478.8 5635.5 5735.3 5800.3 5825.7 2001.6 2007.9 2034.6 2059.5 2086.9 26960.7 27154.0 27806.7 27821.7 27831.0 7579.0 7671.0 7708.8 7897.8 7942.8 20979.9 21018.9 21034.4 21035.2 21063.6 8527.2 8608.3 8645.4 8647.7 8648.9 7532.0 7672.5 7715.5 7808.8 7813.0 5750.7 5866.9 5918.4 5978.6 5994.0 1833.7 1886.8 1909.3 1915.9 1943.8 887.6 902.7 917.9 921.6 934.4 7822.3 7905.3 7921.9 7940.6 7973.4 678.2 687.5 695.4 696.0 699.2 5193.5 5285.2 5379.8 5442.3 5527.3 21369.3 21472.5 21632.4 22232.1 22436.1 21033.7 21800.7 21940.2 21983.5 22045.8 11349.8 11369.3 11372.0 11388.0 11439.0 8181.3 8213.6 8478.8 8483.5 8491.2 18328.6 19023.2 19059.5 19137.0 19212.4 19480.2 19500.1 19572.6 19591.9 19700.9 12575.2 12649.8 12677.3 12710.0 12737.7 14112.6 14170.2 14176.7 14206.9 14263.9 11355.3 11529.8 11529.9 11727.3 11844.0 11157.3 11373.4 11456.5 11463.6 11669.5 10210.0 10419.6 10428.2 10432.5 10459.1 6617.3 6707.2 6727.8 6738.6 6835.0 7225.9 7226.6 7245.9 7274.3 7306.7 18:48:04 INFO - PID 28389 | 18:48:04 INFO - PID 28389 | [#4] prototype.html Cycles:180 Average:5580.61 Median:6282.12 stddev:1549.29 (24.7%) stddev-sans-first:1505.97 18:48:04 INFO - PID 28389 | Values: 500.0 520.8 524.0 531.1 531.6 6369.6 6370.6 6442.5 6455.5 6455.8 6248.7 6284.3 6305.6 6315.3 6348.9 4933.5 5084.3 5207.2 5222.4 5282.7 5030.9 5067.4 5077.4 5088.7 5145.3 5024.8 5043.7 5054.3 5063.2 5085.0 5061.3 5084.4 5110.3 5112.6 5119.5 4607.3 4608.0 4618.6 4619.1 4625.7 6186.8 6221.3 6263.4 6265.7 6326.6 5707.8 5756.6 5790.3 5819.2 5834.6 6540.6 6555.7 6612.3 6698.9 6700.4 4933.2 4950.0 4979.9 5002.5 5016.8 6604.5 6804.2 6822.8 6923.6 7014.9 5105.9 5127.6 5134.4 5137.9 5142.2 5161.9 5185.6 5190.4 5190.9 5201.6 5805.6 5821.2 5821.9 5831.4 5837.9 6654.5 6702.3 6718.5 6740.3 6778.3 1770.4 1779.1 1785.8 1803.4 1804.4 1197.2 1248.4 1257.2 1258.9 1259.5 5717.0 5726.6 5734.2 5754.8 5780.0 6747.8 6771.9 6799.5 6828.3 6830.2 5749.3 5752.2 5790.6 5794.5 5811.3 3498.9 3544.8 3562.9 3584.5 3659.9 6294.7 6384.9 6422.9 6527.4 6532.3 6786.8 6880.3 6927.3 6953.7 6957.8 6390.7 6391.9 6423.7 6482.0 6520.6 6598.4 6656.6 6668.4 6717.1 6722.5 6680.8 6706.8 6767.3 6787.2 6839.0 6529.0 6542.1 6566.0 6596.4 6613.9 5084.5 5112.9 5132.2 5133.2 5138.3 6493.7 6726.9 6738.2 6761.3 6923.2 6434.4 6623.9 6627.8 6637.6 6666.9 6519.7 6564.4 6602.8 6608.0 6620.8 6279.9 6379.3 6496.3 6501.5 6545.7 6602.6 6653.5 6694.7 6744.6 6755.5 6417.9 6474.4 6495.9 6509.0 6531.4 18:48:04 INFO - PID 28389 | 18:48:04 INFO - PID 28389 | [#5] yui.html Cycles:180 Average:24652.21 Median:17824.69 stddev:36311.64 (203.7%) stddev-sans-first:36369.71 18:48:04 INFO - PID 28389 | Values: 900.1 916.4 929.2 933.0 943.4 17873.4 18106.7 18265.5 18279.3 18281.5 16333.9 17001.1 17043.4 17064.6 17091.1 961.9 975.5 976.6 979.6 980.0 953.2 982.4 993.5 993.5 995.0 1041.2 1043.5 1051.5 1052.8 1053.2 1034.8 1036.8 1046.3 1050.5 1050.6 773.2 774.6 776.2 778.0 778.9 16761.7 18241.5 18348.4 18431.1 18452.5 21421.1 21788.0 22089.6 22169.3 22212.3 17416.3 17481.7 17540.1 17575.3 17626.6 3778.9 3803.1 3806.7 3811.5 3812.8 143168.0 143656.0 143709.0 143974.0 144142.0 16889.7 17144.8 17352.0 17364.2 17540.1 31598.2 32171.2 32188.5 32213.7 32247.5 8053.4 8346.6 8398.8 8400.5 8411.1 4328.4 4374.9 4430.5 4436.8 4442.6 5372.9 5504.3 5540.5 5565.1 5590.8 1008.1 1022.0 1028.6 1039.2 1041.7 678.9 695.2 703.8 712.1 716.1 11550.7 11851.6 12098.5 12292.1 12554.9 685.6 687.5 701.8 702.2 707.7 5590.6 5601.6 5604.7 5673.5 5752.7 122295.0 125172.0 126328.0 130114.0 130357.3 107516.0 108293.0 109843.5 110869.0 111530.0 96361.5 97076.5 98446.0 99301.0 100727.0 10214.4 10351.2 10491.9 10570.6 10737.2 45157.0 45637.0 46317.8 46836.8 47197.3 56795.0 57557.2 57631.0 60289.4 60863.0 14977.5 15291.8 15327.0 15357.7 15363.0 17420.2 17737.5 17787.5 17798.6 17850.7 14993.5 15007.9 15180.8 15216.8 15283.5 15569.2 15703.0 15719.6 15724.4 15798.4 15244.1 15393.2 15394.5 15476.4 15675.5 12338.8 12578.4 12633.4 12652.6 12671.0 11625.8 11832.6 11841.0 12032.3 12101.5 18:48:04 INFO - PID 28389 | -------- Summary: end -------- 18:48:04 INFO - PID 28389 | 18:48:05 INFO - TEST-INFO | 28389: exit 0 18:48:05 INFO - TEST-OK | dromaeo_css | took 1109746ms 18:48:05 INFO - TEST-START | kraken 18:48:05 INFO - Initialising browser for kraken test... 18:48:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58660/getInfo.html -profile /tmp/tmpKXyRTx/profile 18:48:05 INFO - TEST-INFO | started process 28749 (/builds/slave/test/build/application/firefox/firefox http://localhost:58660/getInfo.html) 18:48:10 INFO - TEST-INFO | 28749: exit 0 18:48:11 INFO - Browser initialized. 18:48:11 INFO - Running cycle 1/1 for kraken test... 18:48:11 INFO - Using env: {'DISPLAY': ':0', 18:48:11 INFO - 'HOME': '/home/cltbld', 18:48:11 INFO - 'JSGC_DISABLE_POISONING': '1', 18:48:11 INFO - 'LANG': 'en_US.UTF-8', 18:48:11 INFO - 'LANGUAGE': 'en_US:en', 18:48:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:48:11 INFO - 'LOGNAME': 'cltbld', 18:48:11 INFO - 'MAIL': '/var/mail/cltbld', 18:48:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:48:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:48:11 INFO - 'MOZ_CRASHREPORTER': '1', 18:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:48:11 INFO - 'MOZ_NO_REMOTE': '1', 18:48:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:11 INFO - 'NO_EM_RESTART': '1', 18:48:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:11 INFO - 'PWD': '/builds/slave/test', 18:48:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:48:11 INFO - 'RUST_BACKTRACE': 'full', 18:48:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:48:11 INFO - 'SHELL': '/bin/bash', 18:48:11 INFO - 'SHLVL': '1', 18:48:11 INFO - 'STYLO_FORCE_DISABLED': '1', 18:48:11 INFO - 'TERM': 'linux', 18:48:11 INFO - 'TMOUT': '86400', 18:48:11 INFO - 'USER': 'cltbld', 18:48:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086', 18:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:11 INFO - '_': '/tools/buildbot/bin/python'} 18:48:11 INFO - TEST-INFO | started process 28984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKXyRTx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:48:11 INFO - PID 28984 | 18:48:11 INFO - PID 28984 | (/builds/slave/test/build/application/firefox/firefox:29034): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:48:11 INFO - PID 28984 | 18:48:22 INFO - PID 28984 | RSS: Main: 154542080 18:48:22 INFO - PID 28984 | 18:48:24 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58660/tests/kraken/driver.html?testName=audio-beat-detection) 18:48:25 INFO - PID 28984 | RSS: Main: 160509952 18:48:25 INFO - PID 28984 | 18:48:28 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58660/tests/kraken/driver.html?testName=audio-dft) 18:48:28 INFO - PID 28984 | RSS: Main: 160968704 18:48:28 INFO - PID 28984 | 18:48:32 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58660/tests/kraken/driver.html?testName=audio-fft) 18:48:32 INFO - PID 28984 | RSS: Main: 156745728 18:48:32 INFO - PID 28984 | 18:48:34 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58660/tests/kraken/driver.html?testName=audio-oscillator) 18:48:35 INFO - PID 28984 | RSS: Main: 157212672 18:48:35 INFO - PID 28984 | 18:48:37 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58660/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:48:37 INFO - PID 28984 | RSS: Main: 157499392 18:48:37 INFO - PID 28984 | 18:48:41 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58660/tests/kraken/driver.html?testName=imaging-darkroom) 18:48:41 INFO - PID 28984 | RSS: Main: 159703040 18:48:41 INFO - PID 28984 | 18:48:45 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58660/tests/kraken/driver.html?testName=imaging-desaturate) 18:48:46 INFO - PID 28984 | RSS: Main: 160260096 18:48:46 INFO - PID 28984 | 18:48:49 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58660/tests/kraken/driver.html?testName=json-parse-financial) 18:48:49 INFO - PID 28984 | RSS: Main: 160276480 18:48:49 INFO - PID 28984 | 18:48:51 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58660/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:48:51 INFO - PID 28984 | RSS: Main: 160096256 18:48:51 INFO - PID 28984 | 18:48:53 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:48:54 INFO - PID 28984 | RSS: Main: 159944704 18:48:54 INFO - PID 28984 | 18:48:56 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:48:56 INFO - PID 28984 | RSS: Main: 156954624 18:48:56 INFO - PID 28984 | 18:48:59 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:49:00 INFO - PID 28984 | RSS: Main: 156934144 18:49:00 INFO - PID 28984 | 18:49:03 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:49:03 INFO - PID 28984 | RSS: Main: 157405184 18:49:03 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | Cycle 1(1): loaded http://localhost:58660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58660/tests/kraken/driver.html?testName=ai-astar) 18:49:05 INFO - PID 28984 | RSS: Main: 158539776 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | __start_tp_report 18:49:05 INFO - PID 28984 | _x_x_mozilla_page_load 18:49:05 INFO - PID 28984 | _x_x_mozilla_page_load_details 18:49:05 INFO - PID 28984 | |i|pagename|runs| 18:49:05 INFO - PID 28984 | |0;ai-astar;108;107;107;107;107;108;107;109;106;109 18:49:05 INFO - PID 28984 | |1;audio-beat-detection;117;127;116;118;117;120;116;123;118;117 18:49:05 INFO - PID 28984 | |2;audio-dft;163;164;163;163;162;164;162;169;166;167 18:49:05 INFO - PID 28984 | |3;audio-fft;74;73;73;74;74;74;73;75;74;74 18:49:05 INFO - PID 28984 | |4;audio-oscillator;80;80;79;78;80;78;78;80;82;80 18:49:05 INFO - PID 28984 | |5;imaging-gaussian-blur;113;113;113;113;114;114;114;114;113;114 18:49:05 INFO - PID 28984 | |6;imaging-darkroom;149;147;150;148;148;149;148;149;149;149 18:49:05 INFO - PID 28984 | |7;imaging-desaturate;104;93;94;94;94;96;94;95;93;95 18:49:05 INFO - PID 28984 | |8;json-parse-financial;52;54;53;54;53;54;55;52;50;51 18:49:05 INFO - PID 28984 | |9;json-stringify-tinderbox;38;38;38;38;38;38;45;38;38;39 18:49:05 INFO - PID 28984 | |10;stanford-crypto-aes;71;72;72;74;72;73;74;74;72;73 18:49:05 INFO - PID 28984 | |11;stanford-crypto-ccm;117;117;112;112;109;117;115;115;111;109 18:49:05 INFO - PID 28984 | |12;stanford-crypto-pbkdf2;173;171;169;174;168;169;167;179;173;169 18:49:05 INFO - PID 28984 | |13;stanford-crypto-sha256-iterative;66;73;66;67;66;71;67;69;65;66 18:49:05 INFO - PID 28984 | __end_tp_report 18:49:05 INFO - PID 28984 | __start_cc_report 18:49:05 INFO - PID 28984 | _x_x_mozilla_cycle_collect,744 18:49:05 INFO - PID 28984 | __end_cc_report 18:49:05 INFO - PID 28984 | __startTimestamp1505958545687__endTimestamp 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | ------- Summary: start ------- 18:49:05 INFO - PID 28984 | Number of tests: 14 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#0] ai-astar Cycles:10 Average:107.50 Median:107.50 stddev:0.97 (0.9%) stddev-sans-first:1.01 18:49:05 INFO - PID 28984 | Values: 108.0 107.0 107.0 107.0 107.0 108.0 107.0 109.0 106.0 109.0 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#1] audio-beat-detection Cycles:10 Average:118.90 Median:118.00 stddev:3.54 (3.0%) stddev-sans-first:3.69 18:49:05 INFO - PID 28984 | Values: 117.0 127.0 116.0 118.0 117.0 120.0 116.0 123.0 118.0 117.0 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.31 (1.4%) stddev-sans-first:2.40 18:49:05 INFO - PID 28984 | Values: 163.0 164.0 163.0 163.0 162.0 164.0 162.0 169.0 166.0 167.0 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 18:49:05 INFO - PID 28984 | Values: 74.0 73.0 73.0 74.0 74.0 74.0 73.0 75.0 74.0 74.0 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:80.00 stddev:1.27 (1.6%) stddev-sans-first:1.33 18:49:05 INFO - PID 28984 | Values: 80.0 80.0 79.0 78.0 80.0 78.0 78.0 80.0 82.0 80.0 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:49:05 INFO - PID 28984 | Values: 113.0 113.0 113.0 113.0 114.0 114.0 114.0 114.0 113.0 114.0 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 18:49:05 INFO - PID 28984 | Values: 149.0 147.0 150.0 148.0 148.0 149.0 148.0 149.0 149.0 149.0 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.00 stddev:3.22 (3.4%) stddev-sans-first:0.97 18:49:05 INFO - PID 28984 | Values: 104.0 93.0 94.0 94.0 94.0 96.0 94.0 95.0 93.0 95.0 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.50 stddev:1.55 (2.9%) stddev-sans-first:1.62 18:49:05 INFO - PID 28984 | Values: 52.0 54.0 53.0 54.0 53.0 54.0 55.0 52.0 50.0 51.0 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#9] json-stringify-tinderbox Cycles:10 Average:38.80 Median:38.00 stddev:2.20 (5.8%) stddev-sans-first:2.32 18:49:05 INFO - PID 28984 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 45.0 38.0 38.0 39.0 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:73.00 stddev:1.06 (1.5%) stddev-sans-first:0.93 18:49:05 INFO - PID 28984 | Values: 71.0 72.0 72.0 74.0 72.0 73.0 74.0 74.0 72.0 73.0 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#11] stanford-crypto-ccm Cycles:10 Average:113.40 Median:115.00 stddev:3.20 (2.8%) stddev-sans-first:3.12 18:49:05 INFO - PID 28984 | Values: 117.0 117.0 112.0 112.0 109.0 117.0 115.0 115.0 111.0 109.0 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:172.00 stddev:3.61 (2.1%) stddev-sans-first:3.77 18:49:05 INFO - PID 28984 | Values: 173.0 171.0 169.0 174.0 168.0 169.0 167.0 179.0 173.0 169.0 18:49:05 INFO - PID 28984 | 18:49:05 INFO - PID 28984 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:2.59 (3.9%) stddev-sans-first:2.68 18:49:05 INFO - PID 28984 | Values: 66.0 73.0 66.0 67.0 66.0 71.0 67.0 69.0 65.0 66.0 18:49:05 INFO - PID 28984 | -------- Summary: end -------- 18:49:05 INFO - PID 28984 | 18:49:06 INFO - PID 28984 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:49:06 INFO - TEST-INFO | 28984: exit 0 18:49:06 INFO - TEST-OK | kraken | took 61161ms 18:49:06 INFO - SUITE-END | took 1170s 18:49:06 INFO - Completed test suite (00:19:31) 18:49:06 INFO - javascript benchmark 18:49:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8666.8371566935, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.357866637339, 3153.3377990621966, 3162.7153556179937, 3163.114327988164, 3169.809811411315, 6225.3463386344465, 6297.905531417033, 6324.652144132071, 6335.714892829822, 6443.35566443356, 6291.968540157292, 6303.275123360815, 6313.652749098797, 6339.429451349378, 6351.142595749572, 5736.2256095427, 5803.796867109652, 5808.4191580842, 5861.3552509223955, 5974.3428222895445, 5893.204417403638, 5904.0, 5913.201717768089, 5928.940710592882, 5939.168516407706, 5839.299284085916, 5870.853228669296, 5935.050391937291, 5950.523958083343, 5964.821055368324, 5255.1640340218955, 5627.2684551008515, 5749.425057494259, 5755.338136114358, 5883.941160588382, 5818.5926985111055, 5820.243368362128, 5882.529397648178, 5892.793752218652, 5896.262967129109, 6099.48154406876, 6118.632882027093, 6333.80998570039, 6393.520485963525, 6403.455706264973, 6698.631575263358, 6710.865782684319, 6712.194536655584, 6715.664216789141, 6735.595864248161, 6841.760538381132, 6861.725530978755, 6873.793786186372, 6890.93109068913, 6944.201416837078, 6315.463185629227, 6315.74737010519, 6400.263969643504, 6402.743890244385, 6404.647744374058, 6792.286809884989, 6891.827704307432, 6926.134233220848, 6990.056342393712, 7082.92917070833, 6574.474042076622, 6628.072069910217, 6629.171353580802, 6654.767083152066, 6657.933420665731, 6670.533062685566, 6696.46428285736, 6725.159355080615, 6731.798046058626, 6739.224989126314, 6743.865122697617, 6750.459963202932, 6762.087118238975, 6784.151981002375, 6791.558548694319, 6725.125733654691, 6732.461403087741, 6732.932670673231, 6791.320867913268, 6846.931530684629, 5210.791568337224, 5271.789128434896, 5284.969430960926, 5355.464453554613, 5383.0, 4620.029793743284, 4653.557911998355, 4671.205894997858, 4718.787654555554, 4749.240121580599, 5832.62087964281, 5833.095870140135, 5835.67903765297, 5840.707964601838, 5845.327787304429, 6794.762183323659, 6812.318768123148, 6854.451643868479, 6861.416779573792, 6884.277150899184, 5789.015867302569, 5798.623089499169, 5856.648601083949, 5859.355470898197, 5861.648301101947, 5664.065429204217, 5744.167095771173, 5757.510611598061, 5763.884722305615, 5769.134629805562, 6499.0, 6520.673966301666, 6533.314002029813, 6550.8362290943105, 6670.132882725215, 6748.426383757435, 6881.793546193622, 6885.345892140239, 6897.310268973263, 6897.55165914214, 6525.771597994048, 6540.803775886731, 6557.803265902031, 6617.139771829824, 6628.900566491603, 6494.2856285807575, 6601.108850305147, 6610.570312929644, 6724.293949135466, 6811.89782153278, 6653.201615806134, 6659.567128136656, 6670.366315200048, 6837.179538455417, 6848.794536163923, 6641.800745977628, 6649.667516624053, 6662.800115996528, 6677.399034086956, 6686.69909854048, 6571.57284776488, 6596.241432235354, 6647.6676166192465, 6678.933210668026, 6685.03067055284, 6503.089567460464, 6519.217693876765, 6571.769988050395, 6591.868162636816, 6607.438367738796, 6488.318726533646, 6538.8365290868105, 6664.733410663519, 6708.496862735216, 6725.125733654593, 6365.745370185141, 6404.359564043559, 6488.545801793829, 6496.187976502937, 6519.641419721961], "value": 6171.9236123103365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.3992325525619, 861.328164032055, 884.8672699095135, 893.3478560650728, 894.9194572488475, 37608.43587346189, 40129.799351003276, 40148.19703605926, 40155.799221003894, 40224.396634050514, 37011.81494092526, 37274.0, 37379.81310093446, 37424.81287593565, 37428.81285593575, 7122.323379278961, 7258.709651613929, 7259.310365515294, 7260.0, 7261.092363454568, 7176.748813791518, 7250.637468126599, 7256.709731610729, 7260.891086633705, 7265.527740696838, 7856.25365590268, 8010.639521221559, 8012.479188852735, 8038.477498962578, 8042.638081286356, 7875.488093273948, 7950.801229969239, 7953.801154971115, 7955.920440795576, 7985.680572777082, 7235.855282894366, 7664.961675191644, 7705.4220933430215, 7728.613569321511, 7822.591933451977, 36415.08962275938, 36694.08264793375, 36714.8164259177, 36808.0, 36815.26369472622, 3439.2605589798313, 3455.879044233465, 3469.930601387958, 3501.107217659506, 3503.9824800876086, 30271.394572108653, 30334.241643958856, 30476.390472190655, 30584.0, 30637.38725225483, 5121.308623335839, 5163.586913046947, 5172.974135129338, 5182.481751824787, 5191.896162076775, 191950.0, 193199.0, 193742.0, 193913.0, 194538.0, 48173.75913120412, 48428.27357589639, 48509.27236091461, 48787.26819097716, 48885.266720999214, 49442.75278623584, 49674.503254966985, 49788.502114978386, 49922.75038624856, 49924.0, 15560.84439155594, 15847.762283565755, 15872.0, 15943.20283985796, 15989.440369587008, 13182.802257965946, 13203.66990825237, 13238.007149463829, 13245.801312980313, 13273.070885038147, 14116.0, 14183.0, 14265.42938282478, 14353.0, 14393.352299146563, 5622.240997465372, 5657.8019769307875, 5691.402402747652, 5762.222100016528, 5786.0, 988.1205726903062, 991.9008099190023, 995.9402435853872, 1002.4486532407146, 1004.924630652704, 21272.680909786366, 21927.2325468611, 21939.341819745434, 22003.669944950838, 22143.77856221417, 1088.816922071258, 1095.8520599719095, 1096.413418820927, 1107.2636696596835, 1118.6196693124377, 11720.23818451815, 11775.28179670674, 11876.0, 11884.524619015143, 12084.962886104155, 222244.0, 223172.0, 223946.0, 224135.0, 224266.0, 44674.32988505175, 45383.0, 50198.49801501938, 51123.233151502754, 51298.0, 1414.5175217493438, 1437.3029080895758, 1448.9927550362393, 1454.316471258507, 1457.234951650392, 26678.59982100309, 26783.7321626789, 26787.86606066957, 27266.863665681543, 27546.173614791587, 36233.09417264589, 36258.637413625525, 36286.27427451489, 36296.0, 36347.63652363548, 194092.0, 194739.0, 194752.0, 194943.0, 195696.0, 32522.186945326557, 32667.509987349735, 32843.17892052718, 32975.835120824246, 33056.50415243725, 39271.0, 41418.1361838712, 41640.3753943685, 41671.58328416798, 41817.0, 30392.0, 30494.542581860846, 30872.69127308698, 30966.69033309638, 31027.844860775553, 30444.543331849596, 30460.695393045786, 30526.542101868046, 30687.2328191797, 30698.846505767327, 34706.0, 34753.13117172091, 34942.0, 35010.0, 35191.0, 30118.54822177625, 30212.24469388283, 30299.697003029687, 30399.54400684036, 30665.386692266475, 20948.266810661553, 21196.682049769573, 21362.359129226148, 21391.78608213898, 21447.034883430595], "value": 16796.24580220505, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.2625586737244, 580.9419058094188, 586.5395664403443, 595.1816252652605, 602.3614968133777, 22668.319950401474, 23471.178508752197, 23509.529809403823, 23530.76469235307, 23558.5288294234, 24106.0, 25616.0, 26047.348816279555, 26246.868765656192, 26288.342791430223, 6381.744730210798, 6574.309697481767, 6581.506387020969, 6583.473322134242, 6593.637349945751, 6288.434040936315, 6520.771772987946, 6568.573042752229, 6570.342965703439, 6587.736490540373, 6549.672516374186, 6555.344465553454, 6556.541042127053, 6558.639274839882, 6562.44219241365, 6582.506312026593, 6585.670716464206, 6586.077949087132, 6587.736490540373, 6589.802305930806, 5890.499307558863, 6128.38716128388, 6138.7237574309265, 6139.87720245597, 6157.876842463125, 29170.562441563394, 29566.70433295661, 29599.0, 29606.111816645534, 29687.554686679716, 2043.6730123180369, 2070.027087268981, 2070.5444802143656, 2076.5743022680313, 2077.0, 19319.80680193194, 19635.41093767189, 19765.9011704942, 19867.30464433738, 20334.89832550828, 2328.4993726348916, 2341.2390972933863, 2353.2940117964713, 2407.3861165402886, 2412.65016572596, 118016.0, 123629.38185309016, 127216.0, 131444.0, 133324.0, 21188.682169767464, 21226.25708100209, 22366.664500032188, 22600.321990340315, 22789.772102278766, 42525.36211956823, 42564.36153457701, 42602.14795704069, 42676.359854602204, 42731.0, 11634.6509604712, 11812.173147879566, 11864.762704745857, 11870.525178992917, 12220.938895305644, 9914.206863450907, 9966.651167209113, 10077.143442807443, 10085.848712269322, 10101.848472272923, 11527.48126334317, 11546.59586914454, 11567.479463424166, 11702.069158588907, 11743.706407339885, 4027.91944161121, 4171.49942006955, 4257.297545904891, 4400.69195156336, 4413.367054189906, 951.690700522333, 954.5305400057708, 963.643451922793, 966.9468179250209, 984.0651381187901, 19254.133563989373, 19385.321513746952, 19428.708569371473, 19579.510512237022, 20016.399508014783, 1018.9847152292722, 1029.5727273181546, 1033.813913495578, 1034.6016783538241, 1038.693585392311, 10645.627403040857, 10792.730181745363, 10798.892011079946, 10799.946000269949, 10923.836142457869, 472567.0, 478997.0, 481511.0, 481892.0, 492818.0, 107600.4619976895, 109178.45410772895, 111507.4424627888, 111660.44169779262, 112613.0, 1054.5992522841425, 1094.5238821112841, 1141.6004398460473, 1162.8372027916098, 1191.4876603060768, 20926.0, 20962.056707447897, 21008.579828403654, 21023.369298921058, 21031.89484052631, 54458.7277063628, 54605.18092228699, 54788.178177326576, 55205.17192242039, 55707.72146139244, 65716.67141664261, 66787.66606166938, 69722.65138674476, 70850.0, 70920.0, 20368.490787729832, 20543.8972805135, 20670.069846856626, 20775.8961205193, 21109.57780844344, 23230.535389292458, 23342.0, 23361.0, 23688.0, 23785.286441406784, 18611.348602798837, 18659.253629854655, 18902.14940327661, 19014.14436350395, 19036.238550457827, 16442.177891105635, 16546.83453165453, 16557.83442165563, 16908.830911691217, 17201.913990429966, 18982.905085474486, 19259.711104333164, 19330.323438679578, 19435.3197638082, 19436.0, 20180.495487612927, 20253.0, 20267.797322026592, 20346.491337716674, 20470.283540076027, 18413.907930460264, 18580.535486612942, 18581.814181858008, 18763.0, 18768.436946891616], "value": 12871.778729113934, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.1867560787919, 1395.553422904671, 1403.8455769865307, 1404.466302804934, 1406.0930699698692, 15149.166795826226, 15710.528684139466, 15823.97144185627, 15843.0, 15890.0, 15446.0, 15476.226188690576, 15529.922350388233, 15581.220938953036, 15604.375824966988, 2810.8875644974178, 2838.304615369232, 2879.84160871152, 2880.6975267596913, 2888.393437378153, 2770.8476033818233, 2801.3696918193446, 2810.3817160224717, 2812.086072026589, 2812.3531587734833, 2688.1801050679537, 2819.5488721804513, 2880.3663194097267, 2890.3496713239565, 2890.638670166229, 2824.6610406751115, 2824.6751623563346, 2879.337752316958, 2881.7550508206828, 2883.0341835485137, 2776.9028084016963, 2797.510435673749, 2801.831890086581, 2807.298175456136, 2873.9281517962218, 15112.546623601309, 15202.087874727442, 15210.771838422432, 15215.467458639005, 15221.695566088727, 8329.708460203863, 8592.527410992392, 8620.568971551398, 8620.65517379304, 8647.524386158759, 5478.835634930959, 5635.549156067505, 5735.254416925773, 5800.303963524362, 5825.7378417971295, 2001.599680063993, 2007.929722459707, 2034.6134234495398, 2059.5366042640435, 2086.9060892259886, 26960.73039269602, 27154.0, 27806.721932780816, 27821.721782782115, 27831.0, 7579.0, 7670.961645191738, 7708.768736937901, 7897.775844744074, 7942.841143177104, 20979.895100524398, 21018.894905525376, 21034.42241831838, 21035.15859365639, 21063.578728425346, 8527.232549070613, 8608.268297194809, 8645.394822362374, 8647.654093836301, 8648.870266946002, 7532.0, 7672.539647621161, 7715.537067775951, 7808.804779880435, 7813.0, 5750.741216645261, 5866.911996320058, 5918.408159184133, 5978.641281523122, 5994.0, 1833.6516061948187, 1886.7830199526957, 1909.2649330007769, 1915.8658893877296, 1943.8444924406015, 887.573964497045, 902.6750369866843, 917.8760867282965, 921.5944984206927, 934.3506263147184, 7822.256885595859, 7905.288524032865, 7921.920780792234, 7940.602969851484, 7973.441859069925, 678.2335960364757, 687.4775170870174, 695.3984803145242, 695.9930400696029, 699.1540236314116, 5193.480651934777, 5285.1543753000105, 5379.757910894019, 5442.292501974718, 5527.281453411031, 21369.252076177258, 21472.4631884201, 21632.35102946914, 22232.110715571194, 22436.10255589758, 21033.68449473259, 21800.672989905164, 21940.232091876707, 21983.450413739465, 22045.779542204695, 11349.773004539862, 11369.2609980351, 11372.0, 11387.975082242638, 11439.0, 8181.304589109992, 8213.630386632736, 8478.83042339162, 8483.533405662747, 8491.19333663301, 18328.63342733111, 19023.239070437026, 19059.523511911757, 19137.0, 19212.423627291202, 19480.220791168194, 19500.122494488067, 19572.60854782868, 19591.902040490277, 19700.90149549243, 12575.182613130117, 12649.810252846399, 12677.30274834893, 12710.046746493865, 12737.745245095231, 14112.647183820487, 14170.220637865017, 14176.716465670836, 14206.857931420553, 14263.928680356532, 11355.261907975955, 11529.769404611692, 11529.942350288195, 11727.296362218294, 11844.0, 11157.27477713946, 11373.43132843338, 11456.541738330374, 11463.598774042868, 11669.474873630877, 10210.0, 10419.583216671552, 10428.217883658908, 10432.478376081013, 10459.110975566859, 6617.338266173344, 6707.195136583641, 6727.831804204934, 6738.59568425896, 6835.008923705936, 7225.891611625935, 7226.638668066471, 7245.891311630225, 7274.305902077879, 7306.7077316906725], "value": 6913.4788271711295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.04102653209964, 520.7708608212389, 523.9633225674204, 531.0732771314057, 531.5773959702037, 6369.554131210817, 6370.649614271213, 6442.5182208092165, 6455.483561315095, 6455.838604034901, 6248.718807653655, 6284.3087260401435, 6305.590136641115, 6315.273743519485, 6348.873022539547, 4933.531314525115, 5084.3136176616235, 5207.218917162418, 5222.399424066224, 5282.683039017652, 5030.899382012358, 5067.442581316052, 5077.416097148838, 5088.669236499634, 5145.276332428641, 5024.82413115541, 5043.747812609373, 5054.267131265964, 5063.215201643751, 5085.0, 5061.266116413136, 5084.389873215201, 5110.335656364686, 5112.616553758483, 5119.462456442057, 4607.281703794777, 4607.953920460786, 4618.607418369443, 4619.122366750306, 4625.676202665814, 6186.81439556814, 6221.346758590328, 6263.371523403902, 6265.686715664198, 6326.620402775849, 5707.828765137053, 5756.553464777453, 5790.33411157718, 5819.156222347779, 5834.5624078194305, 6540.640264785435, 6555.672736178635, 6612.2726500084955, 6698.866022679519, 6700.430463410616, 4933.210686290176, 4949.950500495021, 4979.925301120486, 5002.474740152305, 5016.824411145629, 6604.50466215031, 6804.183497980224, 6822.795316140524, 6923.619200943946, 7014.859702806018, 5105.8555406729265, 5127.6154288428515, 5134.383873935077, 5137.871553211125, 5142.1772516397195, 5161.922571161435, 5185.611079169077, 5190.351206099238, 5190.858011237598, 5201.609879259071, 5805.593608447452, 5821.18503409523, 5821.854453638608, 5831.446012628793, 5837.941620583825, 6654.467642588678, 6702.290915816533, 6718.529702920749, 6740.292269311652, 6778.3221677831825, 1770.3715181110779, 1779.1104447776113, 1785.8213579037772, 1803.3778346470447, 1804.4316040447218, 1197.199866660304, 1248.4194849395076, 1257.2456526084277, 1258.8867001969866, 1259.5276771210797, 5717.0, 5726.627769194989, 5734.225879506297, 5754.827355179351, 5780.040672139514, 6747.797566073025, 6771.864562708718, 6799.524033317719, 6828.283030281848, 6830.180378354629, 5749.281339832521, 5752.223449834302, 5790.623609465456, 5794.478496935211, 5811.3026436827, 3498.8775392861126, 3544.8404821783083, 3562.91092722684, 3584.4981702561663, 3659.9268014639556, 6294.653794041372, 6384.872302553923, 6422.944657709581, 6527.412532872065, 6532.346765323429, 6786.830329241809, 6880.279930017496, 6927.272636373108, 6953.687084081229, 6957.79126626202, 6390.712417941204, 6391.872162556816, 6423.743050277936, 6481.99529072985, 6520.576162549419, 6598.358403565075, 6656.600603963778, 6668.43318317929, 6717.1267735194115, 6722.529422940347, 6680.766173183915, 6706.765263215764, 6767.25560188369, 6787.185537735306, 6838.965805170942, 6529.0, 6542.149520562297, 6566.0479230510355, 6596.439302659328, 6613.867722645617, 5084.466131056334, 5112.923306150485, 5132.230165475059, 5133.230015497706, 5138.280640710229, 6493.675316234264, 6726.856434406065, 6738.191417029988, 6761.315083279526, 6923.203831559234, 6434.356564343529, 6623.933760662332, 6627.834304142242, 6637.568558043712, 6666.866662666816, 6519.706613202512, 6564.4420224281475, 6602.801915942529, 6608.041833934149, 6620.801375958729, 6279.937200627935, 6379.3301703320485, 6496.278486201255, 6501.512386570931, 6545.705443254969, 6602.613451175115, 6653.500987425866, 6694.732210711517, 6744.629045402354, 6755.459563235027, 6417.935820641734, 6474.417302442803, 6495.870082598416, 6509.0, 6531.444827189742], "value": 5124.784124431639, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.149358855881, 916.408916249019, 929.2240978782712, 932.9906700932988, 943.396226415094, 17873.374431894885, 18106.728399074007, 18265.543361415956, 18279.26882924685, 18281.54296142597, 16333.918330408362, 17001.14994250289, 17043.403480878173, 17064.573385665364, 17091.059991700484, 961.9326647134703, 975.4683697384942, 976.584951395654, 979.5836769373024, 980.0297705271765, 953.2421724728822, 982.3761911186413, 993.4784238274891, 993.508213434351, 995.0248756218909, 1041.1722680469045, 1043.504335440667, 1051.479517638766, 1052.8420736889489, 1053.157474020784, 1034.8033873564036, 1036.8289232276666, 1046.2885238038132, 1050.4695128959827, 1050.6007717067541, 773.2383602151876, 774.5623722596715, 776.1539921485552, 778.0352363069809, 778.9454738168331, 16761.66476670472, 18241.543961400937, 18348.35780747681, 18431.078446077776, 18452.53868653281, 21421.14315427381, 21788.0, 22089.558208835893, 22169.334919952267, 22212.333629991124, 17416.30334786607, 17481.737773933273, 17540.122993850255, 17575.29698812046, 17626.647467050716, 3778.886633401002, 3803.1062700265416, 3806.6764325032404, 3811.542614886204, 3812.7902965336893, 143168.0, 143656.0, 143709.0, 143974.0, 144142.0, 16889.662206755795, 17144.828551714323, 17352.04563749006, 17364.218610162574, 17540.122993850255, 31598.210044748605, 32171.195720107185, 32188.517172242435, 32213.677863221536, 32247.51628725571, 8053.395995300376, 8346.624401901929, 8398.790030249293, 8400.495970241805, 8411.116832732598, 4328.43730315057, 4374.868753937387, 4430.534793846664, 4436.844710435119, 4442.622377097983, 5372.8656783579945, 5504.256925315111, 5540.501354878081, 5565.081761509306, 5590.776368945197, 1008.0776089877826, 1021.9744506387251, 1028.5782829040058, 1039.2050081687514, 1041.7083216699336, 678.8981652752127, 695.2213520856571, 703.8064532253671, 712.056525104239, 716.1263258824226, 11550.711232219262, 11851.585194518151, 12098.516059357704, 12292.078094142797, 12554.874451255553, 685.5578152091972, 687.4672129099888, 701.7614011236102, 702.2485940044104, 707.7310621963724, 5590.608657393944, 5601.60788744784, 5604.6917419542315, 5673.546116310686, 5752.654840709487, 122295.0, 125172.0, 126328.0, 130114.0, 130357.34821325833, 107516.0, 108293.0, 109843.45078274717, 110869.0, 111530.0, 96361.51819240859, 97076.51461742788, 98446.0, 99301.0, 100727.0, 10214.43820589845, 10351.171906247633, 10491.94754026225, 10570.630027948984, 10737.248392612442, 45157.0, 45637.0, 46317.768411157725, 46836.7658161707, 47197.29204062011, 56795.0, 57557.19178252995, 57631.0, 60289.39710602838, 60863.0, 14977.475788347356, 15291.770623440434, 15327.0, 15357.692846143238, 15363.0, 17420.216090276223, 17737.467875963743, 17787.46637600874, 17798.644027119128, 17850.732239016164, 14993.475228366955, 15007.924960375129, 15180.772288415903, 15216.771748424004, 15283.46507872219, 15569.221538923235, 15703.0, 15719.607009824846, 15724.449644262397, 15798.36806527772, 15244.085354878744, 15393.230338483256, 15394.46119385861, 15476.380944762084, 15675.529734107995, 12338.75322493563, 12578.371081445708, 12633.431495582905, 12652.620421387373, 12671.0, 11625.825612615987, 11832.645020649394, 11841.0, 12032.338221397556, 12101.455434505293], "value": 8963.857989359545, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1417.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 107.0, 107.0, 107.0, 108.0, 107.0, 109.0, 106.0, 109.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 127.0, 116.0, 118.0, 117.0, 120.0, 116.0, 123.0, 118.0, 117.0], "value": 118.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 162.0, 164.0, 162.0, 169.0, 166.0, 167.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 74.0, 74.0, 74.0, 73.0, 75.0, 74.0, 74.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 78.0, 80.0, 78.0, 78.0, 80.0, 82.0, 80.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 150.0, 148.0, 148.0, 149.0, 148.0, 149.0, 149.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 93.0, 94.0, 94.0, 94.0, 96.0, 94.0, 95.0, 93.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 54.0, 53.0, 54.0, 55.0, 52.0, 50.0, 51.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 45.0, 38.0, 38.0, 39.0], "value": 38.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 72.0, 74.0, 72.0, 73.0, 74.0, 74.0, 72.0, 73.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 112.0, 112.0, 109.0, 117.0, 115.0, 115.0, 111.0, 109.0], "value": 113.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 169.0, 174.0, 168.0, 169.0, 167.0, 179.0, 173.0, 169.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 66.0, 67.0, 66.0, 71.0, 67.0, 69.0, 65.0, 66.0], "value": 67.6, "unit": "score"}]}]} 18:49:06 INFO - Return code: 0 18:49:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:49:06 INFO - # TBPL SUCCESS # 18:49:06 INFO - Running post-action listener: _package_coverage_data 18:49:06 INFO - Running post-action listener: _resource_record_post_action 18:49:06 INFO - [mozharness: 2017-09-21 01:49:06.945160Z] Finished run-tests step (success) 18:49:06 INFO - Running post-run listener: _resource_record_post_run 18:49:07 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 12288; Write bytes: 345911296; Read time: 492; Write time: 394024 18:49:07 INFO - TinderboxPrint: CPU usage
13.1% 18:49:07 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 492 18:49:07 INFO - TinderboxPrint: I/O write bytes / time
345,911,296 / 394,024 18:49:07 INFO - TinderboxPrint: CPU idle
8,235.1 (86.9%) 18:49:07 INFO - TinderboxPrint: CPU user
1,192.3 (12.6%) 18:49:07 INFO - TinderboxPrint: Swap in / out
0 / 0 18:49:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10850304; Read time: 0; Write time: 1036 18:49:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:49:07 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 335060992; Read time: 476; Write time: 392988 18:49:07 INFO - Running post-run listener: _upload_blobber_files 18:49:07 INFO - Blob upload gear active. 18:49:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:49:07 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 18:49:07 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'] 18:49:07 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 18:49:07 INFO - (blobuploader) - INFO - Open directory for files ... 18:49:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 18:49:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:49:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:49:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 18:49:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:49:08 INFO - (blobuploader) - INFO - Done attempting. 18:49:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:49:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:49:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:49:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:49:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:49:10 INFO - (blobuploader) - INFO - Done attempting. 18:49:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:49:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:49:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:49:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:49:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:49:17 INFO - (blobuploader) - INFO - Done attempting. 18:49:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 18:49:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:49:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:49:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 18:49:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:49:18 INFO - (blobuploader) - INFO - Done attempting. 18:49:18 INFO - (blobuploader) - INFO - Iteration through files over. 18:49:18 INFO - Return code: 0 18:49:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:49:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:49:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be09ff4538c787b28993c7442ba49aa202938374ef916004dc73d4e069230c4a3cedeab75d08e1342cc365d4a0b0f04df3b438f638dd7cb29e0c474c2141c551", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/107cb05fe14919fc5420dc1ca6c15f66e845cf8e17d995cfcce55b947b7fe718d66268e009761d852c18e763656568ccd52d295e37b8f96aff5d4b0df3bc95be", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4720ac83684fab21172bea06f9f4a8df9826eee993fb02398338404938cab37b05a4e6c834f51fa2a61da3e2865d0a77beca162db601e20ccbb0ad83137b3b9f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b0d4653f00c8877e8b03947448e63eaf88435f303a8ea7fe86eb1bbdf2ca166030c61576fcb1e55f5a4a0fa8bb5003b10c33ef0e80e33e3dca66527b7b31ed3"} 18:49:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:49:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:49:18 INFO - Contents: 18:49:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be09ff4538c787b28993c7442ba49aa202938374ef916004dc73d4e069230c4a3cedeab75d08e1342cc365d4a0b0f04df3b438f638dd7cb29e0c474c2141c551", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/107cb05fe14919fc5420dc1ca6c15f66e845cf8e17d995cfcce55b947b7fe718d66268e009761d852c18e763656568ccd52d295e37b8f96aff5d4b0df3bc95be", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4720ac83684fab21172bea06f9f4a8df9826eee993fb02398338404938cab37b05a4e6c834f51fa2a61da3e2865d0a77beca162db601e20ccbb0ad83137b3b9f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b0d4653f00c8877e8b03947448e63eaf88435f303a8ea7fe86eb1bbdf2ca166030c61576fcb1e55f5a4a0fa8bb5003b10c33ef0e80e33e3dca66527b7b31ed3"} 18:49:18 INFO - Running post-run listener: copy_logs_to_upload_dir 18:49:18 INFO - Copying logs to upload dir... 18:49:18 INFO - mkdir: /builds/slave/test/build/upload/logs 18:49:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.822762 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-20 18:49:18.731452) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 18:49:18.739138) ========= 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=836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086 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/be09ff4538c787b28993c7442ba49aa202938374ef916004dc73d4e069230c4a3cedeab75d08e1342cc365d4a0b0f04df3b438f638dd7cb29e0c474c2141c551", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/107cb05fe14919fc5420dc1ca6c15f66e845cf8e17d995cfcce55b947b7fe718d66268e009761d852c18e763656568ccd52d295e37b8f96aff5d4b0df3bc95be", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4720ac83684fab21172bea06f9f4a8df9826eee993fb02398338404938cab37b05a4e6c834f51fa2a61da3e2865d0a77beca162db601e20ccbb0ad83137b3b9f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b0d4653f00c8877e8b03947448e63eaf88435f303a8ea7fe86eb1bbdf2ca166030c61576fcb1e55f5a4a0fa8bb5003b10c33ef0e80e33e3dca66527b7b31ed3"} build_url:https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/YpEoj-OJRvCSQ0IhvHvM7g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be09ff4538c787b28993c7442ba49aa202938374ef916004dc73d4e069230c4a3cedeab75d08e1342cc365d4a0b0f04df3b438f638dd7cb29e0c474c2141c551", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/107cb05fe14919fc5420dc1ca6c15f66e845cf8e17d995cfcce55b947b7fe718d66268e009761d852c18e763656568ccd52d295e37b8f96aff5d4b0df3bc95be", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4720ac83684fab21172bea06f9f4a8df9826eee993fb02398338404938cab37b05a4e6c834f51fa2a61da3e2865d0a77beca162db601e20ccbb0ad83137b3b9f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b0d4653f00c8877e8b03947448e63eaf88435f303a8ea7fe86eb1bbdf2ca166030c61576fcb1e55f5a4a0fa8bb5003b10c33ef0e80e33e3dca66527b7b31ed3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 18:49:18.770445) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:49:18.770841) ========= 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=836cfdc75598d54cb747368e000001a9-1505957314.684505-344383086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:49:18.852605) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 18:49:18.855936) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 18:49:18.856267) ========= ========= Total master_lag: 0.28 =========