builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-068 starttime: 1505298028.51 results: success (0) revision: 9873269746359dbcccbd5b44f0e82c0225289945 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.510469) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.510899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.511442) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.627136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.627378) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 03:20:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.6M=0s 2017-09-13 03:20:28 (41.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116466 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.762055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.762337) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015930 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.830439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-09-13 03:20:28.830732) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9873269746359dbcccbd5b44f0e82c0225289945 --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 9873269746359dbcccbd5b44f0e82c0225289945 --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=97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 03:20:28,891 truncating revision to first 12 chars 2017-09-13 03:20:28,891 Setting DEBUG logging. 2017-09-13 03:20:28,891 attempt 1/10 2017-09-13 03:20:28,891 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/987326974635?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 03:20:30,722 unpacking tar archive at: mozilla-central-987326974635/testing/mozharness/ program finished with exit code 0 elapsedTime=2.098329 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-09-13 03:20:30.953041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:30.953354) ========= script_repo_revision: 9873269746359dbcccbd5b44f0e82c0225289945 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:30.953715) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:30.954003) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:30.966633) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-13 03:20:30.967044) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:20:31 INFO - MultiFileLogger online at 20170913 03:20:31 in /builds/slave/test 03:20:31 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 03:20:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:31 INFO - {'append_to_log': False, 03:20:31 INFO - 'base_work_dir': '/builds/slave/test', 03:20:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:20:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:31 INFO - 'branch': 'Firefox-Non-PGO', 03:20:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:31 INFO - 'code_coverage': False, 03:20:31 INFO - 'config_files': ('talos/linux_config.py',), 03:20:31 INFO - 'default_actions': ('clobber', 03:20:31 INFO - 'read-buildbot-config', 03:20:31 INFO - 'download-and-extract', 03:20:31 INFO - 'populate-webroot', 03:20:31 INFO - 'create-virtualenv', 03:20:31 INFO - 'install', 03:20:31 INFO - 'setup-mitmproxy', 03:20:31 INFO - 'run-tests'), 03:20:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:31 INFO - 'disable_ccov_upload': False, 03:20:31 INFO - 'disable_stylo': False, 03:20:31 INFO - 'download_minidump_stackwalk': True, 03:20:31 INFO - 'download_symbols': 'ondemand', 03:20:31 INFO - 'enable_stylo': False, 03:20:31 INFO - 'enable_webrender': False, 03:20:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:20:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:31 INFO - 'gecko_profile': False, 03:20:31 INFO - 'gecko_profile_interval': 0, 03:20:31 INFO - 'installer_path': 'installer.exe', 03:20:31 INFO - 'log_level': 'info', 03:20:31 INFO - 'log_name': 'talos', 03:20:31 INFO - 'log_to_console': True, 03:20:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:20:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:20:31 INFO - 'opt_config_files': (), 03:20:31 INFO - 'pip_index': False, 03:20:31 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:20:31 INFO - 'system_bits': '32', 03:20:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:31 INFO - 'title': 'talos-linux64-ix-068', 03:20:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:31 INFO - 'use_talos_json': True, 03:20:31 INFO - 'verify': 'False', 03:20:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:31 INFO - 'work_dir': 'build'} 03:20:31 INFO - [mozharness: 2017-09-13 10:20:31.165614Z] Running clobber step. 03:20:31 INFO - Running pre-action listener: _resource_record_pre_action 03:20:31 INFO - Running main action method: clobber 03:20:31 INFO - rmtree: /builds/slave/test/build 03:20:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:32 INFO - Running post-action listener: _resource_record_post_action 03:20:32 INFO - [mozharness: 2017-09-13 10:20:32.677995Z] Finished clobber step (success) 03:20:32 INFO - [mozharness: 2017-09-13 10:20:32.678093Z] Running read-buildbot-config step. 03:20:32 INFO - Running pre-action listener: _resource_record_pre_action 03:20:32 INFO - Running main action method: read_buildbot_config 03:20:32 INFO - Using buildbot properties: 03:20:32 INFO - { 03:20:32 INFO - "project": "", 03:20:32 INFO - "product": "firefox", 03:20:32 INFO - "who": "archaeopteryx@coole-files.de", 03:20:32 INFO - "installer_path": "public/build/target.tar.bz2", 03:20:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:20:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:20:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:20:32 INFO - "stage_platform": "linux64", 03:20:32 INFO - "basedir": "/builds/slave/test", 03:20:32 INFO - "buildnumber": 15, 03:20:32 INFO - "platform": "ubuntu64_hw", 03:20:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:20:32 INFO - "slavebuilddir": "test", 03:20:32 INFO - "taskId": "UXCqJZAZS7KfV5YduBPThQ", 03:20:32 INFO - "branch": "mozilla-central", 03:20:32 INFO - "script_repo_revision": "production", 03:20:32 INFO - "revision": "9873269746359dbcccbd5b44f0e82c0225289945", 03:20:32 INFO - "slavename": "talos-linux64-ix-068", 03:20:32 INFO - "repo_path": "mozilla-central" 03:20:32 INFO - } 03:20:32 INFO - Finding installer, test and symbols from parent task. 03:20:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UXCqJZAZS7KfV5YduBPThQ'}, attempt #1 03:20:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UXCqJZAZS7KfV5YduBPThQ'}, attempt #1 03:20:33 INFO - Task dependencies: TFFNhlJXQAqdPaYDbVW9jw 03:20:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw'}, attempt #1 03:20:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2 03:20:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.test_packages.json 03:20:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.crashreporter-symbols.zip 03:20:34 INFO - Running post-action listener: _resource_record_post_action 03:20:34 INFO - [mozharness: 2017-09-13 10:20:34.022573Z] Finished read-buildbot-config step (success) 03:20:34 INFO - [mozharness: 2017-09-13 10:20:34.022794Z] Running download-and-extract step. 03:20:34 INFO - Running pre-action listener: _resource_record_pre_action 03:20:34 INFO - Running main action method: download_and_extract 03:20:34 INFO - mkdir: /builds/slave/test/build/tests 03:20:34 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')]} 03:20:34 INFO - trying https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.test_packages.json 03:20:34 INFO - Downloading https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:20:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:20:34 INFO - Downloaded 989 bytes. 03:20:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:20:34 INFO - Using the following test package requirements: 03:20:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:20:34 INFO - u'common': [u'target.common.tests.zip'], 03:20:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:20:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:20:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:20:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:20:34 INFO - u'mozbase': [u'target.common.tests.zip'], 03:20:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:20:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:20:34 INFO - u'web-platform': [u'target.common.tests.zip', 03:20:34 INFO - u'target.web-platform.tests.tar.gz'], 03:20:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:20:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:20:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.common.tests.zip 03:20:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:20:34 INFO - Fetch https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.common.tests.zip into memory 03:20:36 INFO - Content-Length response header: 54557149 03:20:36 INFO - Bytes received: 54557149 03:20:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.talos.tests.zip 03:20:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:20:46 INFO - Fetch https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.talos.tests.zip into memory 03:20:48 INFO - Content-Length response header: 14499226 03:20:48 INFO - Bytes received: 14499226 03:20:48 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')]} 03:20:48 INFO - trying https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2 03:20:48 INFO - Downloading https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:20:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:20:52 INFO - Downloaded 61556491 bytes. 03:20:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2 03:20:52 INFO - mkdir: /builds/slave/test/properties 03:20:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:20:52 INFO - Writing to file /builds/slave/test/properties/build_url 03:20:52 INFO - Contents: 03:20:52 INFO - build_url:https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2 03:20:52 INFO - Running post-action listener: _resource_record_post_action 03:20:52 INFO - Running post-action listener: find_tests_for_verification 03:20:52 INFO - Running post-action listener: set_extra_try_arguments 03:20:52 INFO - [mozharness: 2017-09-13 10:20:52.514415Z] Finished download-and-extract step (success) 03:20:52 INFO - [mozharness: 2017-09-13 10:20:52.514645Z] Running populate-webroot step. 03:20:52 INFO - Running pre-action listener: _resource_record_pre_action 03:20:52 INFO - Running main action method: populate_webroot 03:20:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:20:52 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['tresize', 03:20:52 INFO - 'tcanvasmark']}, 03:20:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:20:52 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['dromaeo_css', 03:20:52 INFO - 'kraken']}, 03:20:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:52 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'tests': ['damp', 'tps']}, 03:20:52 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['damp', 'tps']}, 03:20:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:20:52 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['dromaeo_dom']}, 03:20:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:20:52 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['basic_compositor_video', 03:20:52 INFO - 'glvideo']}, 03:20:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:20:52 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['ts_paint_webext', 03:20:52 INFO - 'tp5o_webext']}, 03:20:52 INFO - 'other-e10s': {'tests': ['a11yr', 03:20:52 INFO - 'ts_paint', 03:20:52 INFO - 'tpaint', 03:20:52 INFO - 'sessionrestore', 03:20:52 INFO - 'sessionrestore_many_windows', 03:20:52 INFO - 'sessionrestore_no_auto_restore', 03:20:52 INFO - 'tabpaint']}, 03:20:52 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['a11yr', 03:20:52 INFO - 'ts_paint', 03:20:52 INFO - 'tpaint', 03:20:52 INFO - 'sessionrestore', 03:20:52 INFO - 'sessionrestore_many_windows', 03:20:52 INFO - 'sessionrestore_no_auto_restore', 03:20:52 INFO - 'tabpaint']}, 03:20:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:20:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:20:52 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['bloom_basic_singleton']}, 03:20:52 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['bloom_basic']}, 03:20:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:20:52 INFO - 'tsvgr_opacity', 03:20:52 INFO - 'tart', 03:20:52 INFO - 'tscrollx', 03:20:52 INFO - 'tsvg_static']}, 03:20:52 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['tsvgx', 03:20:52 INFO - 'tsvgr_opacity', 03:20:52 INFO - 'tart', 03:20:52 INFO - 'tscrollx', 03:20:52 INFO - 'tsvg_static']}, 03:20:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:20:52 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['tp5o']}, 03:20:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:52 INFO - 'talos_options': ['--mitmproxy', 03:20:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:52 INFO - '--firstNonBlankPaint'], 03:20:52 INFO - 'tests': ['tp6_google', 03:20:52 INFO - 'tp6_youtube', 03:20:52 INFO - 'tp6_amazon', 03:20:52 INFO - 'tp6_facebook']}, 03:20:52 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:52 INFO - 'talos_options': ['--disable-stylo', 03:20:52 INFO - '--mitmproxy', 03:20:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:52 INFO - '--firstNonBlankPaint'], 03:20:52 INFO - 'tests': ['tp6_google', 03:20:52 INFO - 'tp6_youtube', 03:20:52 INFO - 'tp6_amazon', 03:20:52 INFO - 'tp6_facebook']}, 03:20:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:52 INFO - 'talos_options': ['--stylo-threads=1', 03:20:52 INFO - '--mitmproxy', 03:20:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:52 INFO - '--firstNonBlankPaint'], 03:20:52 INFO - 'tests': ['tp6_google', 03:20:52 INFO - 'tp6_youtube', 03:20:52 INFO - 'tp6_amazon', 03:20:52 INFO - 'tp6_facebook']}, 03:20:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'talos_options': ['--xperf_path', 03:20:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:52 INFO - 'tests': ['tp5n']}, 03:20:52 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'talos_options': ['--disable-stylo', 03:20:52 INFO - '--xperf_path', 03:20:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:52 INFO - 'tests': ['tp5n']}}} 03:20:52 INFO - Running post-action listener: _resource_record_post_action 03:20:52 INFO - [mozharness: 2017-09-13 10:20:52.533802Z] Finished populate-webroot step (success) 03:20:52 INFO - [mozharness: 2017-09-13 10:20:52.533892Z] Running create-virtualenv step. 03:20:52 INFO - Running pre-action listener: _resource_record_pre_action 03:20:52 INFO - Running main action method: create_virtualenv 03:20:52 INFO - Creating virtualenv /builds/slave/test/build/venv 03:20:52 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:20:52 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:20:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:20:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:20:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:20:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:20:53 INFO - Installing pip...............done. 03:20:53 INFO - Return code: 0 03:20:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:20:53 INFO - Reading from file tmpfile_stdout 03:20:53 INFO - Output received: 03:20:53 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:20:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:53 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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f0090>, '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 0x11f0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eaf90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', '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 03:20:53 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 03:20:53 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 03:20:53 INFO - Using env: {'DISPLAY': ':0', 03:20:53 INFO - 'HOME': '/home/cltbld', 03:20:53 INFO - 'LANG': 'en_US.UTF-8', 03:20:53 INFO - 'LANGUAGE': 'en_US:en', 03:20:53 INFO - 'LOGNAME': 'cltbld', 03:20:53 INFO - 'MAIL': '/var/mail/cltbld', 03:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:53 INFO - 'MOZ_NO_REMOTE': '1', 03:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:53 INFO - 'NO_EM_RESTART': '1', 03:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:53 INFO - 'PWD': '/builds/slave/test', 03:20:53 INFO - 'SHELL': '/bin/bash', 03:20:53 INFO - 'SHLVL': '1', 03:20:53 INFO - 'TERM': 'linux', 03:20:53 INFO - 'TMOUT': '86400', 03:20:53 INFO - 'USER': 'cltbld', 03:20:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', 03:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:53 INFO - '_': '/tools/buildbot/bin/python'} 03:20:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:20:55 INFO - Downloading/unpacking pip>=1.5 03:20:55 INFO - Running setup.py egg_info for package pip 03:20:55 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:55 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:55 INFO - Installing collected packages: pip 03:20:55 INFO - Found existing installation: pip 1.1 03:20:55 INFO - Uninstalling pip: 03:20:55 INFO - Successfully uninstalled pip 03:20:55 INFO - Running setup.py install for pip 03:20:55 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:55 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:20:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:20:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:20:55 INFO - Successfully installed pip 03:20:55 INFO - Cleaning up... 03:20:55 INFO - Return code: 0 03:20:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f0090>, '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 0x11f0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eaf90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', '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 03:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:20:55 INFO - Using env: {'DISPLAY': ':0', 03:20:55 INFO - 'HOME': '/home/cltbld', 03:20:55 INFO - 'LANG': 'en_US.UTF-8', 03:20:55 INFO - 'LANGUAGE': 'en_US:en', 03:20:55 INFO - 'LOGNAME': 'cltbld', 03:20:55 INFO - 'MAIL': '/var/mail/cltbld', 03:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:55 INFO - 'MOZ_NO_REMOTE': '1', 03:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:55 INFO - 'NO_EM_RESTART': '1', 03:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:55 INFO - 'PWD': '/builds/slave/test', 03:20:55 INFO - 'SHELL': '/bin/bash', 03:20:55 INFO - 'SHLVL': '1', 03:20:55 INFO - 'TERM': 'linux', 03:20:55 INFO - 'TMOUT': '86400', 03:20:55 INFO - 'USER': 'cltbld', 03:20:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', 03:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:55 INFO - '_': '/tools/buildbot/bin/python'} 03:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:55 INFO - Downloading/unpacking psutil>=3.1.1 03:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:20:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:57 INFO - Installing collected packages: psutil 03:20:57 INFO - Running setup.py install for psutil 03:20:57 INFO - building 'psutil._psutil_linux' extension 03:20: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 03:20: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 03:20:57 INFO - building 'psutil._psutil_posix' extension 03:20:57 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 03:20: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:20:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:57 INFO - Successfully installed psutil 03:20:57 INFO - Cleaning up... 03:20:57 INFO - Return code: 0 03:20:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f0090>, '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 0x11f0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eaf90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', '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 03:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:20:57 INFO - Using env: {'DISPLAY': ':0', 03:20:57 INFO - 'HOME': '/home/cltbld', 03:20:57 INFO - 'LANG': 'en_US.UTF-8', 03:20:57 INFO - 'LANGUAGE': 'en_US:en', 03:20:57 INFO - 'LOGNAME': 'cltbld', 03:20:57 INFO - 'MAIL': '/var/mail/cltbld', 03:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:57 INFO - 'MOZ_NO_REMOTE': '1', 03:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:57 INFO - 'NO_EM_RESTART': '1', 03:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:57 INFO - 'PWD': '/builds/slave/test', 03:20:57 INFO - 'SHELL': '/bin/bash', 03:20:57 INFO - 'SHLVL': '1', 03:20:57 INFO - 'TERM': 'linux', 03:20:57 INFO - 'TMOUT': '86400', 03:20:57 INFO - 'USER': 'cltbld', 03:20:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', 03:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:57 INFO - '_': '/tools/buildbot/bin/python'} 03:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:20:59 INFO - Installing collected packages: mozsystemmonitor 03:20:59 INFO - Running setup.py install for mozsystemmonitor 03:20:59 INFO - Successfully installed mozsystemmonitor 03:20:59 INFO - Cleaning up... 03:20:59 INFO - Return code: 0 03:20:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f0090>, '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 0x11f0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eaf90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', '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 03:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:20:59 INFO - Using env: {'DISPLAY': ':0', 03:20:59 INFO - 'HOME': '/home/cltbld', 03:20:59 INFO - 'LANG': 'en_US.UTF-8', 03:20:59 INFO - 'LANGUAGE': 'en_US:en', 03:20:59 INFO - 'LOGNAME': 'cltbld', 03:20:59 INFO - 'MAIL': '/var/mail/cltbld', 03:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:59 INFO - 'MOZ_NO_REMOTE': '1', 03:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:59 INFO - 'NO_EM_RESTART': '1', 03:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:59 INFO - 'PWD': '/builds/slave/test', 03:20:59 INFO - 'SHELL': '/bin/bash', 03:20:59 INFO - 'SHLVL': '1', 03:20:59 INFO - 'TERM': 'linux', 03:20:59 INFO - 'TMOUT': '86400', 03:20:59 INFO - 'USER': 'cltbld', 03:20:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', 03:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:59 INFO - '_': '/tools/buildbot/bin/python'} 03:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:59 INFO - Downloading/unpacking jsonschema==2.5.1 03:20:59 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 03:20:59 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 03:20:59 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 03:20:59 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 03:21:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:21:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:21:00 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 03:21:00 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 03:21:00 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 03:21:00 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 03:21:00 INFO - Downloading functools32-3.2.3-2.tar.gz 03:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:21:00 INFO - warning: no files found matching '*.txt' 03:21:00 INFO - no previously-included directories found matching 'build' 03:21:00 INFO - no previously-included directories found matching 'dist' 03:21:00 INFO - no previously-included directories found matching '.git*' 03:21:00 INFO - Installing collected packages: jsonschema, functools32 03:21:00 INFO - Running setup.py install for functools32 03:21:00 INFO - warning: no files found matching '*.txt' 03:21:00 INFO - no previously-included directories found matching 'build' 03:21:00 INFO - no previously-included directories found matching 'dist' 03:21:00 INFO - no previously-included directories found matching '.git*' 03:21:00 INFO - Successfully installed jsonschema functools32 03:21:00 INFO - Cleaning up... 03:21:01 INFO - Return code: 0 03:21:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:21:01 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')]} 03:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:01 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')]} 03:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:01 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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f0090>, '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 0x11f0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eaf90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', '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 03:21:01 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 03:21:01 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 03:21:01 INFO - Using env: {'DISPLAY': ':0', 03:21:01 INFO - 'HOME': '/home/cltbld', 03:21:01 INFO - 'LANG': 'en_US.UTF-8', 03:21:01 INFO - 'LANGUAGE': 'en_US:en', 03:21:01 INFO - 'LOGNAME': 'cltbld', 03:21:01 INFO - 'MAIL': '/var/mail/cltbld', 03:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:01 INFO - 'MOZ_NO_REMOTE': '1', 03:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:01 INFO - 'NO_EM_RESTART': '1', 03:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:01 INFO - 'PWD': '/builds/slave/test', 03:21:01 INFO - 'SHELL': '/bin/bash', 03:21:01 INFO - 'SHLVL': '1', 03:21:01 INFO - 'TERM': 'linux', 03:21:01 INFO - 'TMOUT': '86400', 03:21:01 INFO - 'USER': 'cltbld', 03:21:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', 03:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:01 INFO - '_': '/tools/buildbot/bin/python'} 03:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:21:01 INFO - Cleaning up... 03:21:01 INFO - Return code: 0 03:21:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:21:01 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')]} 03:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:01 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')]} 03:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:01 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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f0090>, '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 0x11f0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eaf90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', '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 03:21:01 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 03:21:01 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 03:21:01 INFO - Using env: {'DISPLAY': ':0', 03:21:01 INFO - 'HOME': '/home/cltbld', 03:21:01 INFO - 'LANG': 'en_US.UTF-8', 03:21:01 INFO - 'LANGUAGE': 'en_US:en', 03:21:01 INFO - 'LOGNAME': 'cltbld', 03:21:01 INFO - 'MAIL': '/var/mail/cltbld', 03:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:01 INFO - 'MOZ_NO_REMOTE': '1', 03:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:01 INFO - 'NO_EM_RESTART': '1', 03:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:01 INFO - 'PWD': '/builds/slave/test', 03:21:01 INFO - 'SHELL': '/bin/bash', 03:21:01 INFO - 'SHLVL': '1', 03:21:01 INFO - 'TERM': 'linux', 03:21:01 INFO - 'TMOUT': '86400', 03:21:01 INFO - 'USER': 'cltbld', 03:21:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', 03:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:01 INFO - '_': '/tools/buildbot/bin/python'} 03:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:21: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 03:21: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 03:21: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 03:21: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 03:21:02 INFO - Downloading blobuploader-1.2.4.tar.gz 03:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:21:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:21: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 03:21: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 03:21: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 03:21: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 03:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:21:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21: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 03:21: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 03:21: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 03:21: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 03:21:03 INFO - Downloading docopt-0.6.1.tar.gz 03:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:03 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:03 INFO - Running setup.py install for blobuploader 03:21:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:21:03 INFO - Running setup.py install for requests 03:21:03 INFO - Running setup.py install for docopt 03:21:03 INFO - Successfully installed blobuploader requests docopt 03:21:03 INFO - Cleaning up... 03:21:03 INFO - Return code: 0 03:21:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21: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')]} 03:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21: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')]} 03:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:03 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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f0090>, '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 0x11f0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eaf90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', '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 03:21:03 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 03:21:03 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 03:21:03 INFO - Using env: {'DISPLAY': ':0', 03:21:03 INFO - 'HOME': '/home/cltbld', 03:21:03 INFO - 'LANG': 'en_US.UTF-8', 03:21:03 INFO - 'LANGUAGE': 'en_US:en', 03:21:03 INFO - 'LOGNAME': 'cltbld', 03:21:03 INFO - 'MAIL': '/var/mail/cltbld', 03:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:03 INFO - 'MOZ_NO_REMOTE': '1', 03:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:03 INFO - 'NO_EM_RESTART': '1', 03:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:03 INFO - 'PWD': '/builds/slave/test', 03:21:03 INFO - 'SHELL': '/bin/bash', 03:21:03 INFO - 'SHLVL': '1', 03:21:03 INFO - 'TERM': 'linux', 03:21:03 INFO - 'TMOUT': '86400', 03:21:03 INFO - 'USER': 'cltbld', 03:21:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', 03:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:03 INFO - '_': '/tools/buildbot/bin/python'} 03:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:03 INFO - Running setup.py (path:/tmp/pip-NVzWP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:04 INFO - Running setup.py (path:/tmp/pip-xCN9x4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:04 INFO - Running setup.py (path:/tmp/pip-g2BqPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:04 INFO - Running setup.py (path:/tmp/pip-QT8Yjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:04 INFO - Running setup.py (path:/tmp/pip-lLpHec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:04 INFO - Running setup.py (path:/tmp/pip-bVd_G4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:04 INFO - Running setup.py (path:/tmp/pip-F63AvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:04 INFO - Running setup.py (path:/tmp/pip-_QYZUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:04 INFO - Running setup.py (path:/tmp/pip-V3BpRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:04 INFO - Running setup.py (path:/tmp/pip-bQ2JQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:04 INFO - Running setup.py (path:/tmp/pip-gC4ErQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:04 INFO - Running setup.py (path:/tmp/pip-63rRVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:04 INFO - Running setup.py (path:/tmp/pip-4NXdbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:04 INFO - Running setup.py (path:/tmp/pip-EzBH_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:04 INFO - Running setup.py (path:/tmp/pip-zl8XU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:05 INFO - Running setup.py (path:/tmp/pip-ZPMyL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:05 INFO - Running setup.py (path:/tmp/pip-AsvCEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:05 INFO - Running setup.py install for manifestparser 03:21:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:05 INFO - Running setup.py install for mozcrash 03:21:05 INFO - Running setup.py install for mozdebug 03:21:05 INFO - Running setup.py install for mozdevice 03:21:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:21:05 INFO - Running setup.py install for mozfile 03:21:05 INFO - Running setup.py install for mozhttpd 03:21:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:21:05 INFO - Running setup.py install for mozinfo 03:21:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:21:05 INFO - Running setup.py install for mozInstall 03:21:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:05 INFO - Running setup.py install for mozleak 03:21:06 INFO - Running setup.py install for mozlog 03:21:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Running setup.py install for moznetwork 03:21:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Running setup.py install for mozprocess 03:21:06 INFO - Running setup.py install for mozprofile 03:21:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Running setup.py install for mozrunner 03:21:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Running setup.py install for mozscreenshot 03:21:06 INFO - Running setup.py install for moztest 03:21:06 INFO - Running setup.py install for mozversion 03:21:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:06 INFO - Cleaning up... 03:21:06 INFO - Return code: 0 03:21:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:06 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')]} 03:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:06 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')]} 03:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:06 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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f0090>, '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 0x11f0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eaf90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', '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 03:21:06 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 03:21:06 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 03:21:06 INFO - Using env: {'DISPLAY': ':0', 03:21:06 INFO - 'HOME': '/home/cltbld', 03:21:06 INFO - 'LANG': 'en_US.UTF-8', 03:21:06 INFO - 'LANGUAGE': 'en_US:en', 03:21:06 INFO - 'LOGNAME': 'cltbld', 03:21:06 INFO - 'MAIL': '/var/mail/cltbld', 03:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:06 INFO - 'MOZ_NO_REMOTE': '1', 03:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:06 INFO - 'NO_EM_RESTART': '1', 03:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:06 INFO - 'PWD': '/builds/slave/test', 03:21:06 INFO - 'SHELL': '/bin/bash', 03:21:06 INFO - 'SHLVL': '1', 03:21:06 INFO - 'TERM': 'linux', 03:21:06 INFO - 'TMOUT': '86400', 03:21:06 INFO - 'USER': 'cltbld', 03:21:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', 03:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:06 INFO - '_': '/tools/buildbot/bin/python'} 03:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:07 INFO - Running setup.py (path:/tmp/pip-bmgojj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:07 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)) 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:07 INFO - Running setup.py (path:/tmp/pip-WxvVmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:07 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)) 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:07 INFO - Running setup.py (path:/tmp/pip-rmI6aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:07 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)) 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:07 INFO - Running setup.py (path:/tmp/pip-FYYUpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:07 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)) 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:07 INFO - Running setup.py (path:/tmp/pip-pvXYK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:07 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)) 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:07 INFO - Running setup.py (path:/tmp/pip-LFS0km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:07 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)) 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:07 INFO - Running setup.py (path:/tmp/pip-PObTPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:07 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)) 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:07 INFO - Running setup.py (path:/tmp/pip-QaAFCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:07 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)) 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:07 INFO - Running setup.py (path:/tmp/pip-EJbBFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:07 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)) 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:07 INFO - Running setup.py (path:/tmp/pip-9M3QPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:07 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)) 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:07 INFO - Running setup.py (path:/tmp/pip-U13xOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:07 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)) 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:07 INFO - Running setup.py (path:/tmp/pip-7dA5pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:08 INFO - Running setup.py (path:/tmp/pip-qdPCMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:08 INFO - Running setup.py (path:/tmp/pip-xDLROE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:08 INFO - Running setup.py (path:/tmp/pip-vr5Zyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:08 INFO - Running setup.py (path:/tmp/pip-bssm0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:08 INFO - Running setup.py (path:/tmp/pip-Ms9jaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:08 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)) 03:21:08 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)) 03:21:08 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)) 03:21:08 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)) 03:21:08 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)) 03:21:08 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)) 03:21:08 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)) 03:21:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:08 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 03:21:08 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 03:21:08 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 03:21:08 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 03:21:09 INFO - Downloading blessings-1.6.tar.gz 03:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:21:09 INFO - Installing collected packages: blessings 03:21:09 INFO - Running setup.py install for blessings 03:21:09 INFO - Successfully installed blessings 03:21:09 INFO - Cleaning up... 03:21:09 INFO - Return code: 0 03:21:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:21:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:09 INFO - Reading from file tmpfile_stdout 03:21:09 INFO - Current package versions: 03:21:09 INFO - argparse == 1.2.1 03:21:09 INFO - blessings == 1.6 03:21:09 INFO - blobuploader == 1.2.4 03:21:09 INFO - docopt == 0.6.1 03:21:09 INFO - functools32 == 3.2.3-2 03:21:09 INFO - jsonschema == 2.5.1 03:21:09 INFO - manifestparser == 1.1 03:21:09 INFO - mozInstall == 1.13 03:21:09 INFO - mozcrash == 1.0 03:21:09 INFO - mozdebug == 0.1 03:21:09 INFO - mozdevice == 0.51 03:21:09 INFO - mozfile == 1.2 03:21:09 INFO - mozhttpd == 0.7 03:21:09 INFO - mozinfo == 0.10 03:21:09 INFO - mozleak == 0.1 03:21:09 INFO - mozlog == 3.5 03:21:09 INFO - moznetwork == 0.27 03:21:09 INFO - mozprocess == 0.25 03:21:09 INFO - mozprofile == 0.28 03:21:09 INFO - mozrunner == 6.13 03:21:09 INFO - mozscreenshot == 0.1 03:21:09 INFO - mozsystemmonitor == 0.3 03:21:09 INFO - moztest == 0.8 03:21:09 INFO - mozversion == 1.4 03:21:09 INFO - psutil == 3.1.1 03:21:09 INFO - requests == 1.2.3 03:21:09 INFO - wsgiref == 0.1.2 03:21:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:09 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')]} 03:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:09 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')]} 03:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:09 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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f0090>, '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 0x11f0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eaf90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', '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 03:21:09 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 03:21:09 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 03:21:09 INFO - Using env: {'DISPLAY': ':0', 03:21:09 INFO - 'HOME': '/home/cltbld', 03:21:09 INFO - 'LANG': 'en_US.UTF-8', 03:21:09 INFO - 'LANGUAGE': 'en_US:en', 03:21:09 INFO - 'LOGNAME': 'cltbld', 03:21:09 INFO - 'MAIL': '/var/mail/cltbld', 03:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:09 INFO - 'MOZ_NO_REMOTE': '1', 03:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:09 INFO - 'NO_EM_RESTART': '1', 03:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:09 INFO - 'PWD': '/builds/slave/test', 03:21:09 INFO - 'SHELL': '/bin/bash', 03:21:09 INFO - 'SHLVL': '1', 03:21:09 INFO - 'TERM': 'linux', 03:21:09 INFO - 'TMOUT': '86400', 03:21:09 INFO - 'USER': 'cltbld', 03:21:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', 03:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:09 INFO - '_': '/tools/buildbot/bin/python'} 03:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:10 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)) 03:21:10 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)) 03:21:10 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)) 03:21:10 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)) 03:21:10 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)) 03:21:10 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)) 03:21:10 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)) 03:21:10 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)) 03:21:10 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)) 03:21:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:21:10 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 03:21:10 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 03:21:10 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 03:21:10 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 03:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:21:11 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)) 03:21:11 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)) 03:21:11 INFO - Installing collected packages: simplejson 03:21:11 INFO - Running setup.py install for simplejson 03:21:11 INFO - building 'simplejson._speedups' extension 03:21:11 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 03:21:12 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 03:21:12 INFO - Successfully installed simplejson 03:21:12 INFO - Cleaning up... 03:21:12 INFO - Return code: 0 03:21:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:21:12 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')]} 03:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:12 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')]} 03:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:12 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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f0090>, '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 0x11f0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eaf90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', '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 03:21:12 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 03:21:12 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 03:21:12 INFO - Using env: {'DISPLAY': ':0', 03:21:12 INFO - 'HOME': '/home/cltbld', 03:21:12 INFO - 'LANG': 'en_US.UTF-8', 03:21:12 INFO - 'LANGUAGE': 'en_US:en', 03:21:12 INFO - 'LOGNAME': 'cltbld', 03:21:12 INFO - 'MAIL': '/var/mail/cltbld', 03:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:12 INFO - 'MOZ_NO_REMOTE': '1', 03:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:12 INFO - 'NO_EM_RESTART': '1', 03:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:12 INFO - 'PWD': '/builds/slave/test', 03:21:12 INFO - 'SHELL': '/bin/bash', 03:21:12 INFO - 'SHLVL': '1', 03:21:12 INFO - 'TERM': 'linux', 03:21:12 INFO - 'TMOUT': '86400', 03:21:12 INFO - 'USER': 'cltbld', 03:21:12 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', 03:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:12 INFO - '_': '/tools/buildbot/bin/python'} 03:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:21:12 INFO - Cleaning up... 03:21:12 INFO - Return code: 0 03:21:12 INFO - Running post-action listener: _resource_record_post_action 03:21:12 INFO - Running post-action listener: _start_resource_monitoring 03:21:12 INFO - Starting resource monitoring. 03:21:12 INFO - [mozharness: 2017-09-13 10:21:12.672698Z] Finished create-virtualenv step (success) 03:21:12 INFO - [mozharness: 2017-09-13 10:21:12.673282Z] Running install step. 03:21:12 INFO - Running pre-action listener: _resource_record_pre_action 03:21:12 INFO - Running main action method: install 03:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:12 INFO - Reading from file tmpfile_stdout 03:21:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:21:13 INFO - Reading from file tmpfile_stdout 03:21:13 INFO - Output received: 03:21:13 INFO - Usage: mozinstall [options] installer 03:21:13 INFO - Options: 03:21:13 INFO - -h, --help show this help message and exit 03:21:13 INFO - -d DEST, --destination=DEST 03:21:13 INFO - Directory to install application into. [default: 03:21:13 INFO - "/builds/slave/test"] 03:21:13 INFO - --app=APP Application being installed. [default: firefox] 03:21:13 INFO - mkdir: /builds/slave/test/build/application 03:21:13 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'] 03:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:21:30 INFO - Reading from file tmpfile_stdout 03:21:30 INFO - Output received: 03:21:30 INFO - /builds/slave/test/build/application/firefox/firefox 03:21:30 INFO - Running post-action listener: _resource_record_post_action 03:21:30 INFO - [mozharness: 2017-09-13 10:21:30.806698Z] Finished install step (success) 03:21:30 INFO - [mozharness: 2017-09-13 10:21:30.806948Z] Running setup-mitmproxy step. 03:21:30 INFO - Running pre-action listener: _resource_record_pre_action 03:21:30 INFO - Running main action method: setup_mitmproxy 03:21:30 INFO - Skipping: mitmproxy is not required 03:21:30 INFO - Running post-action listener: _resource_record_post_action 03:21:30 INFO - [mozharness: 2017-09-13 10:21:30.808080Z] Finished setup-mitmproxy step (success) 03:21:30 INFO - [mozharness: 2017-09-13 10:21:30.808300Z] Running run-tests step. 03:21:30 INFO - Running pre-action listener: _resource_record_pre_action 03:21:30 INFO - Running pre-action listener: _set_gcov_prefix 03:21:30 INFO - Running main action method: run_tests 03:21:30 WARNING - Try message not found. 03:21:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:21:30 INFO - Python 2.7.3 03:21:30 INFO - Return code: 0 03:21:30 INFO - grabbing minidump binary from tooltool 03:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:30 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 0x11f0090>, '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 0x11f0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eaf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:21:30 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 03:21:30 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 03:21:30 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 03:21:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:21:30 INFO - Return code: 0 03:21:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:21:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:21:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:21:30 INFO - ENV: RUST_BACKTRACE is now full 03:21:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:21:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:21:30 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/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 03:21:30 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/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 03:21:30 INFO - Using env: {'DISPLAY': ':0', 03:21:30 INFO - 'HOME': '/home/cltbld', 03:21:30 INFO - 'LANG': 'en_US.UTF-8', 03:21:30 INFO - 'LANGUAGE': 'en_US:en', 03:21:30 INFO - 'LOGNAME': 'cltbld', 03:21:30 INFO - 'MAIL': '/var/mail/cltbld', 03:21:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:30 INFO - 'MOZ_NO_REMOTE': '1', 03:21:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:30 INFO - 'NO_EM_RESTART': '1', 03:21:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:30 INFO - 'PWD': '/builds/slave/test', 03:21:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:30 INFO - 'RUST_BACKTRACE': 'full', 03:21:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:30 INFO - 'SHELL': '/bin/bash', 03:21:30 INFO - 'SHLVL': '1', 03:21:30 INFO - 'TERM': 'linux', 03:21:30 INFO - 'TMOUT': '86400', 03:21:30 INFO - 'USER': 'cltbld', 03:21:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', 03:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:30 INFO - '_': '/tools/buildbot/bin/python'} 03:21:30 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/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 03:21:31 INFO - mozversion application_buildid: 20170913092825 03:21:31 INFO - mozversion application_changeset: 9873269746359dbcccbd5b44f0e82c0225289945 03:21:31 INFO - mozversion application_display_name: Nightly 03:21:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:21:31 INFO - mozversion application_name: Firefox 03:21:31 INFO - mozversion application_remotingname: firefox 03:21:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:21:31 INFO - mozversion application_vendor: Mozilla 03:21:31 INFO - mozversion application_version: 57.0a1 03:21:31 INFO - mozversion platform_buildid: 20170913092825 03:21:31 INFO - mozversion platform_changeset: 9873269746359dbcccbd5b44f0e82c0225289945 03:21:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:21:31 INFO - mozversion platform_version: 57.0a1 03:21:31 INFO - using testdate: 1505298091 03:21:31 INFO - actual date: 1505298091 03:21:31 INFO - starting webserver on 'localhost:44225' 03:21:31 INFO - SUITE-START | Running 2 tests 03:21:31 INFO - TEST-START | dromaeo_css 03:21:31 INFO - Initialising browser for dromaeo_css test... 03:21:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44225/getInfo.html -profile /tmp/tmpNgMeEH/profile 03:21:31 INFO - TEST-INFO | started process 23378 (/builds/slave/test/build/application/firefox/firefox http://localhost:44225/getInfo.html) 03:21:37 INFO - TEST-INFO | 23378: exit 0 03:21:37 INFO - Browser initialized. 03:21:37 INFO - Running cycle 1/1 for dromaeo_css test... 03:21:37 INFO - Using env: {'DISPLAY': ':0', 03:21:37 INFO - 'HOME': '/home/cltbld', 03:21:37 INFO - 'JSGC_DISABLE_POISONING': '1', 03:21:37 INFO - 'LANG': 'en_US.UTF-8', 03:21:37 INFO - 'LANGUAGE': 'en_US:en', 03:21:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:21:37 INFO - 'LOGNAME': 'cltbld', 03:21:37 INFO - 'MAIL': '/var/mail/cltbld', 03:21:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:37 INFO - 'MOZ_CRASHREPORTER': '1', 03:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:21:37 INFO - 'MOZ_NO_REMOTE': '1', 03:21:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:37 INFO - 'NO_EM_RESTART': '1', 03:21:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:37 INFO - 'PWD': '/builds/slave/test', 03:21:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:37 INFO - 'RUST_BACKTRACE': 'full', 03:21:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:37 INFO - 'SHELL': '/bin/bash', 03:21:37 INFO - 'SHLVL': '1', 03:21:37 INFO - 'STYLO_FORCE_DISABLED': '1', 03:21:37 INFO - 'TERM': 'linux', 03:21:37 INFO - 'TMOUT': '86400', 03:21:37 INFO - 'USER': 'cltbld', 03:21:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', 03:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:37 INFO - '_': '/tools/buildbot/bin/python'} 03:21:37 INFO - TEST-INFO | started process 23566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNgMeEH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:38 INFO - PID 23566 | 03:21:38 INFO - PID 23566 | (/builds/slave/test/build/application/firefox/firefox:23616): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:21:38 INFO - PID 23566 | 03:21:48 INFO - PID 23566 | RSS: Main: 174153728 03:21:48 INFO - PID 23566 | 03:24:46 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:44225/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44225/tests/dromaeo/cssquery-ext.html) 03:24:47 INFO - PID 23566 | RSS: Main: 176541696 03:24:47 INFO - PID 23566 | 03:27:49 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:44225/tests/dromaeo/cssquery-ext.html (next: http://localhost:44225/tests/dromaeo/cssquery-jquery.html) 03:27:49 INFO - PID 23566 | RSS: Main: 170536960 03:27:49 INFO - PID 23566 | 03:30:51 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:44225/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44225/tests/dromaeo/cssquery-mootools.html) 03:30:51 INFO - PID 23566 | RSS: Main: 175181824 03:30:51 INFO - PID 23566 | 03:33:53 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:44225/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44225/tests/dromaeo/cssquery-prototype.html) 03:33:54 INFO - PID 23566 | RSS: Main: 173301760 03:33:54 INFO - PID 23566 | 03:36:57 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:44225/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44225/tests/dromaeo/cssquery-yui.html) 03:36:58 INFO - PID 23566 | RSS: Main: 174612480 03:36:58 INFO - PID 23566 | 03:39:59 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:44225/tests/dromaeo/cssquery-yui.html (next: http://localhost:44225/tests/dromaeo/cssquery-dojo.html) 03:39:59 INFO - PID 23566 | RSS: Main: 178270208 03:39:59 INFO - PID 23566 | 03:39:59 INFO - PID 23566 | __start_tp_report 03:39:59 INFO - PID 23566 | _x_x_mozilla_page_load 03:39:59 INFO - PID 23566 | _x_x_mozilla_page_load_details 03:39:59 INFO - PID 23566 | |i|pagename|runs| 03:39:59 INFO - PID 23566 | |0;dojo.html;3092.489739193033;3106.906792796216;3123.1255248530406;3143.1984843864825;3153.5585018097454;6089;6205.162303089081;6232.2832874219475;6250.874982500347;6285.994240921454;6184.072389141631;6278.654673992928;6342.841428964278;6345.365463453652;6399.296077431491;5812.4768770810615;5878.059510478324;5879.088741245114;5887.116932460122;5896.262967129109;5632.3804381518;5720.8283751487525;5777.393373695764;5807.564432667546;5816.302043754756;5713.371529131792;5783.363829978699;5785.363610002896;5812.651240925516;5849.941500584982;5590.8043218487155;5661.405552416978;5665.886682266373;5685.204071430003;5691.800786972436;5653.462921022497;5689.487946084872;5720.227769251181;5722.713864306768;5723.284589426322;6128;6201.503879689614;6250;6271.498280137578;6281.057841323793;6591.868162636768;6623.105880706091;6701.631410272433;6703.631300278483;6732.427743641796;6539.215294164731;6610.537262391635;6664.833379165511;6680.799576012679;6825.317468253184;6229.626222426624;6252.249730032379;6271.811845644638;6340.144080549113;6346.714397852108;6915.343042410963;6918.342757438036;6921.411680007256;6991.580505169706;7002.299770023059;6378.234611846516;6516.902246466307;6568.408843204134;6670.933290667128;6688.4649228061635;6713.026611141455;6717.664116794239;6723.226828914738;6756.695948682321;6761.425278851353;6663.733450662016;6667.86664266712;6749.122614060141;6749.257581666013;6753.3921947025;6662.233843108008;6687.832804179934;6691.933080669131;6777.8983315249325;6780;5139.100657385017;5169.095408303532;5224.738763061831;5310.787568497217;5327.627066105335;4620.283856002325;4680.7191568506;4686.226772582554;4686.906261874743;4711.1519926413575;5737.168110624019;5740.167675687002;5740.6268592541355;5815.563832712563;5817.418258174149;6578.111954886125;6690.364415380531;6729.192496900403;6832.45340372769;6836.897446538306;5719.8570035749435;5781.768729250867;5785.074388097968;5800.4199580042505;5819.941800582024;5707.800226992035;5787.421257874179;5789.160571717078;5853.443922827325;5881.41185881417;6377.234731832117;6399.13611662429;6499.09012738217;6508.284088750233;6639.800805975829;6802.557833740791;6839.1451068616425;6859.588424694534;6888.827779305558;6905.998630198593;6260.906086408617;6510.869782604226;6515.511336649865;6607.867842643024;6610.3720146586;6543.738250469928;6551.934480655133;6553.606783593;6555.704993275219;6565.244996825426;6651.068850360856;6652.83367915806;6653.068570400051;6661.800145995628;6675.265720770614;6337.2395312562785;6417.133686952202;6418.614883107029;6427.357264273535;6428;6434.935650643621;6531.738730450728;6651.235107962452;6667.19993600771;6673.265940746611;6505.642189679613;6511.120998665119;6570.8357291068105;6589.604623722592;6593.241777195492;6580.473562115115;6604.570702904296;6617.239017513048;6660.700268487833;6718.496112791658;6328.6202827830475;6342.714577843916;6431.260405053479;6432.45324147434;6445.4199122079235 03:39:59 INFO - PID 23566 | |1;ext.html;768.1396835544191;793.480270422873;830.5888585150348;831.6299246835157;842.4313588327877;41176.38235426467;42016;42135.99999999996;42137.78931105344;42287.78856105723;38270.23459530808;38458.8077059615;38482.23035539287;38497.422538661944;38557.42163867544;6966.477514186444;7088.893666595005;7090.468214883878;7091.645417729119;7095.787126386217;6986.336298051677;7060.329268719489;7060.89408658868;7067.151941766995;7097.787066388017;7052.929470705279;7078.327558881898;7080.256573059806;7080.787576372692;7827.6477558510005;7858.489198202098;7916.762497125095;7917.445778795515;7918;7938.206179382045;7819.3744500439825;7868.488548244346;7876.488028278143;7882.054153501616;7889.053313602347;38918;38938.221235575416;39625.20749585021;39690;39770.20459590821;3409.641987591292;3442.862285508577;3446.1556918555116;3450.9654903450896;3460.8788692395647;32475.350492990245;32584.837075814707;32625;32634.184145396317;32689;5237.083510385667;5253.579713622901;5266.368035835686;5281.392639846428;5323.121684922022;183311;183677;183682;184092.0795396028;184569;48961.26558101631;49196.26205606919;49262.26106608404;49265.50734492609;49317.50682493129;49575.50424495709;49689;50024.24963625549;50053;50303.49696502988;15178.544643660707;15329.846701532842;15342.616434589225;15348.386064557517;15351;12330.938345308216;12337.198082124813;12344.567940122231;12346.876531234573;12352.567660132032;14312.785308220386;14419.134851908919;14466.782998255034;14510.419583216553;14573;5760.251167348301;5799.3040835100055;5955.493783028404;5967.9701601491715;5989.520838332923;987.6543209876486;1011.8735158105237;1016.4612755239734;1021.6781713760141;1033.4677641014882;22649.547009059726;22791.772082278963;22844.771552284263;22990.42523936915;23046.308610741704;1095.8411030400548;1098.5001824169983;1109.3732041396747;1113.7382715062115;1115.7489564847845;11953.880461195276;12138.514459421702;12252.20360676571;12274.324912129918;12294.323812190416;227557;229473;229569;229877;230290;52182.47817521776;52857.7357113212;53793.73103134459;56228.71885640546;56378.43621563814;1436.6336584171179;1438.3814959567487;1453.6583902782627;1461.7734251191082;1464.4330566294177;27108.72891271062;27285.72714272832;27339.86330068337;27573.862130689216;27683.861580692774;38011.23977520379;38060.80969595134;38149.23701526009;38164.427533586466;38234.426483603325;204881;205415;205639;205766;205890;34030.82984585061;35149.29701406009;35345.1163720909;35363.82318088496;35598.28803423969;44193.77903110464;44740.77629611831;44850.551494484636;44877.326840098074;45022.54977450184;31801.204969875937;31907.840460797546;32072.03783886487;32642;32876.835615821765;31645.36709265848;31713.5242971351;32084.197895051875;32222.35555288928;32272.83863580667;35428;36706.26587468182;36791.26417471689;36867.81566092152;37245.81377093206;31336.21659458532;31368.68631313749;31375;31449.842750786098;31554.526682100248;23046.193383231508;23346.416339590967;23358.76641233634;23475.882620586788;23502.294931152093 03:39:59 INFO - PID 23566 | |2;jquery.html;567.5743192605546;569.99715001425;570.6604570280682;577.3504807092022;582.6271186440678;22236.77763222367;22977;23084.76915230845;23095.538089238245;23116.884415577897;23325.183618573352;24099.277021689377;24613.75386246137;24938.376540586494;25055;6334.524910631698;6502.7398904043785;6512;6515.3484651534945;6532.804015879531;6405.647689377082;6472.805815825533;6477.708503117371;6478.157839480885;6502.837429064264;6336.239651241857;6455.031745238205;6463.547551671361;6595.67021648918;6605.471562275031;6551.115599394092;6597.80206593803;6600.3729645683825;6626.73493060277;6628;5721.5136713379;6044.788432404889;6114.0828875669;6125.326214116443;6129.417705317987;28041.158765237076;28379.432411351863;28406;28420;28429.147125586267;2018.0716870239708;2037.9388618341472;2038.011564391269;2039.785822488647;2042.5404284036122;18322.725159122623;18786.436406907815;19119.23523059076;19133.61732765337;19133.9043304784;2374.5963186258377;2421.8910149043336;2422.7819496245424;2434.464417828075;2462.827602067856;119737;126428;134847;141322;141938.2903085478;13357.46570137203;13860.722785544232;13983.720325593431;14398.20809855468;14576.854231457763;22036.228731994303;22067.227647032276;22118.668219976713;22123.668144977837;22137.778622213893;9884.80230395388;10001.49992500372;10108.1408080314;10112.241581881388;10112.342697724624;9116.726498205064;9284.48935308551;9337.579808908615;9454.527273636291;9471.337006409485;8585.527795971157;8723.738287851374;8806.47161170319;8969.327300452493;8998.59506322204;2570.7943364530793;2589.6892372914995;2651.801114916389;2714.714954929704;2812.1141840320233;940.229012209995;955.3360414511848;959.318883592643;964.4261664309724;980.5146452505912;18695.626087478173;18786.906065469586;19054.714179287323;19099.522511937033;19305.420837374902;998.7602975285879;1025.195221750922;1026.645807196516;1030.4950574218578;1033.5968972100886;10509.421981791074;10587;10648.840267395995;10657.626983055556;10850.186236032328;431134;434049.1487712832;441688;443298;451690;104771;106158;108103;109698.45150774355;110398.44800775945;1119.1047162270313;1131.5869707556683;1156.8958793708607;1157.0454375140544;1162.2561560601223;16757.07836069028;16851;16926.57683557921;16953.745693814355;17142.314307428063;54099.72950135224;54632;55612.72193639006;56655;56901.71549142228;69152;69213;69607;69655;69778.65110674415;13766.587002389944;14127.505537306144;14213;14227.573172804417;14283.214423206824;22264;22272.554548909255;22278.220262290743;22325.888370558045;22442;17343.219555120304;17514.649707006043;17619.20713567867;17653.82346176522;17662.823371766117;15787.605309867346;16160.272787724816;16195.190240488164;16722.916385417993;16872.57818554546;18145;18191.45425637233;18281.26874924988;18416.17127229251;18450.35423760162;13807.585772426843;13850.238236896665;13935.163890166623;14002.649933751738;14032.438702452197;17243.482695519153;17530.649387012443;17667;17781.4885734714;18054.458366249033 03:39:59 INFO - PID 23566 | |3;mootools.html;1301.3558288647118;1380.8619138086192;1387.7710177820647;1388.2156581531433;1393.8397084335297;14914.701705965888;15485.767713484307;15524.146171960538;15553.844461555382;15555.688886222282;15103.471378501727;15234.695306093872;15243.542693719179;15281.312340944656;15283.465078722247;2769.487644785711;2790.4419116176746;2832.6884042755282;2833.305840069186;2838.148555433372;2732.631094802206;2801.6918139004797;2803.8738256778493;2806.6070750095005;2818.041865765639;2699.8785054672585;2776.3336799168155;2824.5621928601;2828.915132546027;2834.178088354385;2751.7523422891836;2773.5423655096884;2776.694563598003;2797.1888152435768;2798.720127987205;2680.463907218564;2691.5962605609316;2707.2690373599216;2722;2742.3418379588957;14812.481563145238;15194;15217.543473695696;15227.314770835228;15286.770698439532;7953.204679532;8302.584870756498;8303.460275082161;8321.66713331466;8348;5137.409197942247;5198.246254293144;5278.630495865291;5351.6521426107565;5352.143657014859;1654.69388163189;1672.406295764998;1678.7146185148554;1709.435886157565;1713.5716070982255;26292.605610915853;26511.337216569547;26530.806113724735;26553.867230663724;26603.334916627045;7399.6670149843385;7412.221716719775;7625.313721764956;7679.155292917774;7703.537787732642;17204;17286.481405557854;17322.740158897628;17328.133593320283;17338.826611733723;7995.880061799077;8110.310623596943;8111.675532978733;8133.633986470623;8147.063087744867;7214;7272.745453909088;7457.366123879422;7468.626568671545;7540.660670269851;5069.822556210515;5238.449962753933;5251.606129540223;5283.841484755387;5293.444188360244;1440.4598275646633;1474.2481334519473;1576.9448069317518;1589.6343840916654;1608.9436869709505;906.4425378392373;941.8540126280437;950.1353768071023;951.048951048951;962.9037096290455;8505.74482765518;8607.397482176188;8676.34927380449;8798.164174403422;8829.735107946772;720.5064530796421;728.7777227945528;729.5622626424104;742.4097842215451;807.2290962131151;5282.550983166397;5298.940211957547;5312.495312945264;5369.892602147936;5381.246625472437;20406;20926.790732092486;21719.348419547438;21753.89123054406;21770.564588708454;21580.352589422342;22043.779562204494;22076.88961555214;22106.44733881666;22126.668099978513;9962.252831037702;10705.9464702676;10798.082163016075;10833.404162771123;10835.349879007126;7591.8861217082895;7900.249476299742;7904.446688731734;7937.563434011185;7938.166492518202;18324.633507330047;18337.449876503728;18637.534061648566;18643.627127457647;18762.906185468986;19100.713489297395;19116.426507204807;19183.904080479508;19279.80720192836;19306.7103993443;10784.299020563638;10877.728056798644;10926.071283940953;10956.671299861016;10971.835422468828;13982.790258146339;14163.858361416254;14172;14174.433022678977;14191.290435477978;11276.492557834754;11291.3789741565;11435.428228588704;11546.538138474367;11697.590584329508;11126.61056863006;11162.49768760424;11202.495887685236;11336.829947550628;11505.137114716263;9248.16766491019;9383.530823458663;9401.435913845191;9430.62277508892;9459.290553208675;6997.965010174917;7000.929990700028;7012.2286548478605;7029.156501219886;7124.964375178091;7121.287871212838;7180.1742799578715;7225.6387180641805;7296.635168241461;7337.70649174027 03:39:59 INFO - PID 23566 | |4;prototype.html;500.9774560144793;507.4266079330356;528.5401700520548;529.6266132376675;536.0779459329954;6231.158793562868;6283.968580157099;6297.338779428152;6352.174217351743;6373.9362606373925;6011.5190784737115;6068.302145253286;6128.387161283869;6130.693465326738;6203.31763506014;4891.853244402673;4965;5021.397432308119;5031.899362012758;5050.747462626872;4989.55094041538;4999.850004499871;5021.246812978065;5022.936009034504;5025.321581586476;4918.466989500393;4981.950180498185;4985.227289770091;5027.4972502749615;5066.695998240099;5004.449510553836;5028.95169388642;5040.2187660912805;5042.84871453857;5079.136546787018;4527.796249168795;4529.165687896407;4533.365328853963;4540.614047805941;4553.931691024637;5986.880262394728;6080.635161890256;6136.969315153396;6149.907751383733;6238.875222495525;5679;5691.463304907693;5714.7428365723645;5749.770009199627;5764.5676574257095;6606.588595162731;6615.735370585171;6660.733570657168;6668.366505182;6687.732490700366;4931.3589233399425;4932.778024988884;4935.950640493621;4950.628702847301;4963.081829861451;6925.58446493207;6995.335443132894;7018.508704390695;7027.472939529555;7047.43620510358;5053.898922021539;5079.6474326944035;5091.632390938232;5091.949080509222;5094.847154585368;5139.331886854685;5143.6399452037995;5146.459621739738;5159.17453207485;5205.115130427836;5670;5696.51579615729;5750.281214848144;5763.85590360236;5781.8554536136935;6342.968285158637;6408.487321014308;6604.1084453599115;6612.537122401482;6686.765963191265;1751.089433494601;1757.2268201991083;1760.5158581389965;1766.6025144342677;1767.5404394857173;1215.2526196389333;1215.732538841471;1231.5751065882257;1235.6540168752763;1236.9257844529357;5588.972055139699;5804.216430781875;5821.27234095738;5839.357670656224;5865.5600829937075;6833.384995350442;6865.759698410531;6869.175698916162;6898.896516552256;6908.3437073477935;5724.77100915967;5777.480026797609;5783.739731712083;5798.246227990418;5799.3040835100055;3601.423772196436;3608.6391360864227;3624.365735996243;3630.43728222126;3649.616790236987;6443.903341449882;6534.542582019308;6575.200103924067;6577.908383059954;6592.8351791205605;6790.5925644461495;6825.35159159879;6911.410375613536;6921.688524016431;6973.4072603829245;6448.387403196689;6489.870202595922;6502.846119631975;6579.4736421085245;6636.701348439332;6652.368025037614;6687.732490700318;6700.93299067003;6729.69716362755;6859.416949559144;6614.140161778938;6648.601083934979;6657.900131498128;6673.566218195801;6752.324767523209;6563.343665633399;6571.507136964651;6584.604923704593;6589.703463344257;6662.733490660319;4976.726280054487;5001.899962000813;5003.649744517995;5004.949950500449;5016.899662006813;6795.93702691498;6826.795196144124;6831.316868313328;6854.5201835873;6904.171499420102;6510.869782604416;6521.739130434919;6609.570377925419;6627.436667883091;6649.567778094409;6430.421262086435;6472.867248231447;6493.155889734304;6527.249366322743;6593;6444.806655800334;6473.087110800065;6490.902636460362;6504.219493660791;6519.250286216956;6147.44672979434;6628.337166283333;6628.502862285444;6655.467562595078;6660.83347916306;6338.651374174465;6375;6406.295307516262;6407.455366293917;6436.292007879036 03:39:59 INFO - PID 23566 | |5;yui.html;888.8800011998378;908.3459908865616;942.6700654770831;946.3895787217245;954.3271993244763;19307.903460482696;20227.494312642193;20272.087756050994;20285.0871710773;20351.389458316273;17301.30794768208;17584.912075439606;17856.553586160353;17888.82111178888;18045.368412105578;948.3124734567418;970.3838062830083;972.1930797438145;974.990250097497;977.2475194100539;962.874826272587;994.990085063661;996.7209181429212;996.9501524923761;999.8900120986685;1062.984055239172;1065.350136416785;1066.2909165404997;1066.5787014129414;1066.9413182275011;1009.198580533751;1019.6584144311664;1060.2790102730141;1061.262422616282;1061.8991195836384;750.5684231566871;750.8348163404042;751.1061836414649;751.4138971602159;752.39808153477;18628;18689.345872894384;18755.437336879917;18765;18773.530661733566;20508.69236961447;20642.07110680023;20910;20986;21031.47421314464;17394.21726022332;17464.91267543667;17621;17938;18016.189271482814;3664.2488289900507;3681.3557627415094;3684.410494320896;3684.6499582539614;3686.041629176407;138855;139441.3027934864;141104;141439;144537;16702.331906723837;16921.7461738074;17178.1410929453;17361.47915562535;17383.043932583576;30595;30967.225819354248;31184.53223201654;31338.843305783324;31747;8099.433039687283;8178.754637360888;8193.46742461738;8193.50838949665;8197.672093116327;4239.745615263032;4252.447181866338;4327.415798867112;4339.370791235253;4369.71596846204;5360.91958620621;5471.2887324647545;5472.179173124063;5501.917471237854;5503.394626591072;935.1770442010986;942.5004747483845;967.9661211857551;973.8344481438172;978.9461579613047;697.9092717946635;713.5336882706089;714.6783947223666;720.9243029481934;728.3735987051132;11604.477798499087;11644.825327620092;11781.469833857325;12399.614198687683;12568.120231583884;682.8907374820005;690.5683947532792;695.6799872058909;697.4524997876642;709.5919846088519;5551.250581171571;5595.580331475156;5662.405447427961;5705.5720820938595;5709.371969083398;122507.38746306211;123043.33271712631;123389;124670;127615;92672.07327926769;97288;105583;114754;124608.37695811644;94636.52681736548;97074.51462742641;97922.5103874476;98223.50888245513;101112;12019.278843269432;12408.317542535247;12714.61856144317;12921;13355.131916425402;42251.57748422476;43528;43639.12721745611;43951.560484394744;44816.55183448124;82748.58625706832;83292;84898.57550712206;86598;88083.55958220168;18772.342967996054;19142.138603762585;19348.032598370308;19388.0305984703;19479.70780438323;21140;21637;22304.330870073925;22364.217252396087;22377.888110559343;18455.354062608283;18547.258109675462;18558.536036599195;18713.15790789445;18820.435386938414;18117.27530898802;18217.908910455364;18259.269629215214;18332.17505212242;18382.90808546002;18611.348602798837;18801.341953031577;18816.059197040366;19022;19034.904825475784;13567.932160339134;13744.175349479063;13996.37016334247;14019.859801402263;14203.28983550839;13398.397072131973;13745.862541374458;13799.10305830158;13839.654008649864;13933.372998215307 03:39:59 INFO - PID 23566 | __end_tp_report 03:39:59 INFO - PID 23566 | __start_cc_report 03:39:59 INFO - PID 23566 | _x_x_mozilla_cycle_collect,367 03:39:59 INFO - PID 23566 | __end_cc_report 03:39:59 INFO - PID 23566 | __startTimestamp1505299199963__endTimestamp 03:39:59 INFO - PID 23566 | 03:39:59 INFO - PID 23566 | ------- Summary: start ------- 03:39:59 INFO - PID 23566 | Number of tests: 6 03:39:59 INFO - PID 23566 | 03:39:59 INFO - PID 23566 | [#0] dojo.html Cycles:165 Average:6169.53 Median:6417.13 stddev:742.73 (11.6%) stddev-sans-first:704.69 03:39:59 INFO - PID 23566 | Values: 3092.5 3106.9 3123.1 3143.2 3153.6 6089.0 6205.2 6232.3 6250.9 6286.0 6184.1 6278.7 6342.8 6345.4 6399.3 5812.5 5878.1 5879.1 5887.1 5896.3 5632.4 5720.8 5777.4 5807.6 5816.3 5713.4 5783.4 5785.4 5812.7 5849.9 5590.8 5661.4 5665.9 5685.2 5691.8 5653.5 5689.5 5720.2 5722.7 5723.3 6128.0 6201.5 6250.0 6271.5 6281.1 6591.9 6623.1 6701.6 6703.6 6732.4 6539.2 6610.5 6664.8 6680.8 6825.3 6229.6 6252.2 6271.8 6340.1 6346.7 6915.3 6918.3 6921.4 6991.6 7002.3 6378.2 6516.9 6568.4 6670.9 6688.5 6713.0 6717.7 6723.2 6756.7 6761.4 6663.7 6667.9 6749.1 6749.3 6753.4 6662.2 6687.8 6691.9 6777.9 6780.0 5139.1 5169.1 5224.7 5310.8 5327.6 4620.3 4680.7 4686.2 4686.9 4711.2 5737.2 5740.2 5740.6 5815.6 5817.4 6578.1 6690.4 6729.2 6832.5 6836.9 5719.9 5781.8 5785.1 5800.4 5819.9 5707.8 5787.4 5789.2 5853.4 5881.4 6377.2 6399.1 6499.1 6508.3 6639.8 6802.6 6839.1 6859.6 6888.8 6906.0 6260.9 6510.9 6515.5 6607.9 6610.4 6543.7 6551.9 6553.6 6555.7 6565.2 6651.1 6652.8 6653.1 6661.8 6675.3 6337.2 6417.1 6418.6 6427.4 6428.0 6434.9 6531.7 6651.2 6667.2 6673.3 6505.6 6511.1 6570.8 6589.6 6593.2 6580.5 6604.6 6617.2 6660.7 6718.5 6328.6 6342.7 6431.3 6432.5 6445.4 03:39:59 INFO - PID 23566 | 03:39:59 INFO - PID 23566 | [#1] ext.html Cycles:180 Average:37744.36 Median:35247.21 stddev:53658.37 (152.2%) stddev-sans-first:53737.06 03:39:59 INFO - PID 23566 | Values: 768.1 793.5 830.6 831.6 842.4 41176.4 42016.0 42136.0 42137.8 42287.8 38270.2 38458.8 38482.2 38497.4 38557.4 6966.5 7088.9 7090.5 7091.6 7095.8 6986.3 7060.3 7060.9 7067.2 7097.8 7052.9 7078.3 7080.3 7080.8 7827.6 7858.5 7916.8 7917.4 7918.0 7938.2 7819.4 7868.5 7876.5 7882.1 7889.1 38918.0 38938.2 39625.2 39690.0 39770.2 3409.6 3442.9 3446.2 3451.0 3460.9 32475.4 32584.8 32625.0 32634.2 32689.0 5237.1 5253.6 5266.4 5281.4 5323.1 183311.0 183677.0 183682.0 184092.1 184569.0 48961.3 49196.3 49262.3 49265.5 49317.5 49575.5 49689.0 50024.2 50053.0 50303.5 15178.5 15329.8 15342.6 15348.4 15351.0 12330.9 12337.2 12344.6 12346.9 12352.6 14312.8 14419.1 14466.8 14510.4 14573.0 5760.3 5799.3 5955.5 5968.0 5989.5 987.7 1011.9 1016.5 1021.7 1033.5 22649.5 22791.8 22844.8 22990.4 23046.3 1095.8 1098.5 1109.4 1113.7 1115.7 11953.9 12138.5 12252.2 12274.3 12294.3 227557.0 229473.0 229569.0 229877.0 230290.0 52182.5 52857.7 53793.7 56228.7 56378.4 1436.6 1438.4 1453.7 1461.8 1464.4 27108.7 27285.7 27339.9 27573.9 27683.9 38011.2 38060.8 38149.2 38164.4 38234.4 204881.0 205415.0 205639.0 205766.0 205890.0 34030.8 35149.3 35345.1 35363.8 35598.3 44193.8 44740.8 44850.6 44877.3 45022.5 31801.2 31907.8 32072.0 32642.0 32876.8 31645.4 31713.5 32084.2 32222.4 32272.8 35428.0 36706.3 36791.3 36867.8 37245.8 31336.2 31368.7 31375.0 31449.8 31554.5 23046.2 23346.4 23358.8 23475.9 23502.3 03:39:59 INFO - PID 23566 | 03:39:59 INFO - PID 23566 | [#2] jquery.html Cycles:180 Average:32629.60 Median:22275.39 stddev:74604.69 (334.9%) stddev-sans-first:74775.14 03:39:59 INFO - PID 23566 | Values: 567.6 570.0 570.7 577.4 582.6 22236.8 22977.0 23084.8 23095.5 23116.9 23325.2 24099.3 24613.8 24938.4 25055.0 6334.5 6502.7 6512.0 6515.3 6532.8 6405.6 6472.8 6477.7 6478.2 6502.8 6336.2 6455.0 6463.5 6595.7 6605.5 6551.1 6597.8 6600.4 6626.7 6628.0 5721.5 6044.8 6114.1 6125.3 6129.4 28041.2 28379.4 28406.0 28420.0 28429.1 2018.1 2037.9 2038.0 2039.8 2042.5 18322.7 18786.4 19119.2 19133.6 19133.9 2374.6 2421.9 2422.8 2434.5 2462.8 119737.0 126428.0 134847.0 141322.0 141938.3 13357.5 13860.7 13983.7 14398.2 14576.9 22036.2 22067.2 22118.7 22123.7 22137.8 9884.8 10001.5 10108.1 10112.2 10112.3 9116.7 9284.5 9337.6 9454.5 9471.3 8585.5 8723.7 8806.5 8969.3 8998.6 2570.8 2589.7 2651.8 2714.7 2812.1 940.2 955.3 959.3 964.4 980.5 18695.6 18786.9 19054.7 19099.5 19305.4 998.8 1025.2 1026.6 1030.5 1033.6 10509.4 10587.0 10648.8 10657.6 10850.2 431134.0 434049.1 441688.0 443298.0 451690.0 104771.0 106158.0 108103.0 109698.5 110398.4 1119.1 1131.6 1156.9 1157.0 1162.3 16757.1 16851.0 16926.6 16953.7 17142.3 54099.7 54632.0 55612.7 56655.0 56901.7 69152.0 69213.0 69607.0 69655.0 69778.7 13766.6 14127.5 14213.0 14227.6 14283.2 22264.0 22272.6 22278.2 22325.9 22442.0 17343.2 17514.6 17619.2 17653.8 17662.8 15787.6 16160.3 16195.2 16722.9 16872.6 18145.0 18191.5 18281.3 18416.2 18450.4 13807.6 13850.2 13935.2 14002.6 14032.4 17243.5 17530.6 17667.0 17781.5 18054.5 03:39:59 INFO - PID 23566 | 03:39:59 INFO - PID 23566 | [#3] mootools.html Cycles:180 Average:9346.65 Median:2747.05 stddev:6682.33 (243.3%) stddev-sans-first:6673.73 03:39:59 INFO - PID 23566 | Values: 1301.4 1380.9 1387.8 1388.2 1393.8 14914.7 15485.8 15524.1 15553.8 15555.7 15103.5 15234.7 15243.5 15281.3 15283.5 2769.5 2790.4 2832.7 2833.3 2838.1 2732.6 2801.7 2803.9 2806.6 2818.0 2699.9 2776.3 2824.6 2828.9 2834.2 2751.8 2773.5 2776.7 2797.2 2798.7 2680.5 2691.6 2707.3 2722.0 2742.3 14812.5 15194.0 15217.5 15227.3 15286.8 7953.2 8302.6 8303.5 8321.7 8348.0 5137.4 5198.2 5278.6 5351.7 5352.1 1654.7 1672.4 1678.7 1709.4 1713.6 26292.6 26511.3 26530.8 26553.9 26603.3 7399.7 7412.2 7625.3 7679.2 7703.5 17204.0 17286.5 17322.7 17328.1 17338.8 7995.9 8110.3 8111.7 8133.6 8147.1 7214.0 7272.7 7457.4 7468.6 7540.7 5069.8 5238.4 5251.6 5283.8 5293.4 1440.5 1474.2 1576.9 1589.6 1608.9 906.4 941.9 950.1 951.0 962.9 8505.7 8607.4 8676.3 8798.2 8829.7 720.5 728.8 729.6 742.4 807.2 5282.6 5298.9 5312.5 5369.9 5381.2 20406.0 20926.8 21719.3 21753.9 21770.6 21580.4 22043.8 22076.9 22106.4 22126.7 9962.3 10705.9 10798.1 10833.4 10835.3 7591.9 7900.2 7904.4 7937.6 7938.2 18324.6 18337.4 18637.5 18643.6 18762.9 19100.7 19116.4 19183.9 19279.8 19306.7 10784.3 10877.7 10926.1 10956.7 10971.8 13982.8 14163.9 14172.0 14174.4 14191.3 11276.5 11291.4 11435.4 11546.5 11697.6 11126.6 11162.5 11202.5 11336.8 11505.1 9248.2 9383.5 9401.4 9430.6 9459.3 6998.0 7000.9 7012.2 7029.2 7125.0 7121.3 7180.2 7225.6 7296.6 7337.7 03:39:59 INFO - PID 23566 | 03:39:59 INFO - PID 23566 | [#4] prototype.html Cycles:180 Average:5550.00 Median:6133.83 stddev:1554.56 (25.3%) stddev-sans-first:1512.02 03:39:59 INFO - PID 23566 | Values: 501.0 507.4 528.5 529.6 536.1 6231.2 6284.0 6297.3 6352.2 6373.9 6011.5 6068.3 6128.4 6130.7 6203.3 4891.9 4965.0 5021.4 5031.9 5050.7 4989.6 4999.9 5021.2 5022.9 5025.3 4918.5 4982.0 4985.2 5027.5 5066.7 5004.4 5029.0 5040.2 5042.8 5079.1 4527.8 4529.2 4533.4 4540.6 4553.9 5986.9 6080.6 6137.0 6149.9 6238.9 5679.0 5691.5 5714.7 5749.8 5764.6 6606.6 6615.7 6660.7 6668.4 6687.7 4931.4 4932.8 4936.0 4950.6 4963.1 6925.6 6995.3 7018.5 7027.5 7047.4 5053.9 5079.6 5091.6 5091.9 5094.8 5139.3 5143.6 5146.5 5159.2 5205.1 5670.0 5696.5 5750.3 5763.9 5781.9 6343.0 6408.5 6604.1 6612.5 6686.8 1751.1 1757.2 1760.5 1766.6 1767.5 1215.3 1215.7 1231.6 1235.7 1236.9 5589.0 5804.2 5821.3 5839.4 5865.6 6833.4 6865.8 6869.2 6898.9 6908.3 5724.8 5777.5 5783.7 5798.2 5799.3 3601.4 3608.6 3624.4 3630.4 3649.6 6443.9 6534.5 6575.2 6577.9 6592.8 6790.6 6825.4 6911.4 6921.7 6973.4 6448.4 6489.9 6502.8 6579.5 6636.7 6652.4 6687.7 6700.9 6729.7 6859.4 6614.1 6648.6 6657.9 6673.6 6752.3 6563.3 6571.5 6584.6 6589.7 6662.7 4976.7 5001.9 5003.6 5004.9 5016.9 6795.9 6826.8 6831.3 6854.5 6904.2 6510.9 6521.7 6609.6 6627.4 6649.6 6430.4 6472.9 6493.2 6527.2 6593.0 6444.8 6473.1 6490.9 6504.2 6519.3 6147.4 6628.3 6628.5 6655.5 6660.8 6338.7 6375.0 6406.3 6407.5 6436.3 03:39:59 INFO - PID 23566 | 03:39:59 INFO - PID 23566 | [#5] yui.html Cycles:180 Average:25745.13 Median:20776.04 stddev:36467.87 (175.5%) stddev-sans-first:36522.41 03:39:59 INFO - PID 23566 | Values: 888.9 908.3 942.7 946.4 954.3 19307.9 20227.5 20272.1 20285.1 20351.4 17301.3 17584.9 17856.6 17888.8 18045.4 948.3 970.4 972.2 975.0 977.2 962.9 995.0 996.7 997.0 999.9 1063.0 1065.4 1066.3 1066.6 1066.9 1009.2 1019.7 1060.3 1061.3 1061.9 750.6 750.8 751.1 751.4 752.4 18628.0 18689.3 18755.4 18765.0 18773.5 20508.7 20642.1 20910.0 20986.0 21031.5 17394.2 17464.9 17621.0 17938.0 18016.2 3664.2 3681.4 3684.4 3684.6 3686.0 138855.0 139441.3 141104.0 141439.0 144537.0 16702.3 16921.7 17178.1 17361.5 17383.0 30595.0 30967.2 31184.5 31338.8 31747.0 8099.4 8178.8 8193.5 8193.5 8197.7 4239.7 4252.4 4327.4 4339.4 4369.7 5360.9 5471.3 5472.2 5501.9 5503.4 935.2 942.5 968.0 973.8 978.9 697.9 713.5 714.7 720.9 728.4 11604.5 11644.8 11781.5 12399.6 12568.1 682.9 690.6 695.7 697.5 709.6 5551.3 5595.6 5662.4 5705.6 5709.4 122507.4 123043.3 123389.0 124670.0 127615.0 92672.1 97288.0 105583.0 114754.0 124608.4 94636.5 97074.5 97922.5 98223.5 101112.0 12019.3 12408.3 12714.6 12921.0 13355.1 42251.6 43528.0 43639.1 43951.6 44816.6 82748.6 83292.0 84898.6 86598.0 88083.6 18772.3 19142.1 19348.0 19388.0 19479.7 21140.0 21637.0 22304.3 22364.2 22377.9 18455.4 18547.3 18558.5 18713.2 18820.4 18117.3 18217.9 18259.3 18332.2 18382.9 18611.3 18801.3 18816.1 19022.0 19034.9 13567.9 13744.2 13996.4 14019.9 14203.3 13398.4 13745.9 13799.1 13839.7 13933.4 03:39:59 INFO - PID 23566 | -------- Summary: end -------- 03:39:59 INFO - PID 23566 | 03:40:00 INFO - PID 23566 | 03:40:00 INFO - PID 23566 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 03:40:00 INFO - PID 23566 | 03:40:00 INFO - TEST-INFO | 23566: exit 0 03:40:00 INFO - TEST-OK | dromaeo_css | took 1109509ms 03:40:00 INFO - TEST-START | kraken 03:40:00 INFO - Initialising browser for kraken test... 03:40:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44225/getInfo.html -profile /tmp/tmp4L8KNa/profile 03:40:00 INFO - TEST-INFO | started process 23939 (/builds/slave/test/build/application/firefox/firefox http://localhost:44225/getInfo.html) 03:40:05 INFO - TEST-INFO | 23939: exit 0 03:40:06 INFO - Browser initialized. 03:40:06 INFO - Running cycle 1/1 for kraken test... 03:40:06 INFO - Using env: {'DISPLAY': ':0', 03:40:06 INFO - 'HOME': '/home/cltbld', 03:40:06 INFO - 'JSGC_DISABLE_POISONING': '1', 03:40:06 INFO - 'LANG': 'en_US.UTF-8', 03:40:06 INFO - 'LANGUAGE': 'en_US:en', 03:40:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:40:06 INFO - 'LOGNAME': 'cltbld', 03:40:06 INFO - 'MAIL': '/var/mail/cltbld', 03:40:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:40:06 INFO - 'MOZ_CRASHREPORTER': '1', 03:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:40:06 INFO - 'MOZ_NO_REMOTE': '1', 03:40:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:06 INFO - 'NO_EM_RESTART': '1', 03:40:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:06 INFO - 'PWD': '/builds/slave/test', 03:40:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:06 INFO - 'RUST_BACKTRACE': 'full', 03:40:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:40:06 INFO - 'SHELL': '/bin/bash', 03:40:06 INFO - 'SHLVL': '1', 03:40:06 INFO - 'STYLO_FORCE_DISABLED': '1', 03:40:06 INFO - 'TERM': 'linux', 03:40:06 INFO - 'TMOUT': '86400', 03:40:06 INFO - 'USER': 'cltbld', 03:40:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856', 03:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:06 INFO - '_': '/tools/buildbot/bin/python'} 03:40:06 INFO - TEST-INFO | started process 24125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4L8KNa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:07 INFO - PID 24125 | 03:40:07 INFO - PID 24125 | (/builds/slave/test/build/application/firefox/firefox:24174): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:40:07 INFO - PID 24125 | 03:40:17 INFO - PID 24125 | RSS: Main: 174059520 03:40:17 INFO - PID 24125 | 03:40:20 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44225/tests/kraken/driver.html?testName=audio-beat-detection) 03:40:20 INFO - PID 24125 | RSS: Main: 178724864 03:40:20 INFO - PID 24125 | 03:40:23 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44225/tests/kraken/driver.html?testName=audio-dft) 03:40:24 INFO - PID 24125 | RSS: Main: 178896896 03:40:24 INFO - PID 24125 | 03:40:27 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44225/tests/kraken/driver.html?testName=audio-fft) 03:40:27 INFO - PID 24125 | RSS: Main: 174616576 03:40:27 INFO - PID 24125 | 03:40:29 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44225/tests/kraken/driver.html?testName=audio-oscillator) 03:40:30 INFO - PID 24125 | RSS: Main: 175251456 03:40:30 INFO - PID 24125 | 03:40:32 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44225/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:40:33 INFO - PID 24125 | RSS: Main: 175460352 03:40:33 INFO - PID 24125 | 03:40:36 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44225/tests/kraken/driver.html?testName=imaging-darkroom) 03:40:37 INFO - PID 24125 | RSS: Main: 177655808 03:40:37 INFO - PID 24125 | 03:40:40 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44225/tests/kraken/driver.html?testName=imaging-desaturate) 03:40:41 INFO - PID 24125 | RSS: Main: 177790976 03:40:41 INFO - PID 24125 | 03:40:44 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44225/tests/kraken/driver.html?testName=json-parse-financial) 03:40:45 INFO - PID 24125 | RSS: Main: 178122752 03:40:45 INFO - PID 24125 | 03:40:46 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44225/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:40:47 INFO - PID 24125 | RSS: Main: 178077696 03:40:47 INFO - PID 24125 | 03:40:48 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44225/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:40:49 INFO - PID 24125 | RSS: Main: 178728960 03:40:49 INFO - PID 24125 | 03:40:51 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44225/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:40:52 INFO - PID 24125 | RSS: Main: 176140288 03:40:52 INFO - PID 24125 | 03:40:55 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:40:55 INFO - PID 24125 | RSS: Main: 175919104 03:40:55 INFO - PID 24125 | 03:40:58 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:40:59 INFO - PID 24125 | RSS: Main: 176013312 03:40:59 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | Cycle 1(1): loaded http://localhost:44225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44225/tests/kraken/driver.html?testName=ai-astar) 03:41:01 INFO - PID 24125 | RSS: Main: 177373184 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | __start_tp_report 03:41:01 INFO - PID 24125 | _x_x_mozilla_page_load 03:41:01 INFO - PID 24125 | _x_x_mozilla_page_load_details 03:41:01 INFO - PID 24125 | |i|pagename|runs| 03:41:01 INFO - PID 24125 | |0;ai-astar;109;108;107;108;110;107;109;110;106;107 03:41:01 INFO - PID 24125 | |1;audio-beat-detection;134;118;117;115;117;116;118;117;115;116 03:41:01 INFO - PID 24125 | |2;audio-dft;165;165;168;169;167;164;173;170;166;164 03:41:01 INFO - PID 24125 | |3;audio-fft;74;74;74;75;75;74;74;74;76;74 03:41:01 INFO - PID 24125 | |4;audio-oscillator;80;80;79;80;79;80;81;80;79;79 03:41:01 INFO - PID 24125 | |5;imaging-gaussian-blur;113;114;113;113;113;115;113;116;114;117 03:41:01 INFO - PID 24125 | |6;imaging-darkroom;150;148;149;148;149;149;148;149;149;148 03:41:01 INFO - PID 24125 | |7;imaging-desaturate;94;94;94;94;94;95;94;95;100;99 03:41:01 INFO - PID 24125 | |8;json-parse-financial;54;52;53;53;53;52;54;54;54;54 03:41:01 INFO - PID 24125 | |9;json-stringify-tinderbox;37;38;38;38;38;38;38;47;38;38 03:41:01 INFO - PID 24125 | |10;stanford-crypto-aes;80;77;75;75;77;75;75;74;77;74 03:41:01 INFO - PID 24125 | |11;stanford-crypto-ccm;112;118;126;110;115;115;114;112;115;115 03:41:01 INFO - PID 24125 | |12;stanford-crypto-pbkdf2;178;186;179;171;183;176;175;173;170;169 03:41:01 INFO - PID 24125 | |13;stanford-crypto-sha256-iterative;67;67;64;65;68;71;65;66;68;75 03:41:01 INFO - PID 24125 | __end_tp_report 03:41:01 INFO - PID 24125 | __start_cc_report 03:41:01 INFO - PID 24125 | _x_x_mozilla_cycle_collect,942 03:41:01 INFO - PID 24125 | __end_cc_report 03:41:01 INFO - PID 24125 | __startTimestamp1505299261329__endTimestamp 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | ------- Summary: start ------- 03:41:01 INFO - PID 24125 | Number of tests: 14 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#0] ai-astar Cycles:10 Average:108.10 Median:108.50 stddev:1.37 (1.3%) stddev-sans-first:1.41 03:41:01 INFO - PID 24125 | Values: 109.0 108.0 107.0 108.0 110.0 107.0 109.0 110.0 106.0 107.0 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#1] audio-beat-detection Cycles:10 Average:118.30 Median:117.00 stddev:5.62 (4.8%) stddev-sans-first:1.13 03:41:01 INFO - PID 24125 | Values: 134.0 118.0 117.0 115.0 117.0 116.0 118.0 117.0 115.0 116.0 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#2] audio-dft Cycles:10 Average:167.10 Median:167.50 stddev:2.92 (1.7%) stddev-sans-first:3.00 03:41:01 INFO - PID 24125 | Values: 165.0 165.0 168.0 169.0 167.0 164.0 173.0 170.0 166.0 164.0 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#3] audio-fft Cycles:10 Average:74.40 Median:74.00 stddev:0.70 (0.9%) stddev-sans-first:0.73 03:41:01 INFO - PID 24125 | Values: 74.0 74.0 74.0 75.0 75.0 74.0 74.0 74.0 76.0 74.0 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#4] audio-oscillator Cycles:10 Average:79.70 Median:80.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 03:41:01 INFO - PID 24125 | Values: 80.0 80.0 79.0 80.0 79.0 80.0 81.0 80.0 79.0 79.0 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.45 (1.3%) stddev-sans-first:1.48 03:41:01 INFO - PID 24125 | Values: 113.0 114.0 113.0 113.0 113.0 115.0 113.0 116.0 114.0 117.0 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 03:41:01 INFO - PID 24125 | Values: 150.0 148.0 149.0 148.0 149.0 149.0 148.0 149.0 149.0 148.0 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.00 stddev:2.26 (2.4%) stddev-sans-first:2.35 03:41:01 INFO - PID 24125 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 100.0 99.0 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 03:41:01 INFO - PID 24125 | Values: 54.0 52.0 53.0 53.0 53.0 52.0 54.0 54.0 54.0 54.0 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#9] json-stringify-tinderbox Cycles:10 Average:38.80 Median:38.00 stddev:2.90 (7.6%) stddev-sans-first:3.00 03:41:01 INFO - PID 24125 | Values: 37.0 38.0 38.0 38.0 38.0 38.0 38.0 47.0 38.0 38.0 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.00 stddev:1.85 (2.4%) stddev-sans-first:1.24 03:41:01 INFO - PID 24125 | Values: 80.0 77.0 75.0 75.0 77.0 75.0 75.0 74.0 77.0 74.0 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#11] stanford-crypto-ccm Cycles:10 Average:115.20 Median:115.00 stddev:4.39 (3.8%) stddev-sans-first:4.50 03:41:01 INFO - PID 24125 | Values: 112.0 118.0 126.0 110.0 115.0 115.0 114.0 112.0 115.0 115.0 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:177.00 stddev:5.60 (3.2%) stddev-sans-first:5.89 03:41:01 INFO - PID 24125 | Values: 178.0 186.0 179.0 171.0 183.0 176.0 175.0 173.0 170.0 169.0 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:3.27 (4.8%) stddev-sans-first:3.46 03:41:01 INFO - PID 24125 | Values: 67.0 67.0 64.0 65.0 68.0 71.0 65.0 66.0 68.0 75.0 03:41:01 INFO - PID 24125 | -------- Summary: end -------- 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 03:41:01 INFO - PID 24125 | 03:41:01 INFO - PID 24125 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:41:02 INFO - TEST-INFO | 24125: exit 0 03:41:02 INFO - TEST-OK | kraken | took 61405ms 03:41:02 INFO - SUITE-END | took 1170s 03:41:02 INFO - Completed test suite (00:19:31) 03:41:02 INFO - javascript benchmark 03:41:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8539.226293993495, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.489739193033, 3106.906792796216, 3123.1255248530406, 3143.1984843864825, 3153.5585018097454, 6089.0, 6205.162303089081, 6232.2832874219475, 6250.874982500347, 6285.994240921454, 6184.072389141631, 6278.654673992928, 6342.841428964278, 6345.365463453652, 6399.296077431491, 5812.4768770810615, 5878.059510478324, 5879.088741245114, 5887.116932460122, 5896.262967129109, 5632.3804381518, 5720.8283751487525, 5777.393373695764, 5807.564432667546, 5816.302043754756, 5713.371529131792, 5783.363829978699, 5785.363610002896, 5812.651240925516, 5849.941500584982, 5590.8043218487155, 5661.405552416978, 5665.886682266373, 5685.204071430003, 5691.800786972436, 5653.462921022497, 5689.487946084872, 5720.227769251181, 5722.713864306768, 5723.284589426322, 6128.0, 6201.503879689614, 6250.0, 6271.498280137578, 6281.057841323793, 6591.868162636768, 6623.105880706091, 6701.631410272433, 6703.631300278483, 6732.427743641796, 6539.215294164731, 6610.537262391635, 6664.833379165511, 6680.799576012679, 6825.317468253184, 6229.626222426624, 6252.249730032379, 6271.811845644638, 6340.144080549113, 6346.714397852108, 6915.343042410963, 6918.342757438036, 6921.411680007256, 6991.580505169706, 7002.299770023059, 6378.234611846516, 6516.902246466307, 6568.408843204134, 6670.933290667128, 6688.4649228061635, 6713.026611141455, 6717.664116794239, 6723.226828914738, 6756.695948682321, 6761.425278851353, 6663.733450662016, 6667.86664266712, 6749.122614060141, 6749.257581666013, 6753.3921947025, 6662.233843108008, 6687.832804179934, 6691.933080669131, 6777.8983315249325, 6780.0, 5139.100657385017, 5169.095408303532, 5224.738763061831, 5310.787568497217, 5327.627066105335, 4620.283856002325, 4680.7191568506, 4686.226772582554, 4686.906261874743, 4711.1519926413575, 5737.168110624019, 5740.167675687002, 5740.6268592541355, 5815.563832712563, 5817.418258174149, 6578.111954886125, 6690.364415380531, 6729.192496900403, 6832.45340372769, 6836.897446538306, 5719.8570035749435, 5781.768729250867, 5785.074388097968, 5800.4199580042505, 5819.941800582024, 5707.800226992035, 5787.421257874179, 5789.160571717078, 5853.443922827325, 5881.41185881417, 6377.234731832117, 6399.13611662429, 6499.09012738217, 6508.284088750233, 6639.800805975829, 6802.557833740791, 6839.1451068616425, 6859.588424694534, 6888.827779305558, 6905.998630198593, 6260.906086408617, 6510.869782604226, 6515.511336649865, 6607.867842643024, 6610.3720146586, 6543.738250469928, 6551.934480655133, 6553.606783593, 6555.704993275219, 6565.244996825426, 6651.068850360856, 6652.83367915806, 6653.068570400051, 6661.800145995628, 6675.265720770614, 6337.2395312562785, 6417.133686952202, 6418.614883107029, 6427.357264273535, 6428.0, 6434.935650643621, 6531.738730450728, 6651.235107962452, 6667.19993600771, 6673.265940746611, 6505.642189679613, 6511.120998665119, 6570.8357291068105, 6589.604623722592, 6593.241777195492, 6580.473562115115, 6604.570702904296, 6617.239017513048, 6660.700268487833, 6718.496112791658, 6328.6202827830475, 6342.714577843916, 6431.260405053479, 6432.45324147434, 6445.4199122079235], "value": 6112.593768399149, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.1396835544191, 793.480270422873, 830.5888585150348, 831.6299246835157, 842.4313588327877, 41176.38235426467, 42016.0, 42135.99999999996, 42137.78931105344, 42287.78856105723, 38270.23459530808, 38458.8077059615, 38482.23035539287, 38497.422538661944, 38557.42163867544, 6966.477514186444, 7088.893666595005, 7090.468214883878, 7091.645417729119, 7095.787126386217, 6986.336298051677, 7060.329268719489, 7060.89408658868, 7067.151941766995, 7097.787066388017, 7052.929470705279, 7078.327558881898, 7080.256573059806, 7080.787576372692, 7827.6477558510005, 7858.489198202098, 7916.762497125095, 7917.445778795515, 7918.0, 7938.206179382045, 7819.3744500439825, 7868.488548244346, 7876.488028278143, 7882.054153501616, 7889.053313602347, 38918.0, 38938.221235575416, 39625.20749585021, 39690.0, 39770.20459590821, 3409.641987591292, 3442.862285508577, 3446.1556918555116, 3450.9654903450896, 3460.8788692395647, 32475.350492990245, 32584.837075814707, 32625.0, 32634.184145396317, 32689.0, 5237.083510385667, 5253.579713622901, 5266.368035835686, 5281.392639846428, 5323.121684922022, 183311.0, 183677.0, 183682.0, 184092.0795396028, 184569.0, 48961.26558101631, 49196.26205606919, 49262.26106608404, 49265.50734492609, 49317.50682493129, 49575.50424495709, 49689.0, 50024.24963625549, 50053.0, 50303.49696502988, 15178.544643660707, 15329.846701532842, 15342.616434589225, 15348.386064557517, 15351.0, 12330.938345308216, 12337.198082124813, 12344.567940122231, 12346.876531234573, 12352.567660132032, 14312.785308220386, 14419.134851908919, 14466.782998255034, 14510.419583216553, 14573.0, 5760.251167348301, 5799.3040835100055, 5955.493783028404, 5967.9701601491715, 5989.520838332923, 987.6543209876486, 1011.8735158105237, 1016.4612755239734, 1021.6781713760141, 1033.4677641014882, 22649.547009059726, 22791.772082278963, 22844.771552284263, 22990.42523936915, 23046.308610741704, 1095.8411030400548, 1098.5001824169983, 1109.3732041396747, 1113.7382715062115, 1115.7489564847845, 11953.880461195276, 12138.514459421702, 12252.20360676571, 12274.324912129918, 12294.323812190416, 227557.0, 229473.0, 229569.0, 229877.0, 230290.0, 52182.47817521776, 52857.7357113212, 53793.73103134459, 56228.71885640546, 56378.43621563814, 1436.6336584171179, 1438.3814959567487, 1453.6583902782627, 1461.7734251191082, 1464.4330566294177, 27108.72891271062, 27285.72714272832, 27339.86330068337, 27573.862130689216, 27683.861580692774, 38011.23977520379, 38060.80969595134, 38149.23701526009, 38164.427533586466, 38234.426483603325, 204881.0, 205415.0, 205639.0, 205766.0, 205890.0, 34030.82984585061, 35149.29701406009, 35345.1163720909, 35363.82318088496, 35598.28803423969, 44193.77903110464, 44740.77629611831, 44850.551494484636, 44877.326840098074, 45022.54977450184, 31801.204969875937, 31907.840460797546, 32072.03783886487, 32642.0, 32876.835615821765, 31645.36709265848, 31713.5242971351, 32084.197895051875, 32222.35555288928, 32272.83863580667, 35428.0, 36706.26587468182, 36791.26417471689, 36867.81566092152, 37245.81377093206, 31336.21659458532, 31368.68631313749, 31375.0, 31449.842750786098, 31554.526682100248, 23046.193383231508, 23346.416339590967, 23358.76641233634, 23475.882620586788, 23502.294931152093], "value": 17136.69004409073, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.5743192605546, 569.99715001425, 570.6604570280682, 577.3504807092022, 582.6271186440678, 22236.77763222367, 22977.0, 23084.76915230845, 23095.538089238245, 23116.884415577897, 23325.183618573352, 24099.277021689377, 24613.75386246137, 24938.376540586494, 25055.0, 6334.524910631698, 6502.7398904043785, 6512.0, 6515.3484651534945, 6532.804015879531, 6405.647689377082, 6472.805815825533, 6477.708503117371, 6478.157839480885, 6502.837429064264, 6336.239651241857, 6455.031745238205, 6463.547551671361, 6595.67021648918, 6605.471562275031, 6551.115599394092, 6597.80206593803, 6600.3729645683825, 6626.73493060277, 6628.0, 5721.5136713379, 6044.788432404889, 6114.0828875669, 6125.326214116443, 6129.417705317987, 28041.158765237076, 28379.432411351863, 28406.0, 28420.0, 28429.147125586267, 2018.0716870239708, 2037.9388618341472, 2038.011564391269, 2039.785822488647, 2042.5404284036122, 18322.725159122623, 18786.436406907815, 19119.23523059076, 19133.61732765337, 19133.9043304784, 2374.5963186258377, 2421.8910149043336, 2422.7819496245424, 2434.464417828075, 2462.827602067856, 119737.0, 126428.0, 134847.0, 141322.0, 141938.2903085478, 13357.46570137203, 13860.722785544232, 13983.720325593431, 14398.20809855468, 14576.854231457763, 22036.228731994303, 22067.227647032276, 22118.668219976713, 22123.668144977837, 22137.778622213893, 9884.80230395388, 10001.49992500372, 10108.1408080314, 10112.241581881388, 10112.342697724624, 9116.726498205064, 9284.48935308551, 9337.579808908615, 9454.527273636291, 9471.337006409485, 8585.527795971157, 8723.738287851374, 8806.47161170319, 8969.327300452493, 8998.59506322204, 2570.7943364530793, 2589.6892372914995, 2651.801114916389, 2714.714954929704, 2812.1141840320233, 940.229012209995, 955.3360414511848, 959.318883592643, 964.4261664309724, 980.5146452505912, 18695.626087478173, 18786.906065469586, 19054.714179287323, 19099.522511937033, 19305.420837374902, 998.7602975285879, 1025.195221750922, 1026.645807196516, 1030.4950574218578, 1033.5968972100886, 10509.421981791074, 10587.0, 10648.840267395995, 10657.626983055556, 10850.186236032328, 431134.0, 434049.1487712832, 441688.0, 443298.0, 451690.0, 104771.0, 106158.0, 108103.0, 109698.45150774355, 110398.44800775945, 1119.1047162270313, 1131.5869707556683, 1156.8958793708607, 1157.0454375140544, 1162.2561560601223, 16757.07836069028, 16851.0, 16926.57683557921, 16953.745693814355, 17142.314307428063, 54099.72950135224, 54632.0, 55612.72193639006, 56655.0, 56901.71549142228, 69152.0, 69213.0, 69607.0, 69655.0, 69778.65110674415, 13766.587002389944, 14127.505537306144, 14213.0, 14227.573172804417, 14283.214423206824, 22264.0, 22272.554548909255, 22278.220262290743, 22325.888370558045, 22442.0, 17343.219555120304, 17514.649707006043, 17619.20713567867, 17653.82346176522, 17662.823371766117, 15787.605309867346, 16160.272787724816, 16195.190240488164, 16722.916385417993, 16872.57818554546, 18145.0, 18191.45425637233, 18281.26874924988, 18416.17127229251, 18450.35423760162, 13807.585772426843, 13850.238236896665, 13935.163890166623, 14002.649933751738, 14032.438702452197, 17243.482695519153, 17530.649387012443, 17667.0, 17781.4885734714, 18054.458366249033], "value": 11644.941120826106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.3558288647118, 1380.8619138086192, 1387.7710177820647, 1388.2156581531433, 1393.8397084335297, 14914.701705965888, 15485.767713484307, 15524.146171960538, 15553.844461555382, 15555.688886222282, 15103.471378501727, 15234.695306093872, 15243.542693719179, 15281.312340944656, 15283.465078722247, 2769.487644785711, 2790.4419116176746, 2832.6884042755282, 2833.305840069186, 2838.148555433372, 2732.631094802206, 2801.6918139004797, 2803.8738256778493, 2806.6070750095005, 2818.041865765639, 2699.8785054672585, 2776.3336799168155, 2824.5621928601, 2828.915132546027, 2834.178088354385, 2751.7523422891836, 2773.5423655096884, 2776.694563598003, 2797.1888152435768, 2798.720127987205, 2680.463907218564, 2691.5962605609316, 2707.2690373599216, 2722.0, 2742.3418379588957, 14812.481563145238, 15194.0, 15217.543473695696, 15227.314770835228, 15286.770698439532, 7953.204679532, 8302.584870756498, 8303.460275082161, 8321.66713331466, 8348.0, 5137.409197942247, 5198.246254293144, 5278.630495865291, 5351.6521426107565, 5352.143657014859, 1654.69388163189, 1672.406295764998, 1678.7146185148554, 1709.435886157565, 1713.5716070982255, 26292.605610915853, 26511.337216569547, 26530.806113724735, 26553.867230663724, 26603.334916627045, 7399.6670149843385, 7412.221716719775, 7625.313721764956, 7679.155292917774, 7703.537787732642, 17204.0, 17286.481405557854, 17322.740158897628, 17328.133593320283, 17338.826611733723, 7995.880061799077, 8110.310623596943, 8111.675532978733, 8133.633986470623, 8147.063087744867, 7214.0, 7272.745453909088, 7457.366123879422, 7468.626568671545, 7540.660670269851, 5069.822556210515, 5238.449962753933, 5251.606129540223, 5283.841484755387, 5293.444188360244, 1440.4598275646633, 1474.2481334519473, 1576.9448069317518, 1589.6343840916654, 1608.9436869709505, 906.4425378392373, 941.8540126280437, 950.1353768071023, 951.048951048951, 962.9037096290455, 8505.74482765518, 8607.397482176188, 8676.34927380449, 8798.164174403422, 8829.735107946772, 720.5064530796421, 728.7777227945528, 729.5622626424104, 742.4097842215451, 807.2290962131151, 5282.550983166397, 5298.940211957547, 5312.495312945264, 5369.892602147936, 5381.246625472437, 20406.0, 20926.790732092486, 21719.348419547438, 21753.89123054406, 21770.564588708454, 21580.352589422342, 22043.779562204494, 22076.88961555214, 22106.44733881666, 22126.668099978513, 9962.252831037702, 10705.9464702676, 10798.082163016075, 10833.404162771123, 10835.349879007126, 7591.8861217082895, 7900.249476299742, 7904.446688731734, 7937.563434011185, 7938.166492518202, 18324.633507330047, 18337.449876503728, 18637.534061648566, 18643.627127457647, 18762.906185468986, 19100.713489297395, 19116.426507204807, 19183.904080479508, 19279.80720192836, 19306.7103993443, 10784.299020563638, 10877.728056798644, 10926.071283940953, 10956.671299861016, 10971.835422468828, 13982.790258146339, 14163.858361416254, 14172.0, 14174.433022678977, 14191.290435477978, 11276.492557834754, 11291.3789741565, 11435.428228588704, 11546.538138474367, 11697.590584329508, 11126.61056863006, 11162.49768760424, 11202.495887685236, 11336.829947550628, 11505.137114716263, 9248.16766491019, 9383.530823458663, 9401.435913845191, 9430.62277508892, 9459.290553208675, 6997.965010174917, 7000.929990700028, 7012.2286548478605, 7029.156501219886, 7124.964375178091, 7121.287871212838, 7180.1742799578715, 7225.6387180641805, 7296.635168241461, 7337.70649174027], "value": 6652.263974493249, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.9774560144793, 507.4266079330356, 528.5401700520548, 529.6266132376675, 536.0779459329954, 6231.158793562868, 6283.968580157099, 6297.338779428152, 6352.174217351743, 6373.9362606373925, 6011.5190784737115, 6068.302145253286, 6128.387161283869, 6130.693465326738, 6203.31763506014, 4891.853244402673, 4965.0, 5021.397432308119, 5031.899362012758, 5050.747462626872, 4989.55094041538, 4999.850004499871, 5021.246812978065, 5022.936009034504, 5025.321581586476, 4918.466989500393, 4981.950180498185, 4985.227289770091, 5027.4972502749615, 5066.695998240099, 5004.449510553836, 5028.95169388642, 5040.2187660912805, 5042.84871453857, 5079.136546787018, 4527.796249168795, 4529.165687896407, 4533.365328853963, 4540.614047805941, 4553.931691024637, 5986.880262394728, 6080.635161890256, 6136.969315153396, 6149.907751383733, 6238.875222495525, 5679.0, 5691.463304907693, 5714.7428365723645, 5749.770009199627, 5764.5676574257095, 6606.588595162731, 6615.735370585171, 6660.733570657168, 6668.366505182, 6687.732490700366, 4931.3589233399425, 4932.778024988884, 4935.950640493621, 4950.628702847301, 4963.081829861451, 6925.58446493207, 6995.335443132894, 7018.508704390695, 7027.472939529555, 7047.43620510358, 5053.898922021539, 5079.6474326944035, 5091.632390938232, 5091.949080509222, 5094.847154585368, 5139.331886854685, 5143.6399452037995, 5146.459621739738, 5159.17453207485, 5205.115130427836, 5670.0, 5696.51579615729, 5750.281214848144, 5763.85590360236, 5781.8554536136935, 6342.968285158637, 6408.487321014308, 6604.1084453599115, 6612.537122401482, 6686.765963191265, 1751.089433494601, 1757.2268201991083, 1760.5158581389965, 1766.6025144342677, 1767.5404394857173, 1215.2526196389333, 1215.732538841471, 1231.5751065882257, 1235.6540168752763, 1236.9257844529357, 5588.972055139699, 5804.216430781875, 5821.27234095738, 5839.357670656224, 5865.5600829937075, 6833.384995350442, 6865.759698410531, 6869.175698916162, 6898.896516552256, 6908.3437073477935, 5724.77100915967, 5777.480026797609, 5783.739731712083, 5798.246227990418, 5799.3040835100055, 3601.423772196436, 3608.6391360864227, 3624.365735996243, 3630.43728222126, 3649.616790236987, 6443.903341449882, 6534.542582019308, 6575.200103924067, 6577.908383059954, 6592.8351791205605, 6790.5925644461495, 6825.35159159879, 6911.410375613536, 6921.688524016431, 6973.4072603829245, 6448.387403196689, 6489.870202595922, 6502.846119631975, 6579.4736421085245, 6636.701348439332, 6652.368025037614, 6687.732490700318, 6700.93299067003, 6729.69716362755, 6859.416949559144, 6614.140161778938, 6648.601083934979, 6657.900131498128, 6673.566218195801, 6752.324767523209, 6563.343665633399, 6571.507136964651, 6584.604923704593, 6589.703463344257, 6662.733490660319, 4976.726280054487, 5001.899962000813, 5003.649744517995, 5004.949950500449, 5016.899662006813, 6795.93702691498, 6826.795196144124, 6831.316868313328, 6854.5201835873, 6904.171499420102, 6510.869782604416, 6521.739130434919, 6609.570377925419, 6627.436667883091, 6649.567778094409, 6430.421262086435, 6472.867248231447, 6493.155889734304, 6527.249366322743, 6593.0, 6444.806655800334, 6473.087110800065, 6490.902636460362, 6504.219493660791, 6519.250286216956, 6147.44672979434, 6628.337166283333, 6628.502862285444, 6655.467562595078, 6660.83347916306, 6338.651374174465, 6375.0, 6406.295307516262, 6407.455366293917, 6436.292007879036], "value": 5092.973780631137, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.8800011998378, 908.3459908865616, 942.6700654770831, 946.3895787217245, 954.3271993244763, 19307.903460482696, 20227.494312642193, 20272.087756050994, 20285.0871710773, 20351.389458316273, 17301.30794768208, 17584.912075439606, 17856.553586160353, 17888.82111178888, 18045.368412105578, 948.3124734567418, 970.3838062830083, 972.1930797438145, 974.990250097497, 977.2475194100539, 962.874826272587, 994.990085063661, 996.7209181429212, 996.9501524923761, 999.8900120986685, 1062.984055239172, 1065.350136416785, 1066.2909165404997, 1066.5787014129414, 1066.9413182275011, 1009.198580533751, 1019.6584144311664, 1060.2790102730141, 1061.262422616282, 1061.8991195836384, 750.5684231566871, 750.8348163404042, 751.1061836414649, 751.4138971602159, 752.39808153477, 18628.0, 18689.345872894384, 18755.437336879917, 18765.0, 18773.530661733566, 20508.69236961447, 20642.07110680023, 20910.0, 20986.0, 21031.47421314464, 17394.21726022332, 17464.91267543667, 17621.0, 17938.0, 18016.189271482814, 3664.2488289900507, 3681.3557627415094, 3684.410494320896, 3684.6499582539614, 3686.041629176407, 138855.0, 139441.3027934864, 141104.0, 141439.0, 144537.0, 16702.331906723837, 16921.7461738074, 17178.1410929453, 17361.47915562535, 17383.043932583576, 30595.0, 30967.225819354248, 31184.53223201654, 31338.843305783324, 31747.0, 8099.433039687283, 8178.754637360888, 8193.46742461738, 8193.50838949665, 8197.672093116327, 4239.745615263032, 4252.447181866338, 4327.415798867112, 4339.370791235253, 4369.71596846204, 5360.91958620621, 5471.2887324647545, 5472.179173124063, 5501.917471237854, 5503.394626591072, 935.1770442010986, 942.5004747483845, 967.9661211857551, 973.8344481438172, 978.9461579613047, 697.9092717946635, 713.5336882706089, 714.6783947223666, 720.9243029481934, 728.3735987051132, 11604.477798499087, 11644.825327620092, 11781.469833857325, 12399.614198687683, 12568.120231583884, 682.8907374820005, 690.5683947532792, 695.6799872058909, 697.4524997876642, 709.5919846088519, 5551.250581171571, 5595.580331475156, 5662.405447427961, 5705.5720820938595, 5709.371969083398, 122507.38746306211, 123043.33271712631, 123389.0, 124670.0, 127615.0, 92672.07327926769, 97288.0, 105583.0, 114754.0, 124608.37695811644, 94636.52681736548, 97074.51462742641, 97922.5103874476, 98223.50888245513, 101112.0, 12019.278843269432, 12408.317542535247, 12714.61856144317, 12921.0, 13355.131916425402, 42251.57748422476, 43528.0, 43639.12721745611, 43951.560484394744, 44816.55183448124, 82748.58625706832, 83292.0, 84898.57550712206, 86598.0, 88083.55958220168, 18772.342967996054, 19142.138603762585, 19348.032598370308, 19388.0305984703, 19479.70780438323, 21140.0, 21637.0, 22304.330870073925, 22364.217252396087, 22377.888110559343, 18455.354062608283, 18547.258109675462, 18558.536036599195, 18713.15790789445, 18820.435386938414, 18117.27530898802, 18217.908910455364, 18259.269629215214, 18332.17505212242, 18382.90808546002, 18611.348602798837, 18801.341953031577, 18816.059197040366, 19022.0, 19034.904825475784, 13567.932160339134, 13744.175349479063, 13996.37016334247, 14019.859801402263, 14203.28983550839, 13398.397072131973, 13745.862541374458, 13799.10305830158, 13839.654008649864, 13933.372998215307], "value": 9381.128124814464, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1432.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 107.0, 108.0, 110.0, 107.0, 109.0, 110.0, 106.0, 107.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 118.0, 117.0, 115.0, 117.0, 116.0, 118.0, 117.0, 115.0, 116.0], "value": 118.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 168.0, 169.0, 167.0, 164.0, 173.0, 170.0, 166.0, 164.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 75.0, 75.0, 74.0, 74.0, 74.0, 76.0, 74.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 80.0, 79.0, 80.0, 81.0, 80.0, 79.0, 79.0], "value": 79.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 113.0, 115.0, 113.0, 116.0, 114.0, 117.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 149.0, 148.0, 149.0, 149.0, 148.0, 149.0, 149.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 100.0, 99.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 53.0, 53.0, 52.0, 54.0, 54.0, 54.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 47.0, 38.0, 38.0], "value": 38.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 75.0, 75.0, 77.0, 75.0, 75.0, 74.0, 77.0, 74.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 118.0, 126.0, 110.0, 115.0, 115.0, 114.0, 112.0, 115.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 186.0, 179.0, 171.0, 183.0, 176.0, 175.0, 173.0, 170.0, 169.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 64.0, 65.0, 68.0, 71.0, 65.0, 66.0, 68.0, 75.0], "value": 67.6, "unit": "score"}]}]} 03:41:02 INFO - Return code: 0 03:41:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:41:02 INFO - # TBPL SUCCESS # 03:41:02 INFO - Running post-action listener: _package_coverage_data 03:41:02 INFO - Running post-action listener: _resource_record_post_action 03:41:02 INFO - [mozharness: 2017-09-13 10:41:02.605723Z] Finished run-tests step (success) 03:41:02 INFO - Running post-run listener: _resource_record_post_run 03:41:02 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 131072; Write bytes: 405303296; Read time: 8; Write time: 300204 03:41:02 INFO - TinderboxPrint: CPU usage
13.1% 03:41:02 INFO - TinderboxPrint: I/O read bytes / time
131,072 / 8 03:41:02 INFO - TinderboxPrint: I/O write bytes / time
405,303,296 / 300,204 03:41:02 INFO - TinderboxPrint: CPU idle
8,234.4 (86.9%) 03:41:02 INFO - TinderboxPrint: CPU user
1,192.1 (12.6%) 03:41:02 INFO - TinderboxPrint: Swap in / out
0 / 0 03:41:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 74219520; Read time: 0; Write time: 34136 03:41:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:41:02 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 131072; Write bytes: 331083776; Read time: 8; Write time: 266068 03:41:03 INFO - Running post-run listener: _upload_blobber_files 03:41:03 INFO - Blob upload gear active. 03:41:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:41:03 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 03:41:03 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'] 03:41:03 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 03:41:03 INFO - (blobuploader) - INFO - Open directory for files ... 03:41:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:41:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:04 INFO - (blobuploader) - INFO - Done attempting. 03:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:41:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:05 INFO - (blobuploader) - INFO - Done attempting. 03:41:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:41:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:41:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:12 INFO - (blobuploader) - INFO - Done attempting. 03:41:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:41:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:41:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:12 INFO - (blobuploader) - INFO - Done attempting. 03:41:12 INFO - (blobuploader) - INFO - Iteration through files over. 03:41:12 INFO - Return code: 0 03:41:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:41:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:41:12 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7cbc4f8233427cc8dde0e63cbf449812f298beb62b77cf2268d9f638ab66aa775c5e0e089fdad208a0aa4f3652e4219e36fa6e353d3c7de474fbf82f73a6cc4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb5ec73a1ecdfdea50219922597cab8bbaaed9b465f43fcc98aa0f4ec2a9f3dd69f8e96c9be31f813328fc4c031bcc570727f4d1f5f8d9fb8cb6c2ebca260263", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5a5acbd6df51c82a4e6fac1c7617aa201c065b1f284fb92e53984ae55bb12e775cfd24accad9c6a445fa81aae2cb8842bfc386d61c34e3e1852ee94476e6ce6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cacf002c04c7497c351738cb344cbb74b40b3832de7555249efdc4ab6d350736042905bc2192f745985575189516ad62cf57936dc60e916e426cb5c21e035909"} 03:41:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:41:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:41:12 INFO - Contents: 03:41:12 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7cbc4f8233427cc8dde0e63cbf449812f298beb62b77cf2268d9f638ab66aa775c5e0e089fdad208a0aa4f3652e4219e36fa6e353d3c7de474fbf82f73a6cc4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb5ec73a1ecdfdea50219922597cab8bbaaed9b465f43fcc98aa0f4ec2a9f3dd69f8e96c9be31f813328fc4c031bcc570727f4d1f5f8d9fb8cb6c2ebca260263", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5a5acbd6df51c82a4e6fac1c7617aa201c065b1f284fb92e53984ae55bb12e775cfd24accad9c6a445fa81aae2cb8842bfc386d61c34e3e1852ee94476e6ce6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cacf002c04c7497c351738cb344cbb74b40b3832de7555249efdc4ab6d350736042905bc2192f745985575189516ad62cf57936dc60e916e426cb5c21e035909"} 03:41:12 INFO - Running post-run listener: copy_logs_to_upload_dir 03:41:12 INFO - Copying logs to upload dir... 03:41:12 INFO - mkdir: /builds/slave/test/build/upload/logs 03:41:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.009680 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-13 03:41:13.007415) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 03:41:13.010472) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856 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/f7cbc4f8233427cc8dde0e63cbf449812f298beb62b77cf2268d9f638ab66aa775c5e0e089fdad208a0aa4f3652e4219e36fa6e353d3c7de474fbf82f73a6cc4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb5ec73a1ecdfdea50219922597cab8bbaaed9b465f43fcc98aa0f4ec2a9f3dd69f8e96c9be31f813328fc4c031bcc570727f4d1f5f8d9fb8cb6c2ebca260263", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5a5acbd6df51c82a4e6fac1c7617aa201c065b1f284fb92e53984ae55bb12e775cfd24accad9c6a445fa81aae2cb8842bfc386d61c34e3e1852ee94476e6ce6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cacf002c04c7497c351738cb344cbb74b40b3832de7555249efdc4ab6d350736042905bc2192f745985575189516ad62cf57936dc60e916e426cb5c21e035909"} build_url:https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7cbc4f8233427cc8dde0e63cbf449812f298beb62b77cf2268d9f638ab66aa775c5e0e089fdad208a0aa4f3652e4219e36fa6e353d3c7de474fbf82f73a6cc4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb5ec73a1ecdfdea50219922597cab8bbaaed9b465f43fcc98aa0f4ec2a9f3dd69f8e96c9be31f813328fc4c031bcc570727f4d1f5f8d9fb8cb6c2ebca260263", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5a5acbd6df51c82a4e6fac1c7617aa201c065b1f284fb92e53984ae55bb12e775cfd24accad9c6a445fa81aae2cb8842bfc386d61c34e3e1852ee94476e6ce6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cacf002c04c7497c351738cb344cbb74b40b3832de7555249efdc4ab6d350736042905bc2192f745985575189516ad62cf57936dc60e916e426cb5c21e035909"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 03:41:13.038558) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:41:13.038849) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1505271898.953900-1346883856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:41:13.121892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 03:41:13.122203) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 03:41:13.122497) ========= ========= Total master_lag: 0.22 =========