builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-011 starttime: 1506336936.32 results: success (0) revision: 5f3f19824efa14cc6db546baf59c54a0fc15ddc9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 03:55:36.315777) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 03:55:36.316260) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 03:55:36.316544) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 03:55:36.333793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:55:36.334210) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 03:55:36-- 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% 46.5M=0s 2017-09-25 03:55:36 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132813 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:55:36.484113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:55:36.484491) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015513 ========= master_lag: 0.47 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:55:36.970028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 03:55:36.970388) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5f3f19824efa14cc6db546baf59c54a0fc15ddc9 --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 5f3f19824efa14cc6db546baf59c54a0fc15ddc9 --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=5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 03:55:37,039 truncating revision to first 12 chars 2017-09-25 03:55:37,039 Setting DEBUG logging. 2017-09-25 03:55:37,039 attempt 1/10 2017-09-25 03:55:37,039 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5f3f19824efa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 03:55:38,373 unpacking tar archive at: mozilla-central-5f3f19824efa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.617894 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 03:55:38.615757) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 03:55:38.616251) ========= script_repo_revision: 5f3f19824efa14cc6db546baf59c54a0fc15ddc9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 03:55:38.616767) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 03:55:38.617043) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 03:55:38.635161) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-25 03:55:38.635591) ========= /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=5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:55:38 INFO - MultiFileLogger online at 20170925 03:55:38 in /builds/slave/test 03:55:38 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:55:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:55:38 INFO - {'append_to_log': False, 03:55:38 INFO - 'base_work_dir': '/builds/slave/test', 03:55:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:55:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:55:38 INFO - 'branch': 'Firefox-Non-PGO', 03:55:38 INFO - 'buildbot_json_path': 'buildprops.json', 03:55:38 INFO - 'code_coverage': False, 03:55:38 INFO - 'config_files': ('talos/linux_config.py',), 03:55:38 INFO - 'default_actions': ('clobber', 03:55:38 INFO - 'read-buildbot-config', 03:55:38 INFO - 'download-and-extract', 03:55:38 INFO - 'populate-webroot', 03:55:38 INFO - 'create-virtualenv', 03:55:38 INFO - 'install', 03:55:38 INFO - 'setup-mitmproxy', 03:55:38 INFO - 'run-tests'), 03:55:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:55:38 INFO - 'disable_ccov_upload': False, 03:55:38 INFO - 'disable_stylo': False, 03:55:38 INFO - 'download_minidump_stackwalk': True, 03:55:38 INFO - 'download_symbols': 'ondemand', 03:55:38 INFO - 'enable_stylo': False, 03:55:38 INFO - 'enable_webrender': False, 03:55:38 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:55:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:55:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:55:38 INFO - 'gecko_profile': False, 03:55:38 INFO - 'gecko_profile_interval': 0, 03:55:38 INFO - 'installer_path': 'installer.exe', 03:55:38 INFO - 'log_level': 'info', 03:55:38 INFO - 'log_name': 'talos', 03:55:38 INFO - 'log_to_console': True, 03:55:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:55:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:55:38 INFO - 'opt_config_files': (), 03:55:38 INFO - 'pip_index': False, 03:55:38 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:55:38 INFO - 'system_bits': '32', 03:55:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:55:38 INFO - 'title': 'talos-linux64-ix-011', 03:55:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:55:38 INFO - 'use_talos_json': True, 03:55:38 INFO - 'verify': 'False', 03:55:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:55:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:55:38 INFO - 'work_dir': 'build'} 03:55:38 INFO - [mozharness: 2017-09-25 10:55:38.843525Z] Running clobber step. 03:55:38 INFO - Running pre-action listener: _resource_record_pre_action 03:55:38 INFO - Running main action method: clobber 03:55:38 INFO - rmtree: /builds/slave/test/build 03:55:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:55:40 INFO - Running post-action listener: _resource_record_post_action 03:55:40 INFO - [mozharness: 2017-09-25 10:55:40.354186Z] Finished clobber step (success) 03:55:40 INFO - [mozharness: 2017-09-25 10:55:40.354284Z] Running read-buildbot-config step. 03:55:40 INFO - Running pre-action listener: _resource_record_pre_action 03:55:40 INFO - Running main action method: read_buildbot_config 03:55:40 INFO - Using buildbot properties: 03:55:40 INFO - { 03:55:40 INFO - "project": "", 03:55:40 INFO - "product": "firefox", 03:55:40 INFO - "who": "archaeopteryx@coole-files.de", 03:55:40 INFO - "installer_path": "public/build/target.tar.bz2", 03:55:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:55:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:55:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:55:40 INFO - "stage_platform": "linux64", 03:55:40 INFO - "basedir": "/builds/slave/test", 03:55:40 INFO - "buildnumber": 68, 03:55:40 INFO - "platform": "ubuntu64_hw", 03:55:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:55:40 INFO - "slavebuilddir": "test", 03:55:40 INFO - "taskId": "ac-Vmmp5R9yhpSg9Cw22Cg", 03:55:40 INFO - "branch": "mozilla-central", 03:55:40 INFO - "script_repo_revision": "production", 03:55:40 INFO - "revision": "5f3f19824efa14cc6db546baf59c54a0fc15ddc9", 03:55:40 INFO - "slavename": "talos-linux64-ix-011", 03:55:40 INFO - "repo_path": "mozilla-central" 03:55:40 INFO - } 03:55:40 INFO - Finding installer, test and symbols from parent task. 03:55:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ac-Vmmp5R9yhpSg9Cw22Cg'}, attempt #1 03:55:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ac-Vmmp5R9yhpSg9Cw22Cg'}, attempt #1 03:55:41 INFO - Task dependencies: SaUzvixmSkCRJGqkRd3BZQ 03:55:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ'}, attempt #1 03:55:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.tar.bz2 03:55:41 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.test_packages.json 03:55:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.crashreporter-symbols.zip 03:55:41 INFO - Running post-action listener: _resource_record_post_action 03:55:41 INFO - [mozharness: 2017-09-25 10:55:41.700523Z] Finished read-buildbot-config step (success) 03:55:41 INFO - [mozharness: 2017-09-25 10:55:41.700743Z] Running download-and-extract step. 03:55:41 INFO - Running pre-action listener: _resource_record_pre_action 03:55:41 INFO - Running main action method: download_and_extract 03:55:41 INFO - mkdir: /builds/slave/test/build/tests 03:55:41 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:55:41 INFO - trying https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.test_packages.json 03:55:41 INFO - Downloading https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:55:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:55:42 INFO - Downloaded 989 bytes. 03:55:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:55:42 INFO - Using the following test package requirements: 03:55:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:55:42 INFO - u'common': [u'target.common.tests.zip'], 03:55:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:55:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:55:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:55:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:55:42 INFO - u'mozbase': [u'target.common.tests.zip'], 03:55:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:55:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:55:42 INFO - u'web-platform': [u'target.common.tests.zip', 03:55:42 INFO - u'target.web-platform.tests.tar.gz'], 03:55:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:55:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:55:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.common.tests.zip 03:55:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:55:42 INFO - Fetch https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.common.tests.zip into memory 03:55:43 INFO - Content-Length response header: 54943940 03:55:43 INFO - Bytes received: 54943940 03:55:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.talos.tests.zip 03:55:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:55:54 INFO - Fetch https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.talos.tests.zip into memory 03:55:55 INFO - Content-Length response header: 14513823 03:55:55 INFO - Bytes received: 14513823 03:55: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:55:55 INFO - trying https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.tar.bz2 03:55:55 INFO - Downloading https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:55:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:55:56 INFO - Downloaded 61631429 bytes. 03:55:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.tar.bz2 03:55:56 INFO - mkdir: /builds/slave/test/properties 03:55:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:55:56 INFO - Writing to file /builds/slave/test/properties/build_url 03:55:56 INFO - Contents: 03:55:56 INFO - build_url:https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.tar.bz2 03:55:56 INFO - Running post-action listener: _resource_record_post_action 03:55:56 INFO - Running post-action listener: find_tests_for_verification 03:55:56 INFO - Running post-action listener: set_extra_try_arguments 03:55:56 INFO - [mozharness: 2017-09-25 10:55:56.812650Z] Finished download-and-extract step (success) 03:55:56 INFO - [mozharness: 2017-09-25 10:55:56.812804Z] Running populate-webroot step. 03:55:56 INFO - Running pre-action listener: _resource_record_pre_action 03:55:56 INFO - Running main action method: populate_webroot 03:55:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:55:56 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:56 INFO - 'tests': ['tresize', 03:55:56 INFO - 'tcanvasmark']}, 03:55:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:55:56 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:56 INFO - 'tests': ['dromaeo_css', 03:55:56 INFO - 'kraken']}, 03:55:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:55:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:56 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:55:56 INFO - 'talos_options': ['--disable-stylo'], 03:55:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:55:56 INFO - 'tests': ['damp', 'tps']}, 03:55:56 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:55:56 INFO - 'talos_options': ['--disable-stylo'], 03:55:56 INFO - 'tests': ['damp', 'tps']}, 03:55:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:55:56 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:56 INFO - 'tests': ['dromaeo_dom']}, 03:55:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:55:56 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:56 INFO - 'tests': ['basic_compositor_video', 03:55:56 INFO - 'glvideo']}, 03:55:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:55:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:55:56 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:55:56 INFO - 'talos_options': ['--disable-stylo'], 03:55:56 INFO - 'tests': ['ts_paint_webext', 03:55:56 INFO - 'tp5o_webext']}, 03:55:56 INFO - 'other-e10s': {'tests': ['a11yr', 03:55:56 INFO - 'ts_paint', 03:55:56 INFO - 'tpaint', 03:55:56 INFO - 'sessionrestore', 03:55:56 INFO - 'sessionrestore_many_windows', 03:55:56 INFO - 'sessionrestore_no_auto_restore', 03:55:56 INFO - 'tabpaint']}, 03:55:56 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:56 INFO - 'tests': ['a11yr', 03:55:56 INFO - 'ts_paint', 03:55:56 INFO - 'tpaint', 03:55:56 INFO - 'sessionrestore', 03:55:56 INFO - 'sessionrestore_many_windows', 03:55:56 INFO - 'sessionrestore_no_auto_restore', 03:55:56 INFO - 'tabpaint']}, 03:55:56 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:55:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:55:56 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:56 INFO - 'tests': ['perf_reftest_singletons']}, 03:55:56 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:56 INFO - 'tests': ['perf_reftest']}, 03:55:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:55:56 INFO - 'tsvgr_opacity', 03:55:56 INFO - 'tart', 03:55:56 INFO - 'tscrollx', 03:55:56 INFO - 'tsvg_static']}, 03:55:56 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:56 INFO - 'tests': ['tsvgx', 03:55:56 INFO - 'tsvgr_opacity', 03:55:56 INFO - 'tart', 03:55:56 INFO - 'tscrollx', 03:55:56 INFO - 'tsvg_static']}, 03:55:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:55:56 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:55:56 INFO - 'talos_options': ['--disable-stylo'], 03:55:56 INFO - 'tests': ['tp5o']}, 03:55:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:55:56 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:55:56 INFO - 'talos_options': ['--mitmproxy', 03:55:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:55:56 INFO - '--firstNonBlankPaint'], 03:55:56 INFO - 'tests': ['tp6_google', 03:55:56 INFO - 'tp6_youtube', 03:55:56 INFO - 'tp6_amazon', 03:55:56 INFO - 'tp6_facebook']}, 03:55:56 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:55:56 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:55:56 INFO - 'talos_options': ['--disable-stylo', 03:55:56 INFO - '--mitmproxy', 03:55:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:55:56 INFO - '--firstNonBlankPaint'], 03:55:56 INFO - 'tests': ['tp6_google', 03:55:56 INFO - 'tp6_youtube', 03:55:56 INFO - 'tp6_amazon', 03:55:56 INFO - 'tp6_facebook']}, 03:55:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:55:56 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:55:56 INFO - 'talos_options': ['--stylo-threads=1', 03:55:56 INFO - '--mitmproxy', 03:55:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:55:56 INFO - '--firstNonBlankPaint'], 03:55:56 INFO - 'tests': ['tp6_google', 03:55:56 INFO - 'tp6_youtube', 03:55:56 INFO - 'tp6_amazon', 03:55:56 INFO - 'tp6_facebook']}, 03:55:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:55:56 INFO - 'talos_options': ['--xperf_path', 03:55:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:56 INFO - 'tests': ['tp5n']}, 03:55:56 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:55:56 INFO - 'talos_options': ['--disable-stylo', 03:55:56 INFO - '--xperf_path', 03:55:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:56 INFO - 'tests': ['tp5n']}}} 03:55:56 INFO - Running post-action listener: _resource_record_post_action 03:55:56 INFO - [mozharness: 2017-09-25 10:55:56.836141Z] Finished populate-webroot step (success) 03:55:56 INFO - [mozharness: 2017-09-25 10:55:56.836250Z] Running create-virtualenv step. 03:55:56 INFO - Running pre-action listener: _resource_record_pre_action 03:55:56 INFO - Running main action method: create_virtualenv 03:55:56 INFO - Creating virtualenv /builds/slave/test/build/venv 03:55:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:55:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:55:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:55:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:55:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:55:57 INFO - Installing distribute.............................................................................................................................................................................................done. 03:55:57 INFO - Installing pip...............done. 03:55:57 INFO - Return code: 0 03:55:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:55:57 INFO - Reading from file tmpfile_stdout 03:55:57 INFO - Output received: 03:55:57 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:55:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:55: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:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55: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:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f77d60>, '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 0x1f78a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f78ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', '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:55: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', 'pip>=1.5'] in /builds/slave/test/build 03:55: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 pip>=1.5 03:55:57 INFO - Using env: {'DISPLAY': ':0', 03:55:57 INFO - 'HOME': '/home/cltbld', 03:55:57 INFO - 'LANG': 'en_US.UTF-8', 03:55:57 INFO - 'LANGUAGE': 'en_US:en', 03:55:57 INFO - 'LOGNAME': 'cltbld', 03:55:57 INFO - 'MAIL': '/var/mail/cltbld', 03:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:57 INFO - 'MOZ_NO_REMOTE': '1', 03:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:57 INFO - 'NO_EM_RESTART': '1', 03:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:57 INFO - 'PWD': '/builds/slave/test', 03:55:57 INFO - 'SHELL': '/bin/bash', 03:55:57 INFO - 'SHLVL': '1', 03:55:57 INFO - 'TERM': 'linux', 03:55:57 INFO - 'TMOUT': '86400', 03:55:57 INFO - 'USER': 'cltbld', 03:55:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', 03:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:57 INFO - '_': '/tools/buildbot/bin/python'} 03:55:59 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:55:59 INFO - Downloading/unpacking pip>=1.5 03:55:59 INFO - Running setup.py egg_info for package pip 03:55:59 INFO - warning: no files found matching 'pip/cacert.pem' 03:55:59 INFO - warning: no files found matching '*.html' under directory 'docs' 03:55:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:55:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:55:59 INFO - Installing collected packages: pip 03:55:59 INFO - Found existing installation: pip 1.1 03:55:59 INFO - Uninstalling pip: 03:55:59 INFO - Successfully uninstalled pip 03:55:59 INFO - Running setup.py install for pip 03:55:59 INFO - warning: no files found matching 'pip/cacert.pem' 03:55:59 INFO - warning: no files found matching '*.html' under directory 'docs' 03:55:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:55:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:55:59 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:55:59 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:55:59 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:55:59 INFO - Successfully installed pip 03:55:59 INFO - Cleaning up... 03:55:59 INFO - Return code: 0 03:55:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:55: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:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55: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:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55: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', '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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f77d60>, '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 0x1f78a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f78ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', '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:55: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:55: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 psutil>=3.1.1 03:55:59 INFO - Using env: {'DISPLAY': ':0', 03:55:59 INFO - 'HOME': '/home/cltbld', 03:55:59 INFO - 'LANG': 'en_US.UTF-8', 03:55:59 INFO - 'LANGUAGE': 'en_US:en', 03:55:59 INFO - 'LOGNAME': 'cltbld', 03:55:59 INFO - 'MAIL': '/var/mail/cltbld', 03:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:59 INFO - 'MOZ_NO_REMOTE': '1', 03:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:59 INFO - 'NO_EM_RESTART': '1', 03:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:59 INFO - 'PWD': '/builds/slave/test', 03:55:59 INFO - 'SHELL': '/bin/bash', 03:55:59 INFO - 'SHLVL': '1', 03:55:59 INFO - 'TERM': 'linux', 03:55:59 INFO - 'TMOUT': '86400', 03:55:59 INFO - 'USER': 'cltbld', 03:55:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', 03:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:59 INFO - '_': '/tools/buildbot/bin/python'} 03:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:59 INFO - Downloading/unpacking psutil>=3.1.1 03:55: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:55: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:55: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:55: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:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:56:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:00 INFO - Installing collected packages: psutil 03:56:00 INFO - Running setup.py install for psutil 03:56:00 INFO - building 'psutil._psutil_linux' extension 03:56:00 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:56:00 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:56:00 INFO - building 'psutil._psutil_posix' extension 03:56:00 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:56:01 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:56:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:01 INFO - Successfully installed psutil 03:56:01 INFO - Cleaning up... 03:56:01 INFO - Return code: 0 03:56:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:56: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:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56: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:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f77d60>, '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 0x1f78a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f78ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', '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:56: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:56: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 mozsystemmonitor==0.3 03:56:01 INFO - Using env: {'DISPLAY': ':0', 03:56:01 INFO - 'HOME': '/home/cltbld', 03:56:01 INFO - 'LANG': 'en_US.UTF-8', 03:56:01 INFO - 'LANGUAGE': 'en_US:en', 03:56:01 INFO - 'LOGNAME': 'cltbld', 03:56:01 INFO - 'MAIL': '/var/mail/cltbld', 03:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:01 INFO - 'MOZ_NO_REMOTE': '1', 03:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:01 INFO - 'NO_EM_RESTART': '1', 03:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:01 INFO - 'PWD': '/builds/slave/test', 03:56:01 INFO - 'SHELL': '/bin/bash', 03:56:01 INFO - 'SHLVL': '1', 03:56:01 INFO - 'TERM': 'linux', 03:56:01 INFO - 'TMOUT': '86400', 03:56:01 INFO - 'USER': 'cltbld', 03:56:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', 03:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:01 INFO - '_': '/tools/buildbot/bin/python'} 03:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:56: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:56: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:56: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:56: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:56:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:56:02 INFO - Installing collected packages: mozsystemmonitor 03:56:02 INFO - Running setup.py install for mozsystemmonitor 03:56:02 INFO - Successfully installed mozsystemmonitor 03:56:02 INFO - Cleaning up... 03:56:03 INFO - Return code: 0 03:56:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:56: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:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56: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:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f77d60>, '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 0x1f78a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f78ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', '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:56:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:56:03 INFO - Using env: {'DISPLAY': ':0', 03:56:03 INFO - 'HOME': '/home/cltbld', 03:56:03 INFO - 'LANG': 'en_US.UTF-8', 03:56:03 INFO - 'LANGUAGE': 'en_US:en', 03:56:03 INFO - 'LOGNAME': 'cltbld', 03:56:03 INFO - 'MAIL': '/var/mail/cltbld', 03:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:03 INFO - 'MOZ_NO_REMOTE': '1', 03:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:03 INFO - 'NO_EM_RESTART': '1', 03:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:03 INFO - 'PWD': '/builds/slave/test', 03:56:03 INFO - 'SHELL': '/bin/bash', 03:56:03 INFO - 'SHLVL': '1', 03:56:03 INFO - 'TERM': 'linux', 03:56:03 INFO - 'TMOUT': '86400', 03:56:03 INFO - 'USER': 'cltbld', 03:56:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', 03:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:03 INFO - '_': '/tools/buildbot/bin/python'} 03:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:03 INFO - Downloading/unpacking jsonschema==2.5.1 03:56:03 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:56:03 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:56:03 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:56:03 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:56:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:56:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:05 INFO - Downloading functools32-3.2.3-2.tar.gz 03:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:56:05 INFO - warning: no files found matching '*.txt' 03:56:05 INFO - no previously-included directories found matching 'build' 03:56:05 INFO - no previously-included directories found matching 'dist' 03:56:05 INFO - no previously-included directories found matching '.git*' 03:56:05 INFO - Installing collected packages: jsonschema, functools32 03:56:05 INFO - Running setup.py install for functools32 03:56:05 INFO - warning: no files found matching '*.txt' 03:56:05 INFO - no previously-included directories found matching 'build' 03:56:05 INFO - no previously-included directories found matching 'dist' 03:56:05 INFO - no previously-included directories found matching '.git*' 03:56:05 INFO - Successfully installed jsonschema functools32 03:56:05 INFO - Cleaning up... 03:56:05 INFO - Return code: 0 03:56:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:05 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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f77d60>, '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 0x1f78a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f78ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', '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:56:05 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:56:05 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:56:05 INFO - Using env: {'DISPLAY': ':0', 03:56:05 INFO - 'HOME': '/home/cltbld', 03:56:05 INFO - 'LANG': 'en_US.UTF-8', 03:56:05 INFO - 'LANGUAGE': 'en_US:en', 03:56:05 INFO - 'LOGNAME': 'cltbld', 03:56:05 INFO - 'MAIL': '/var/mail/cltbld', 03:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:05 INFO - 'MOZ_NO_REMOTE': '1', 03:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:05 INFO - 'NO_EM_RESTART': '1', 03:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:05 INFO - 'PWD': '/builds/slave/test', 03:56:05 INFO - 'SHELL': '/bin/bash', 03:56:05 INFO - 'SHLVL': '1', 03:56:05 INFO - 'TERM': 'linux', 03:56:05 INFO - 'TMOUT': '86400', 03:56:05 INFO - 'USER': 'cltbld', 03:56:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', 03:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:05 INFO - '_': '/tools/buildbot/bin/python'} 03:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:56:06 INFO - Cleaning up... 03:56:06 INFO - Return code: 0 03:56:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:56: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:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56: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:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:06 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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f77d60>, '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 0x1f78a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f78ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', '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:56:06 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:56:06 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:56:06 INFO - Using env: {'DISPLAY': ':0', 03:56:06 INFO - 'HOME': '/home/cltbld', 03:56:06 INFO - 'LANG': 'en_US.UTF-8', 03:56:06 INFO - 'LANGUAGE': 'en_US:en', 03:56:06 INFO - 'LOGNAME': 'cltbld', 03:56:06 INFO - 'MAIL': '/var/mail/cltbld', 03:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:06 INFO - 'MOZ_NO_REMOTE': '1', 03:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:06 INFO - 'NO_EM_RESTART': '1', 03:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:06 INFO - 'PWD': '/builds/slave/test', 03:56:06 INFO - 'SHELL': '/bin/bash', 03:56:06 INFO - 'SHLVL': '1', 03:56:06 INFO - 'TERM': 'linux', 03:56:06 INFO - 'TMOUT': '86400', 03:56:06 INFO - 'USER': 'cltbld', 03:56:06 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', 03:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:06 INFO - '_': '/tools/buildbot/bin/python'} 03:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:06 INFO - Downloading/unpacking blobuploader==1.2.4 03:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:07 INFO - Downloading blobuploader-1.2.4.tar.gz 03:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:56:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:56:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:07 INFO - Downloading docopt-0.6.1.tar.gz 03:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:56:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:56:07 INFO - Running setup.py install for blobuploader 03:56:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:56:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:56:08 INFO - Running setup.py install for requests 03:56:08 INFO - Running setup.py install for docopt 03:56:08 INFO - Successfully installed blobuploader requests docopt 03:56:08 INFO - Cleaning up... 03:56:08 INFO - Return code: 0 03:56:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:08 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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f77d60>, '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 0x1f78a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f78ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', '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:56:08 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:56:08 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:56:08 INFO - Using env: {'DISPLAY': ':0', 03:56:08 INFO - 'HOME': '/home/cltbld', 03:56:08 INFO - 'LANG': 'en_US.UTF-8', 03:56:08 INFO - 'LANGUAGE': 'en_US:en', 03:56:08 INFO - 'LOGNAME': 'cltbld', 03:56:08 INFO - 'MAIL': '/var/mail/cltbld', 03:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:08 INFO - 'MOZ_NO_REMOTE': '1', 03:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:08 INFO - 'NO_EM_RESTART': '1', 03:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:08 INFO - 'PWD': '/builds/slave/test', 03:56:08 INFO - 'SHELL': '/bin/bash', 03:56:08 INFO - 'SHLVL': '1', 03:56:08 INFO - 'TERM': 'linux', 03:56:08 INFO - 'TMOUT': '86400', 03:56:08 INFO - 'USER': 'cltbld', 03:56:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', 03:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:08 INFO - '_': '/tools/buildbot/bin/python'} 03:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:56:08 INFO - Running setup.py (path:/tmp/pip-0VMlrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:56:08 INFO - Running setup.py (path:/tmp/pip-DB1TCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:56:08 INFO - Running setup.py (path:/tmp/pip-81qJMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:56:08 INFO - Running setup.py (path:/tmp/pip-SXivGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:56:09 INFO - Running setup.py (path:/tmp/pip-c09VSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:56:09 INFO - Running setup.py (path:/tmp/pip-T86FKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:56:09 INFO - Running setup.py (path:/tmp/pip-7qtWKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:56:09 INFO - Running setup.py (path:/tmp/pip-7bN53T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:56:09 INFO - Running setup.py (path:/tmp/pip-qR9slo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:56:09 INFO - Running setup.py (path:/tmp/pip-gyaw0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:56:09 INFO - Running setup.py (path:/tmp/pip-aRhc8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:56:09 INFO - Running setup.py (path:/tmp/pip-yz3OS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:56:09 INFO - Running setup.py (path:/tmp/pip-lMlGf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:56:09 INFO - Running setup.py (path:/tmp/pip-uBZs0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:09 INFO - Running setup.py (path:/tmp/pip-EnK3Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:56:09 INFO - Running setup.py (path:/tmp/pip-yvQuhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:56:09 INFO - Running setup.py (path:/tmp/pip-mL3O0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:56:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:56:09 INFO - Running setup.py install for manifestparser 03:56:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:56:10 INFO - Running setup.py install for mozcrash 03:56:10 INFO - Running setup.py install for mozdebug 03:56:10 INFO - Running setup.py install for mozdevice 03:56:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:56:10 INFO - Running setup.py install for mozfile 03:56:10 INFO - Running setup.py install for mozhttpd 03:56:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:56:10 INFO - Running setup.py install for mozinfo 03:56:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:56:10 INFO - Running setup.py install for mozInstall 03:56:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:56:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:56:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:56:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:56:10 INFO - Running setup.py install for mozleak 03:56:10 INFO - Running setup.py install for mozlog 03:56:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:56:10 INFO - Running setup.py install for moznetwork 03:56:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:56:11 INFO - Running setup.py install for mozprocess 03:56:11 INFO - Running setup.py install for mozprofile 03:56:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:56:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:56:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:56:11 INFO - Running setup.py install for mozrunner 03:56:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:56:11 INFO - Running setup.py install for mozscreenshot 03:56:11 INFO - Running setup.py install for moztest 03:56:11 INFO - Running setup.py install for mozversion 03:56:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:56:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:56:11 INFO - Cleaning up... 03:56:11 INFO - Return code: 0 03:56:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f77d60>, '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 0x1f78a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f78ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', '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:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:56:11 INFO - Using env: {'DISPLAY': ':0', 03:56:11 INFO - 'HOME': '/home/cltbld', 03:56:11 INFO - 'LANG': 'en_US.UTF-8', 03:56:11 INFO - 'LANGUAGE': 'en_US:en', 03:56:11 INFO - 'LOGNAME': 'cltbld', 03:56:11 INFO - 'MAIL': '/var/mail/cltbld', 03:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:11 INFO - 'MOZ_NO_REMOTE': '1', 03:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:11 INFO - 'NO_EM_RESTART': '1', 03:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:11 INFO - 'PWD': '/builds/slave/test', 03:56:11 INFO - 'SHELL': '/bin/bash', 03:56:11 INFO - 'SHLVL': '1', 03:56:11 INFO - 'TERM': 'linux', 03:56:11 INFO - 'TMOUT': '86400', 03:56:11 INFO - 'USER': 'cltbld', 03:56:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', 03:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:11 INFO - '_': '/tools/buildbot/bin/python'} 03:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:56:11 INFO - Running setup.py (path:/tmp/pip-oBmYaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:56:12 INFO - Running setup.py (path:/tmp/pip-yEkX8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:56:12 INFO - Running setup.py (path:/tmp/pip-3E2Cvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:56:12 INFO - Running setup.py (path:/tmp/pip-FRoLge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:56:12 INFO - Running setup.py (path:/tmp/pip-ND3lXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:56:12 INFO - Running setup.py (path:/tmp/pip-TKpFCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:56:12 INFO - Running setup.py (path:/tmp/pip-3EAipn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:56:12 INFO - Running setup.py (path:/tmp/pip-W7U4Do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:56:12 INFO - Running setup.py (path:/tmp/pip-ZGKkk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:56:12 INFO - Running setup.py (path:/tmp/pip-DVp_sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:56:12 INFO - Running setup.py (path:/tmp/pip-6BY7XE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:56:12 INFO - Running setup.py (path:/tmp/pip-d12VBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:56:12 INFO - Running setup.py (path:/tmp/pip-86pVXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:56:12 INFO - Running setup.py (path:/tmp/pip-QsW4Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:12 INFO - Running setup.py (path:/tmp/pip-vFbLYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:13 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:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:56:13 INFO - Running setup.py (path:/tmp/pip-NzxCMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:56:13 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:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:56:13 INFO - Running setup.py (path:/tmp/pip-hASrZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:56:13 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:56:13 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:56:13 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:56:13 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:56:13 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:56:13 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:56:13 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:56:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:14 INFO - Downloading blessings-1.6.tar.gz 03:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:56:14 INFO - Installing collected packages: blessings 03:56:14 INFO - Running setup.py install for blessings 03:56:14 INFO - Successfully installed blessings 03:56:14 INFO - Cleaning up... 03:56:14 INFO - Return code: 0 03:56:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:56:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:56:14 INFO - Reading from file tmpfile_stdout 03:56:14 INFO - Current package versions: 03:56:14 INFO - argparse == 1.2.1 03:56:14 INFO - blessings == 1.6 03:56:14 INFO - blobuploader == 1.2.4 03:56:14 INFO - docopt == 0.6.1 03:56:14 INFO - functools32 == 3.2.3-2 03:56:14 INFO - jsonschema == 2.5.1 03:56:14 INFO - manifestparser == 1.1 03:56:14 INFO - mozInstall == 1.13 03:56:14 INFO - mozcrash == 1.0 03:56:14 INFO - mozdebug == 0.1 03:56:14 INFO - mozdevice == 0.51 03:56:14 INFO - mozfile == 1.2 03:56:14 INFO - mozhttpd == 0.7 03:56:14 INFO - mozinfo == 0.10 03:56:14 INFO - mozleak == 0.1 03:56:14 INFO - mozlog == 3.5 03:56:14 INFO - moznetwork == 0.27 03:56:14 INFO - mozprocess == 0.25 03:56:14 INFO - mozprofile == 0.28 03:56:14 INFO - mozrunner == 6.13 03:56:14 INFO - mozscreenshot == 0.1 03:56:14 INFO - mozsystemmonitor == 0.3 03:56:14 INFO - moztest == 0.8 03:56:14 INFO - mozversion == 1.4 03:56:14 INFO - psutil == 3.1.1 03:56:14 INFO - requests == 1.2.3 03:56:14 INFO - wsgiref == 0.1.2 03:56:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f77d60>, '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 0x1f78a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f78ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', '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:56:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:56:14 INFO - Using env: {'DISPLAY': ':0', 03:56:14 INFO - 'HOME': '/home/cltbld', 03:56:14 INFO - 'LANG': 'en_US.UTF-8', 03:56:14 INFO - 'LANGUAGE': 'en_US:en', 03:56:14 INFO - 'LOGNAME': 'cltbld', 03:56:14 INFO - 'MAIL': '/var/mail/cltbld', 03:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:14 INFO - 'MOZ_NO_REMOTE': '1', 03:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:14 INFO - 'NO_EM_RESTART': '1', 03:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:14 INFO - 'PWD': '/builds/slave/test', 03:56:14 INFO - 'SHELL': '/bin/bash', 03:56:14 INFO - 'SHLVL': '1', 03:56:14 INFO - 'TERM': 'linux', 03:56:14 INFO - 'TMOUT': '86400', 03:56:14 INFO - 'USER': 'cltbld', 03:56:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', 03:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:14 INFO - '_': '/tools/buildbot/bin/python'} 03:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:15 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:56:15 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:56:15 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:56:15 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:56:15 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:56:15 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:56:15 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:56:15 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:56:15 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:56:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:56:16 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:56:16 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:56:16 INFO - Installing collected packages: simplejson 03:56:16 INFO - Running setup.py install for simplejson 03:56:16 INFO - building 'simplejson._speedups' extension 03:56:16 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:56:17 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:56:17 INFO - Successfully installed simplejson 03:56:17 INFO - Cleaning up... 03:56:17 INFO - Return code: 0 03:56:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f77d60>, '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 0x1f78a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f78ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', '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:56:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:56:17 INFO - Using env: {'DISPLAY': ':0', 03:56:17 INFO - 'HOME': '/home/cltbld', 03:56:17 INFO - 'LANG': 'en_US.UTF-8', 03:56:17 INFO - 'LANGUAGE': 'en_US:en', 03:56:17 INFO - 'LOGNAME': 'cltbld', 03:56:17 INFO - 'MAIL': '/var/mail/cltbld', 03:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:17 INFO - 'MOZ_NO_REMOTE': '1', 03:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:17 INFO - 'NO_EM_RESTART': '1', 03:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:17 INFO - 'PWD': '/builds/slave/test', 03:56:17 INFO - 'SHELL': '/bin/bash', 03:56:17 INFO - 'SHLVL': '1', 03:56:17 INFO - 'TERM': 'linux', 03:56:17 INFO - 'TMOUT': '86400', 03:56:17 INFO - 'USER': 'cltbld', 03:56:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', 03:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:17 INFO - '_': '/tools/buildbot/bin/python'} 03:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:56:17 INFO - Cleaning up... 03:56:17 INFO - Return code: 0 03:56:17 INFO - Running post-action listener: _resource_record_post_action 03:56:17 INFO - Running post-action listener: _start_resource_monitoring 03:56:17 INFO - Starting resource monitoring. 03:56:17 INFO - [mozharness: 2017-09-25 10:56:17.637060Z] Finished create-virtualenv step (success) 03:56:17 INFO - [mozharness: 2017-09-25 10:56:17.637604Z] Running install step. 03:56:17 INFO - Running pre-action listener: _resource_record_pre_action 03:56:17 INFO - Running main action method: install 03:56:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:56:17 INFO - Reading from file tmpfile_stdout 03:56:17 INFO - Detecting whether we're running mozinstall >=1.0... 03:56:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:56:18 INFO - Reading from file tmpfile_stdout 03:56:18 INFO - Output received: 03:56:18 INFO - Usage: mozinstall [options] installer 03:56:18 INFO - Options: 03:56:18 INFO - -h, --help show this help message and exit 03:56:18 INFO - -d DEST, --destination=DEST 03:56:18 INFO - Directory to install application into. [default: 03:56:18 INFO - "/builds/slave/test"] 03:56:18 INFO - --app=APP Application being installed. [default: firefox] 03:56:18 INFO - mkdir: /builds/slave/test/build/application 03:56:18 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:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:56:35 INFO - Reading from file tmpfile_stdout 03:56:35 INFO - Output received: 03:56:35 INFO - /builds/slave/test/build/application/firefox/firefox 03:56:35 INFO - Running post-action listener: _resource_record_post_action 03:56:35 INFO - [mozharness: 2017-09-25 10:56:35.795178Z] Finished install step (success) 03:56:35 INFO - [mozharness: 2017-09-25 10:56:35.795326Z] Running setup-mitmproxy step. 03:56:35 INFO - Running pre-action listener: _resource_record_pre_action 03:56:35 INFO - Running main action method: setup_mitmproxy 03:56:35 INFO - Skipping: mitmproxy is not required 03:56:35 INFO - Running post-action listener: _resource_record_post_action 03:56:35 INFO - [mozharness: 2017-09-25 10:56:35.795980Z] Finished setup-mitmproxy step (success) 03:56:35 INFO - [mozharness: 2017-09-25 10:56:35.796120Z] Running run-tests step. 03:56:35 INFO - Running pre-action listener: _resource_record_pre_action 03:56:35 INFO - Running pre-action listener: _set_gcov_prefix 03:56:35 INFO - Running main action method: run_tests 03:56:35 WARNING - Try message not found. 03:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:56:35 INFO - Python 2.7.3 03:56:35 INFO - Return code: 0 03:56:35 INFO - grabbing minidump binary from tooltool 03:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f77d60>, '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 0x1f78a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f78ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:56:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:56:35 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:56:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:56:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:56:35 INFO - Return code: 0 03:56:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:56:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:56:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:56:35 INFO - ENV: RUST_BACKTRACE is now full 03:56:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:56:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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:56:35 INFO - Using env: {'DISPLAY': ':0', 03:56:35 INFO - 'HOME': '/home/cltbld', 03:56:35 INFO - 'LANG': 'en_US.UTF-8', 03:56:35 INFO - 'LANGUAGE': 'en_US:en', 03:56:35 INFO - 'LOGNAME': 'cltbld', 03:56:35 INFO - 'MAIL': '/var/mail/cltbld', 03:56:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:56:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:35 INFO - 'MOZ_NO_REMOTE': '1', 03:56:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:35 INFO - 'NO_EM_RESTART': '1', 03:56:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:35 INFO - 'PWD': '/builds/slave/test', 03:56:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:56:35 INFO - 'RUST_BACKTRACE': 'full', 03:56:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:56:35 INFO - 'SHELL': '/bin/bash', 03:56:35 INFO - 'SHLVL': '1', 03:56:35 INFO - 'TERM': 'linux', 03:56:35 INFO - 'TMOUT': '86400', 03:56:35 INFO - 'USER': 'cltbld', 03:56:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', 03:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:35 INFO - '_': '/tools/buildbot/bin/python'} 03:56:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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:56:36 INFO - mozversion application_buildid: 20170925095842 03:56:36 INFO - mozversion application_changeset: 5f3f19824efa14cc6db546baf59c54a0fc15ddc9 03:56:36 INFO - mozversion application_display_name: Nightly 03:56:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:56:36 INFO - mozversion application_name: Firefox 03:56:36 INFO - mozversion application_remotingname: firefox 03:56:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:56:36 INFO - mozversion application_vendor: Mozilla 03:56:36 INFO - mozversion application_version: 58.0a1 03:56:36 INFO - mozversion platform_buildid: 20170925095842 03:56:36 INFO - mozversion platform_changeset: 5f3f19824efa14cc6db546baf59c54a0fc15ddc9 03:56:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:56:36 INFO - mozversion platform_version: 58.0a1 03:56:36 INFO - using testdate: 1506336996 03:56:36 INFO - actual date: 1506336996 03:56:36 INFO - starting webserver on 'localhost:40020' 03:56:36 INFO - SUITE-START | Running 2 tests 03:56:36 INFO - TEST-START | dromaeo_css 03:56:36 INFO - Initialising browser for dromaeo_css test... 03:56:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40020/getInfo.html -profile /tmp/tmpErTP_5/profile 03:56:36 INFO - TEST-INFO | started process 13202 (/builds/slave/test/build/application/firefox/firefox http://localhost:40020/getInfo.html) 03:56:42 INFO - TEST-INFO | 13202: exit 0 03:56:42 INFO - Browser initialized. 03:56:42 INFO - Running cycle 1/1 for dromaeo_css test... 03:56:42 INFO - Using env: {'DISPLAY': ':0', 03:56:42 INFO - 'HOME': '/home/cltbld', 03:56:42 INFO - 'JSGC_DISABLE_POISONING': '1', 03:56:42 INFO - 'LANG': 'en_US.UTF-8', 03:56:42 INFO - 'LANGUAGE': 'en_US:en', 03:56:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:56:42 INFO - 'LOGNAME': 'cltbld', 03:56:42 INFO - 'MAIL': '/var/mail/cltbld', 03:56:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:56:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:56:42 INFO - 'MOZ_CRASHREPORTER': '1', 03:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:56:42 INFO - 'MOZ_NO_REMOTE': '1', 03:56:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:42 INFO - 'NO_EM_RESTART': '1', 03:56:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:42 INFO - 'PWD': '/builds/slave/test', 03:56:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:56:42 INFO - 'RUST_BACKTRACE': 'full', 03:56:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:56:42 INFO - 'SHELL': '/bin/bash', 03:56:42 INFO - 'SHLVL': '1', 03:56:42 INFO - 'STYLO_FORCE_DISABLED': '1', 03:56:42 INFO - 'TERM': 'linux', 03:56:42 INFO - 'TMOUT': '86400', 03:56:42 INFO - 'USER': 'cltbld', 03:56:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', 03:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:42 INFO - '_': '/tools/buildbot/bin/python'} 03:56:42 INFO - TEST-INFO | started process 13438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpErTP_5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:43 INFO - PID 13438 | 03:56:43 INFO - PID 13438 | (/builds/slave/test/build/application/firefox/firefox:13487): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:56:43 INFO - PID 13438 | 03:56:53 INFO - PID 13438 | RSS: Main: 151535616 03:56:53 INFO - PID 13438 | 03:59:51 INFO - PID 13438 | Cycle 1(1): loaded http://localhost:40020/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40020/tests/dromaeo/cssquery-ext.html) 03:59:52 INFO - PID 13438 | RSS: Main: 153325568 03:59:52 INFO - PID 13438 | 04:02:54 INFO - PID 13438 | Cycle 1(1): loaded http://localhost:40020/tests/dromaeo/cssquery-ext.html (next: http://localhost:40020/tests/dromaeo/cssquery-jquery.html) 04:02:55 INFO - PID 13438 | RSS: Main: 152891392 04:02:55 INFO - PID 13438 | 04:05:56 INFO - PID 13438 | Cycle 1(1): loaded http://localhost:40020/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40020/tests/dromaeo/cssquery-mootools.html) 04:05:57 INFO - PID 13438 | RSS: Main: 155049984 04:05:57 INFO - PID 13438 | 04:08:59 INFO - PID 13438 | Cycle 1(1): loaded http://localhost:40020/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40020/tests/dromaeo/cssquery-prototype.html) 04:08:59 INFO - PID 13438 | RSS: Main: 153870336 04:08:59 INFO - PID 13438 | 04:12:03 INFO - PID 13438 | Cycle 1(1): loaded http://localhost:40020/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40020/tests/dromaeo/cssquery-yui.html) 04:12:03 INFO - PID 13438 | RSS: Main: 154832896 04:12:03 INFO - PID 13438 | 04:15:05 INFO - PID 13438 | Cycle 1(1): loaded http://localhost:40020/tests/dromaeo/cssquery-yui.html (next: http://localhost:40020/tests/dromaeo/cssquery-dojo.html) 04:15:05 INFO - PID 13438 | RSS: Main: 157528064 04:15:05 INFO - PID 13438 | 04:15:05 INFO - PID 13438 | __start_tp_report 04:15:05 INFO - PID 13438 | _x_x_mozilla_page_load 04:15:05 INFO - PID 13438 | _x_x_mozilla_page_load_details 04:15:05 INFO - PID 13438 | |i|pagename|runs| 04:15:05 INFO - PID 13438 | |0;dojo.html;3135.513995330723;3153.826539540326;3173.904782856512;3198.264399188187;3204.214967333003;6277.497800175986;6346.428821406084;6352.618842869425;6392.041193820929;6483.643399613014;6352.872942541147;6396.456301214403;6559.3112723164095;6571.3757193066585;6573.671316434171;5789.681567513785;5877.85305367365;5922.170896074553;5952.047672372421;5982.282126144869;5829.358770535237;5908.793192238272;5935.258092738408;5995.460408563228;6000.96999515004;5691.914621280664;5771.394003629643;5805.10020946754;5814.854628634275;5902.645841249518;5842.065269556851;5860.384659610722;5863.8534036649;5866.73599688015;5899.557533185029;5813.215215945836;5850.76596936122;5869.589128760988;5886.587938844283;5926.792562260343;6368.172137622079;6376.776812811529;6405.359464053604;6415;6494.967525162391;6699.196096468406;6784.8303792405095;6793.524453288272;6901.654917254117;6941.340572645641;6889.896651550231;6897.48268879836;6983.580985140908;6989.790306290819;6991.755288564876;6122.173506576644;6306.1171435998995;6329.68351582419;6439.066335381391;6463.289038205747;7028.051213086168;7116.395106415909;7118.466115041289;7120.038794762744;7126.928730712731;6698.430633396216;6698.4641228701585;6777.152855893013;6789;6792.049113124167;6713.530052896251;6772.085768421299;6807.183138023469;6819.24988251292;6821.624810635363;6730.697118629673;6777.051212830208;6779;6783.559068660521;6841.794746157623;6794.082798822095;6834;6854.554453960476;6878.931210687929;6889.965550172217;5271.341082364705;5322.494363035506;5380.757865896044;5387.380451248078;5401.000814849265;4594.104149690845;4616.3306320584;4623.676342656049;4640.32715256286;4682.204025315705;5808.244928159397;5880.294364676266;5884.205632239593;5889.146073819272;5933.732982015819;6850;6863.588184708933;6924.272951340137;6965.164180298397;7009.228984811667;5885.352611212763;5900.970495147582;5986.55100867428;5987.670678112746;5991.820245392558;5775.306963164448;5815.127730840408;5817.621854579524;5827.650340979555;5889.528837692974;6717.966410167918;6741.932580674229;6781.830454238683;6782.694778734969;6789.966050169717;6927.134108236471;6928.1339832520935;6939.4448444125355;7014.579125252501;7021.262767409348;6581.473482121323;6684.665766711742;6691.063251144941;6776.627285499345;6791.558548694319;6770.424513916372;6771.796846094625;6790.287019863041;6803.625800580818;6807.591544507345;6890.586564806128;6947.756828510978;6961.965190174017;6989.7553585624255;6991.2309645937885;6448.484121270193;6503.804885853432;6600.108985287116;6633.237177724431;6672.199336079701;6665.700043497957;6690.59856408617;6699.129113215251;6717.9328206719265;6736.259011508632;6425.903611445926;6572.80281591553;6578.375054369827;6654.90017649726;6674.899876501953;6487.740490380332;6560.081588577698;6568.080468734476;6582.967085164543;6584.868302633825;6331.081993110881;6404.103425520524;6406.615603063831;6438.581492202992;6498.090267362668 04:15:05 INFO - PID 13438 | |1;ext.html;805.689809423372;834.3283656656394;837.9874301885469;840.2143995364331;840.4327079221524;39317;42834.143317133676;42867.78566107165;43012.78493607527;43151.35272970908;40536.594634053654;40556.59443405565;40795.38806917899;40988.38517422241;41197;7225.132984041922;7298.124225092996;7312.159101703292;7332;7349.00788393568;7207.279272072803;7293.307135822089;7297.671604777771;7324.414046876237;7337.926620733778;7279.854402911938;7313.7074517019255;7316.195218525958;7318.560886346836;7878.960605196995;8002.719904803333;8057.838843223161;8069.031716194065;8075.152109028585;8077.838443231161;7911.090224624184;7984.720534781313;7989.520628762293;7989.760307190793;7989.96005019977;37779.622203777886;39412;40217.59782402197;40384.192316153516;40415.39376909348;3537.7169826414083;3585;3587.5694916609914;3590.5870824855215;3591.084273510264;33142.6685733142;33151.171220719436;33185.170370740685;33189.83405082959;33195.672173113046;5198.246254293106;5202.843914682566;5205.323307969939;5228.5555727763185;5241.842744717626;192234;192861;193467;194013.02993485084;194382.02808986005;43126.13747725028;43674.34488482675;50617.746911265946;50634;50709.23936140961;58061;58936.410635893095;58964.70517647384;58991.41008589945;58994;15901.284442200129;15964.600884977968;16003.919980400024;16028.19859007045;16040.278187481592;12884.291363974884;12955.5465558705;12980.805287920688;12989.090763646644;13017.284049377186;14869.851301487062;14955.775663365059;15010.099394036393;15042.473513427196;15107.848921510864;5760.567957403212;5960;6050.183225264621;6109.14471973924;6111.113888486145;870.2863651805459;874.3791907745444;890.470170248701;903.263839970422;912.1927094521396;22935.655965160535;23033.539329213658;23058.538829223322;23081.79519532394;23543;981.0875885426622;997.1823105053932;998.0169533009979;1001.1740314240635;1004.42747633848;12117.394130293625;12323.630291091282;12367.196132251374;12387.690307742198;12397.070219733556;232225;233445;235951;236390;237189;51508;52074.21888671673;52104;52117.47882521126;52550.47449525532;1409.7391982483273;1451.0495625365402;1453.6075259679826;1458.0522660270697;1461.0649184521915;22983;23019.88490057539;23142.537149257256;23248;23541.76458235464;38053.23893522169;38103.42844857274;38176.61823381731;38235.80882095572;38251.80874095612;186752;187310;187382;188122;188192;32027.67972320247;36727.26545469129;36795.26409471849;37670.434943475324;37694.434583481816;44189.116217676106;46220.30669540027;46226.76886615546;46538.53461465342;46562;32403.837980809945;32582.674173257965;32727.509087364186;32766.508502372006;32822;32873;32903.67096329006;32975.835120824246;33028.50457243095;33370.666293336755;36865.63134368622;37341;37389.439158412104;37483.250334992605;37613;31940.20149496281;32280.35439291248;32449;32470.188245294055;32650.51024234686;23504.059837606303;23584.764152358945;23828;24030;24398.146064887645 04:15:05 INFO - PID 13438 | |2;jquery.html;586.6450797267651;587.729644363593;594.200799924102;607.8510764862609;633.6578247746218;23004;23701.288961331145;23747.76252237477;23795.881020594916;23796.8810155949;20940.58118837626;21789.782102178975;24689.259322220318;24763;24928.75071249287;6679.499037572177;6767;6819.318068193191;6820.863582728342;6824.897626535606;6679.231888332831;6799.796006119825;6814.6933387997415;6816.488763342744;6819;6238.59449135807;6712.194536655608;6762.3237676232475;6771.932280677204;6776.864462710742;6543.476521878239;6559.245686746038;6613.272540020594;6613.702383392735;6614.735410583571;6104;6138.263408390977;6144.938550614482;6164.229471316085;6164.969175154096;27846.721532784617;28270.293242668893;28297;28311;28322.15033548997;2051.5281485258474;2095.5704080663427;2107.136074209582;2116.6401711709045;2116.724825772655;18519.90740046291;19370.128344224544;19389.224431022743;19405.902970485058;19426.417207483657;2417.782399584046;2426.308502076917;2486.66430031947;2495.351208685755;2495.4759500504915;123637.38181309126;127330;137800;141409;144642.27678861644;14403.231657695444;14532.418703251962;14900.18049007315;14966.850331496546;15208.391664333523;23319.41701457477;23391.181308654115;23478.530429391318;23523.76476235216;23555.411114721926;9957.402555846673;9990.150837178775;10038.849417258747;10082.848757268646;10095.848562271573;9230.630774769068;9254.814903702023;9278.350515463988;9292.210162136294;9326.300527460467;8946.150115738994;8983.203359328161;9063.32025098107;9175.954120229357;9178.66909298148;2699.5275826730244;2750.2711781377952;2797.9860100699366;2812.170409729135;2857.7142285771256;975.8975307592742;986.7779749556292;993.5181437003048;1012.7417508535276;1012.8227560176939;18091.54771130732;18802.717959230624;19010.61978760417;19209.711854322195;19431.805681943282;1040.8230600797883;1051.169576034924;1055.4353420919924;1069.5294070608907;1079.5681727308981;10205.642802502025;10561.419121948213;10610.416427096583;10799.730006749736;10832.458377081115;465006;475399;476540;483228;483863;116530;118590;118944;119612;120886.39556802336;1079.5304042741432;1127.1208457403238;1193.451012534244;1201.5193922430922;1254.8305978692943;18745.531361716065;18887.961162135663;18895.338663146726;19026;19207.135678894203;56159;57250;58056.70971645115;58511.12233316419;59320.70339648274;72967;73468;74047;74115.25884741299;74662.25337746553;14626.195559244345;14905.25473726331;15023.09861408319;15055.096694198382;15067.171305578298;22717.88641056784;22835.31494055181;22948.885255573616;23049.308520744406;23091.19180828663;18208.45374638763;18295.908520457313;18554.536136596154;18623.348182813537;18747.71878421852;15491.225438728245;15574.610634734223;15601.453949111727;15662.295196716403;16233.269502872163;17893.463196104138;18658.72011919795;18817.247310107443;18999.525011874815;19137.808621913602;14537.636559086108;14696.77954830657;14701.852981470476;14770.704585908437;14823.40706371733;17868.910655446638;18034.278628855223;18037.72943405876;18343.449696509128;18349.63300733951 04:15:05 INFO - PID 13438 | |3;mootools.html;1313.8554758976513;1367.8563750806159;1369.7329020840934;1370.5793586365921;1372.4715984346024;14979.101253924771;15752.921235393836;15762.684746305067;15775.684486310281;15785.684286314296;15385.769213461806;15424.383024678998;15482.767758483631;15502.922485387586;15541;2733.658292713406;2854;2856.585795059715;2865.7134286571386;2870.196345023386;2733.2620192548;2809.2415047937147;2822.32264256579;2823.957640635392;2831.164806382112;2635.235781623327;2909.767218622505;2910.1851481585086;2910.3160757222035;2910.5634154876725;2765.391613844961;2801.789865760066;2816.6479190101236;2818.2390754496378;2833.7024612415707;2693.299742067057;2748.69764325924;2750.4499100179846;2759.599858020576;2768.4878297514824;15033.323500442506;15439.614009649737;15441.5367538974;15444.5366639001;15456.690866182726;8074.919250807476;8375.581220938928;8426.705065322745;8428.62071206791;8439.324854011726;5345.091334473149;5418.91871621926;5502.642328248651;5533.750981205855;5673.631213971079;1948.7369205157406;1973.9506512337164;1973.9901300493405;1977.8813271203774;2010.7788143304224;26825.731742682518;26850.5972410414;27032.32419189536;27046.72953270462;27152.185434436997;6694.397504224546;6857.382835544725;6964;7147.606881621561;7260.346568808727;17894;17972.281108755764;18003.819961800476;18018.36935707244;18029.098545072695;7913.287804097658;7965.402594805413;7978.162292959272;7986.480878742863;8008.439409241297;7162.785116446515;7295.562266264041;7333.1200255969625;7357.705691772377;7372.889406658905;5078.568321692697;5250.789968401221;5308.946910530845;5342.6260161788305;5349.518543331041;1484.094702231638;1528.808898887639;1574.3151728997693;1593.55380493462;1609.609729551615;881.9382643215042;897.699270744308;898.1377877237925;903.4127816918924;906.0169715858367;7372.889406658905;7500.437467189982;7546.056742907137;7561;7609.391248700091;960.870282511852;974.1476208317722;981.3228872078244;982.8378317577519;988.2341185581232;4680.438347398334;4706.788194531255;4754.976225118852;4784.952150478521;4795.520447955177;21565.568688626452;22326.77673223247;22565.774342256696;22648.433789155075;22655;21586.676199857015;22019.559608807733;22054.779452205592;22104.2263520776;22473.21343752961;11362.091032717362;11574.768504630028;11580.76838463226;11608.013318867823;11613.6515904523;8142.837143256983;8270.875936860832;8377.874331884905;8392.916070839214;8439.535825529654;18476.907615461838;18826.435206943814;18837.811621883604;18917.337893173673;19237.326693566218;19033.524161896064;19081.42755717331;19137.712934305717;19189;19238.326658566883;11190.440477975906;11396.772064558496;11399.373034482851;11399.943000284946;11400.144989126014;14008.579742607739;14112.576622701336;14195.503157389441;14357.282135892954;14395.352209150404;11317.207795454238;11386.373749443861;11403.714907127389;11431.085513159094;11670.533178673099;10944.343339399662;11037.448127593749;11125.777484450427;11191;11286.604968826052;9978.151857091938;9997.700068997941;10038.949805251219;10064.496775161359;10087.89912100899;6832.59004459734;6912.27421120775;6943.062686537455;6970.163580370388;7036.824079397851;6700.262971073275;6795.72817087311;6822.965885170543;6913.5506192097355;6947.513674042971 04:15:05 INFO - PID 13438 | |4;prototype.html;517.7385420362714;522.9398619158796;535.3468768102915;545.4273013335999;545.7516829842422;6245.687715614213;6300.495960323175;6315.526335524843;6360.356939434216;6368.649724265164;6157.661328626924;6195.876082478348;6196.729670417565;6213.720382582784;6229.1902052733085;5155.329807125068;5195.40252870919;5202.609804264676;5217.373915130171;5236.528712415882;4948.7278199699;5187.610929180308;5191.299174611417;5267.604929630293;5274.156135018397;4942.827001054964;4998.075356059123;5001.7999280028935;5015.69905805651;5033.370828646419;4943.085529177096;4974.8756281093265;5016.573591244749;5021.5229553192385;5022.221555658879;4456.17560751262;4497.392851964975;4504.932426013613;4547.749873756942;4564.52072532386;6182.289036760785;6193.318734939198;6199.597026193283;6200.162977997958;6221.595596286227;5708.857278568027;5744.271471051259;5768.913466298009;5788.3343415506915;5792.913106303409;6551.246606640249;6638.137042184533;6638.20341559016;6645.833854153637;6699.765508207238;4718.197906355894;4970.453250142481;4980.402351717781;4997.725125118117;5014.342398528785;6780.627065511395;6781.38967492928;6786.253512113663;6940.410065144419;6999.720011199546;4996.7501624918605;5010.473900240495;5014.699118052856;5034.169362055293;5103.18349064148;5137.409197942285;5138.87152821175;5144.382674079135;5150.583589512839;5153.123968925292;5649.830505084854;5699.005348128122;5745.68398738065;5775.422457754191;5781.306243250837;6601.834954126185;6647.401733843977;6669.866602668017;6699.899501507482;6736.629485378351;1775.6359946210996;1781.1628534588722;1784.7679801625707;1791.9462416127537;1797.8471829894345;1151.268944220426;1214.9392530373623;1245.3212998915612;1249.2005116725304;1259.3577275589516;5731.426857314235;5751.654900705971;5766.192733017381;5798.710064496759;5828.912566311508;6730.966345168243;6757.966210169016;6783.559068660521;6786.864262714718;6867.587944723233;5703.087505999103;5740.339860915965;5770.451807078321;5780.88438231233;5808.651480911159;3526.2418580005424;3592.6229344416165;3604.0809593554;3606;3637.4543818427446;6458.675971425846;6510.544261901716;6603.141591593062;6639.502037347122;6654.436207491236;6515.967420162963;6766.966165169143;6782.626955517395;6818.215905170969;6887;6446.806595802133;6467.708953097028;6496.285408605144;6516.2506311773805;6538.738450462023;6473.77341793035;6688.699008544724;6720.563163394364;6737.966310168418;6746.831329216809;6586.80239592813;6592.175978002558;6605.471562275103;6707.798766037026;6710.66446677674;6475.838104047437;6506.544541882023;6561.934380656323;6583.835404114935;6590.934090659224;4981.676191047571;4993.500649934977;5002.374703162105;5015.420142655052;5079.5428411443145;6491.819008685804;6613.43785778195;6712.228093769084;6781.830454238486;6833.521653484208;6295.779647712308;6424.646644434601;6453.806385808433;6562.179727534059;6610.8016759497295;6420.26166990802;6452.838489072012;6523.347665233438;6545.541812073109;6585.736570537125;6461;6487.3836985486305;6500.382463665944;6506.219253689587;6512.479001679949;6487.448566871869;6575.736970521126;6622.079596917033;6648.468122550088;6682.498812588978;6253.937460625518;6279.183706118175;6317.842053948688;6355.269144048493;6415.71129299192 04:15:05 INFO - PID 13438 | |5;yui.html;903.5662881816723;916.1800188830996;931.3201363005011;933.8972713001573;936.3352020065753;17229;17555.912220438895;17677.204525796336;17781.911090444562;17847.91076044621;18180.090995450242;18326.08369581519;18357.08214589272;18840.5289867753;19279.710804337945;955.3646824861459;958.5878072428853;962.1388856973005;962.3840741925173;968.5447839515434;964.62379671928;990.5839547390077;993.0119531066599;993.9204863610894;994.2841154368842;1067.9145668346514;1068.2308737708838;1068.5084860963966;1070.1706177712258;1075.3547871277249;1007.4408703169738;1049.4805071489586;1056.4928834159607;1057.6245432871335;1060.289605964006;748.6182047155935;749.0187853911339;749.2058418076856;749.3330935467438;751.4589495563185;20426.182952682022;20573.69139462909;20657.793422065737;20691.58616827655;20705.378838634864;21392.679109813365;21553.46116347088;21870.562588748136;22080.447988800246;22125.114995400163;17097.743533847002;17372;17797.644047119116;18047.458576242734;18049.458516244533;3748.7188460865545;3753.7372383933134;3768.8492460301554;3783.4324851272254;3799.8670046548236;144399.27800361035;144700;145710.54289457077;146917;148485;16958.745618815727;17411.825881741275;17525.298988040337;17539.298428062735;17547.649047019244;31544.36911261808;31979.84010079935;32110;32221;32279.35441291161;8172.305354044973;8237.588120593946;8315.334773218128;8385.706500272461;8422.284105851071;4442.533533978885;4565.794539245676;4587.8623641290815;4597.517260687647;4598.747068911175;5583.190437386556;5680.8863822723315;5693.17448969897;5705;5718.599698021182;1006.4665727164614;1014.4876837197169;1017.0897047142765;1017.7506510904876;1020.9693709188737;697.4594689115976;713.350850725837;715.2168375628678;731.9011933388924;736.7863319637353;11643.53425862973;11711.472983715754;11860.525578976916;11867;12060.216085954386;691.401937324211;702.2415790945767;705.9788206353818;711.3277952334994;712.9572225666477;5715.514181294553;5836.708164591753;5843.590948633555;5975.462208401264;6032.1856549365275;120745;121712;121784.39107804581;122573;123068;110520;112374;113180.43409783063;113735.86264137253;114802;96851.51574242224;97050.51474742581;97156.51421742846;99196;99207.00792992122;10593.152547796311;10729.302595331279;10788.838167427339;10863.239573229797;11133.944330278297;42365.36451953161;42859.35710964401;44229.33655995227;45008.549914500436;45270;56078.719606401704;57274.713626433266;57349.42650573441;58878.82242355043;59390.10914836367;15905.522834314988;16110.516684499484;16112.758308625615;16341.67316653684;16348.591285217964;17637.294508220042;17673.469795906145;17832;17957.551061223574;18039.278428863225;15268.083914965138;15418.229088545751;15467;15572.454964076203;15615.453459128876;16157.272922718741;16192.271347789143;16325;16419.179041048137;16428.589285267964;15652.92173539125;15878.9206053969;15886.046837189806;15973.520794376187;16053;11932.522699091938;11948.163628546266;11973.042156627624;12357.443915023665;12380.31908245019;11281;11372.54509819598;11408.714782130513;11612.477438515456;11697.473613687234 04:15:05 INFO - PID 13438 | __end_tp_report 04:15:05 INFO - PID 13438 | __start_cc_report 04:15:05 INFO - PID 13438 | _x_x_mozilla_cycle_collect,289 04:15:05 INFO - PID 13438 | __end_cc_report 04:15:05 INFO - PID 13438 | __startTimestamp1506338105555__endTimestamp 04:15:05 INFO - PID 13438 | 04:15:05 INFO - PID 13438 | ------- Summary: start ------- 04:15:05 INFO - PID 13438 | Number of tests: 6 04:15:05 INFO - PID 13438 | 04:15:05 INFO - PID 13438 | [#0] dojo.html Cycles:165 Average:6295.90 Median:6560.08 stddev:773.99 (11.8%) stddev-sans-first:735.58 04:15:05 INFO - PID 13438 | Values: 3135.5 3153.8 3173.9 3198.3 3204.2 6277.5 6346.4 6352.6 6392.0 6483.6 6352.9 6396.5 6559.3 6571.4 6573.7 5789.7 5877.9 5922.2 5952.0 5982.3 5829.4 5908.8 5935.3 5995.5 6001.0 5691.9 5771.4 5805.1 5814.9 5902.6 5842.1 5860.4 5863.9 5866.7 5899.6 5813.2 5850.8 5869.6 5886.6 5926.8 6368.2 6376.8 6405.4 6415.0 6495.0 6699.2 6784.8 6793.5 6901.7 6941.3 6889.9 6897.5 6983.6 6989.8 6991.8 6122.2 6306.1 6329.7 6439.1 6463.3 7028.1 7116.4 7118.5 7120.0 7126.9 6698.4 6698.5 6777.2 6789.0 6792.0 6713.5 6772.1 6807.2 6819.2 6821.6 6730.7 6777.1 6779.0 6783.6 6841.8 6794.1 6834.0 6854.6 6878.9 6890.0 5271.3 5322.5 5380.8 5387.4 5401.0 4594.1 4616.3 4623.7 4640.3 4682.2 5808.2 5880.3 5884.2 5889.1 5933.7 6850.0 6863.6 6924.3 6965.2 7009.2 5885.4 5901.0 5986.6 5987.7 5991.8 5775.3 5815.1 5817.6 5827.7 5889.5 6718.0 6741.9 6781.8 6782.7 6790.0 6927.1 6928.1 6939.4 7014.6 7021.3 6581.5 6684.7 6691.1 6776.6 6791.6 6770.4 6771.8 6790.3 6803.6 6807.6 6890.6 6947.8 6962.0 6989.8 6991.2 6448.5 6503.8 6600.1 6633.2 6672.2 6665.7 6690.6 6699.1 6717.9 6736.3 6425.9 6572.8 6578.4 6654.9 6674.9 6487.7 6560.1 6568.1 6583.0 6584.9 6331.1 6404.1 6406.6 6438.6 6498.1 04:15:05 INFO - PID 13438 | 04:15:05 INFO - PID 13438 | [#1] ext.html Cycles:180 Average:38044.51 Median:37682.43 stddev:53534.00 (142.1%) stddev-sans-first:53611.15 04:15:05 INFO - PID 13438 | Values: 805.7 834.3 838.0 840.2 840.4 39317.0 42834.1 42867.8 43012.8 43151.4 40536.6 40556.6 40795.4 40988.4 41197.0 7225.1 7298.1 7312.2 7332.0 7349.0 7207.3 7293.3 7297.7 7324.4 7337.9 7279.9 7313.7 7316.2 7318.6 7879.0 8002.7 8057.8 8069.0 8075.2 8077.8 7911.1 7984.7 7989.5 7989.8 7990.0 37779.6 39412.0 40217.6 40384.2 40415.4 3537.7 3585.0 3587.6 3590.6 3591.1 33142.7 33151.2 33185.2 33189.8 33195.7 5198.2 5202.8 5205.3 5228.6 5241.8 192234.0 192861.0 193467.0 194013.0 194382.0 43126.1 43674.3 50617.7 50634.0 50709.2 58061.0 58936.4 58964.7 58991.4 58994.0 15901.3 15964.6 16003.9 16028.2 16040.3 12884.3 12955.5 12980.8 12989.1 13017.3 14869.9 14955.8 15010.1 15042.5 15107.8 5760.6 5960.0 6050.2 6109.1 6111.1 870.3 874.4 890.5 903.3 912.2 22935.7 23033.5 23058.5 23081.8 23543.0 981.1 997.2 998.0 1001.2 1004.4 12117.4 12323.6 12367.2 12387.7 12397.1 232225.0 233445.0 235951.0 236390.0 237189.0 51508.0 52074.2 52104.0 52117.5 52550.5 1409.7 1451.0 1453.6 1458.1 1461.1 22983.0 23019.9 23142.5 23248.0 23541.8 38053.2 38103.4 38176.6 38235.8 38251.8 186752.0 187310.0 187382.0 188122.0 188192.0 32027.7 36727.3 36795.3 37670.4 37694.4 44189.1 46220.3 46226.8 46538.5 46562.0 32403.8 32582.7 32727.5 32766.5 32822.0 32873.0 32903.7 32975.8 33028.5 33370.7 36865.6 37341.0 37389.4 37483.3 37613.0 31940.2 32280.4 32449.0 32470.2 32650.5 23504.1 23584.8 23828.0 24030.0 24398.1 04:15:05 INFO - PID 13438 | 04:15:05 INFO - PID 13438 | [#2] jquery.html Cycles:180 Average:34435.56 Median:23026.65 stddev:80595.43 (350.0%) stddev-sans-first:80781.45 04:15:05 INFO - PID 13438 | Values: 586.6 587.7 594.2 607.9 633.7 23004.0 23701.3 23747.8 23795.9 23796.9 20940.6 21789.8 24689.3 24763.0 24928.8 6679.5 6767.0 6819.3 6820.9 6824.9 6679.2 6799.8 6814.7 6816.5 6819.0 6238.6 6712.2 6762.3 6771.9 6776.9 6543.5 6559.2 6613.3 6613.7 6614.7 6104.0 6138.3 6144.9 6164.2 6165.0 27846.7 28270.3 28297.0 28311.0 28322.2 2051.5 2095.6 2107.1 2116.6 2116.7 18519.9 19370.1 19389.2 19405.9 19426.4 2417.8 2426.3 2486.7 2495.4 2495.5 123637.4 127330.0 137800.0 141409.0 144642.3 14403.2 14532.4 14900.2 14966.9 15208.4 23319.4 23391.2 23478.5 23523.8 23555.4 9957.4 9990.2 10038.8 10082.8 10095.8 9230.6 9254.8 9278.4 9292.2 9326.3 8946.2 8983.2 9063.3 9176.0 9178.7 2699.5 2750.3 2798.0 2812.2 2857.7 975.9 986.8 993.5 1012.7 1012.8 18091.5 18802.7 19010.6 19209.7 19431.8 1040.8 1051.2 1055.4 1069.5 1079.6 10205.6 10561.4 10610.4 10799.7 10832.5 465006.0 475399.0 476540.0 483228.0 483863.0 116530.0 118590.0 118944.0 119612.0 120886.4 1079.5 1127.1 1193.5 1201.5 1254.8 18745.5 18888.0 18895.3 19026.0 19207.1 56159.0 57250.0 58056.7 58511.1 59320.7 72967.0 73468.0 74047.0 74115.3 74662.3 14626.2 14905.3 15023.1 15055.1 15067.2 22717.9 22835.3 22948.9 23049.3 23091.2 18208.5 18295.9 18554.5 18623.3 18747.7 15491.2 15574.6 15601.5 15662.3 16233.3 17893.5 18658.7 18817.2 18999.5 19137.8 14537.6 14696.8 14701.9 14770.7 14823.4 17868.9 18034.3 18037.7 18343.4 18349.6 04:15:05 INFO - PID 13438 | 04:15:05 INFO - PID 13438 | [#3] mootools.html Cycles:180 Average:9446.12 Median:2733.46 stddev:6833.73 (250.0%) stddev-sans-first:6825.58 04:15:05 INFO - PID 13438 | Values: 1313.9 1367.9 1369.7 1370.6 1372.5 14979.1 15752.9 15762.7 15775.7 15785.7 15385.8 15424.4 15482.8 15502.9 15541.0 2733.7 2854.0 2856.6 2865.7 2870.2 2733.3 2809.2 2822.3 2824.0 2831.2 2635.2 2909.8 2910.2 2910.3 2910.6 2765.4 2801.8 2816.6 2818.2 2833.7 2693.3 2748.7 2750.4 2759.6 2768.5 15033.3 15439.6 15441.5 15444.5 15456.7 8074.9 8375.6 8426.7 8428.6 8439.3 5345.1 5418.9 5502.6 5533.8 5673.6 1948.7 1974.0 1974.0 1977.9 2010.8 26825.7 26850.6 27032.3 27046.7 27152.2 6694.4 6857.4 6964.0 7147.6 7260.3 17894.0 17972.3 18003.8 18018.4 18029.1 7913.3 7965.4 7978.2 7986.5 8008.4 7162.8 7295.6 7333.1 7357.7 7372.9 5078.6 5250.8 5308.9 5342.6 5349.5 1484.1 1528.8 1574.3 1593.6 1609.6 881.9 897.7 898.1 903.4 906.0 7372.9 7500.4 7546.1 7561.0 7609.4 960.9 974.1 981.3 982.8 988.2 4680.4 4706.8 4755.0 4785.0 4795.5 21565.6 22326.8 22565.8 22648.4 22655.0 21586.7 22019.6 22054.8 22104.2 22473.2 11362.1 11574.8 11580.8 11608.0 11613.7 8142.8 8270.9 8377.9 8392.9 8439.5 18476.9 18826.4 18837.8 18917.3 19237.3 19033.5 19081.4 19137.7 19189.0 19238.3 11190.4 11396.8 11399.4 11399.9 11400.1 14008.6 14112.6 14195.5 14357.3 14395.4 11317.2 11386.4 11403.7 11431.1 11670.5 10944.3 11037.4 11125.8 11191.0 11286.6 9978.2 9997.7 10038.9 10064.5 10087.9 6832.6 6912.3 6943.1 6970.2 7036.8 6700.3 6795.7 6823.0 6913.6 6947.5 04:15:05 INFO - PID 13438 | 04:15:05 INFO - PID 13438 | [#4] prototype.html Cycles:180 Average:5544.48 Median:6199.88 stddev:1539.10 (24.8%) stddev-sans-first:1496.45 04:15:05 INFO - PID 13438 | Values: 517.7 522.9 535.3 545.4 545.8 6245.7 6300.5 6315.5 6360.4 6368.6 6157.7 6195.9 6196.7 6213.7 6229.2 5155.3 5195.4 5202.6 5217.4 5236.5 4948.7 5187.6 5191.3 5267.6 5274.2 4942.8 4998.1 5001.8 5015.7 5033.4 4943.1 4974.9 5016.6 5021.5 5022.2 4456.2 4497.4 4504.9 4547.7 4564.5 6182.3 6193.3 6199.6 6200.2 6221.6 5708.9 5744.3 5768.9 5788.3 5792.9 6551.2 6638.1 6638.2 6645.8 6699.8 4718.2 4970.5 4980.4 4997.7 5014.3 6780.6 6781.4 6786.3 6940.4 6999.7 4996.8 5010.5 5014.7 5034.2 5103.2 5137.4 5138.9 5144.4 5150.6 5153.1 5649.8 5699.0 5745.7 5775.4 5781.3 6601.8 6647.4 6669.9 6699.9 6736.6 1775.6 1781.2 1784.8 1791.9 1797.8 1151.3 1214.9 1245.3 1249.2 1259.4 5731.4 5751.7 5766.2 5798.7 5828.9 6731.0 6758.0 6783.6 6786.9 6867.6 5703.1 5740.3 5770.5 5780.9 5808.7 3526.2 3592.6 3604.1 3606.0 3637.5 6458.7 6510.5 6603.1 6639.5 6654.4 6516.0 6767.0 6782.6 6818.2 6887.0 6446.8 6467.7 6496.3 6516.3 6538.7 6473.8 6688.7 6720.6 6738.0 6746.8 6586.8 6592.2 6605.5 6707.8 6710.7 6475.8 6506.5 6561.9 6583.8 6590.9 4981.7 4993.5 5002.4 5015.4 5079.5 6491.8 6613.4 6712.2 6781.8 6833.5 6295.8 6424.6 6453.8 6562.2 6610.8 6420.3 6452.8 6523.3 6545.5 6585.7 6461.0 6487.4 6500.4 6506.2 6512.5 6487.4 6575.7 6622.1 6648.5 6682.5 6253.9 6279.2 6317.8 6355.3 6415.7 04:15:05 INFO - PID 13438 | 04:15:05 INFO - PID 13438 | [#5] yui.html Cycles:180 Average:24738.01 Median:18253.09 stddev:36248.33 (198.6%) stddev-sans-first:36305.83 04:15:05 INFO - PID 13438 | Values: 903.6 916.2 931.3 933.9 936.3 17229.0 17555.9 17677.2 17781.9 17847.9 18180.1 18326.1 18357.1 18840.5 19279.7 955.4 958.6 962.1 962.4 968.5 964.6 990.6 993.0 993.9 994.3 1067.9 1068.2 1068.5 1070.2 1075.4 1007.4 1049.5 1056.5 1057.6 1060.3 748.6 749.0 749.2 749.3 751.5 20426.2 20573.7 20657.8 20691.6 20705.4 21392.7 21553.5 21870.6 22080.4 22125.1 17097.7 17372.0 17797.6 18047.5 18049.5 3748.7 3753.7 3768.8 3783.4 3799.9 144399.3 144700.0 145710.5 146917.0 148485.0 16958.7 17411.8 17525.3 17539.3 17547.6 31544.4 31979.8 32110.0 32221.0 32279.4 8172.3 8237.6 8315.3 8385.7 8422.3 4442.5 4565.8 4587.9 4597.5 4598.7 5583.2 5680.9 5693.2 5705.0 5718.6 1006.5 1014.5 1017.1 1017.8 1021.0 697.5 713.4 715.2 731.9 736.8 11643.5 11711.5 11860.5 11867.0 12060.2 691.4 702.2 706.0 711.3 713.0 5715.5 5836.7 5843.6 5975.5 6032.2 120745.0 121712.0 121784.4 122573.0 123068.0 110520.0 112374.0 113180.4 113735.9 114802.0 96851.5 97050.5 97156.5 99196.0 99207.0 10593.2 10729.3 10788.8 10863.2 11133.9 42365.4 42859.4 44229.3 45008.5 45270.0 56078.7 57274.7 57349.4 58878.8 59390.1 15905.5 16110.5 16112.8 16341.7 16348.6 17637.3 17673.5 17832.0 17957.6 18039.3 15268.1 15418.2 15467.0 15572.5 15615.5 16157.3 16192.3 16325.0 16419.2 16428.6 15652.9 15878.9 15886.0 15973.5 16053.0 11932.5 11948.2 11973.0 12357.4 12380.3 11281.0 11372.5 11408.7 11612.5 11697.5 04:15:05 INFO - PID 13438 | -------- Summary: end -------- 04:15:05 INFO - PID 13438 | 04:15:06 INFO - TEST-INFO | 13438: exit 0 04:15:06 INFO - TEST-OK | dromaeo_css | took 1110061ms 04:15:06 INFO - TEST-START | kraken 04:15:06 INFO - Initialising browser for kraken test... 04:15:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40020/getInfo.html -profile /tmp/tmpqdwLIF/profile 04:15:06 INFO - TEST-INFO | started process 13802 (/builds/slave/test/build/application/firefox/firefox http://localhost:40020/getInfo.html) 04:15:12 INFO - TEST-INFO | 13802: exit 0 04:15:12 INFO - Browser initialized. 04:15:12 INFO - Running cycle 1/1 for kraken test... 04:15:12 INFO - Using env: {'DISPLAY': ':0', 04:15:12 INFO - 'HOME': '/home/cltbld', 04:15:12 INFO - 'JSGC_DISABLE_POISONING': '1', 04:15:12 INFO - 'LANG': 'en_US.UTF-8', 04:15:12 INFO - 'LANGUAGE': 'en_US:en', 04:15:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:15:12 INFO - 'LOGNAME': 'cltbld', 04:15:12 INFO - 'MAIL': '/var/mail/cltbld', 04:15:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:15:12 INFO - 'MOZ_CRASHREPORTER': '1', 04:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:15:12 INFO - 'MOZ_NO_REMOTE': '1', 04:15:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:12 INFO - 'NO_EM_RESTART': '1', 04:15:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:12 INFO - 'PWD': '/builds/slave/test', 04:15:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:12 INFO - 'RUST_BACKTRACE': 'full', 04:15:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:15:12 INFO - 'SHELL': '/bin/bash', 04:15:12 INFO - 'SHLVL': '1', 04:15:12 INFO - 'STYLO_FORCE_DISABLED': '1', 04:15:12 INFO - 'TERM': 'linux', 04:15:12 INFO - 'TMOUT': '86400', 04:15:12 INFO - 'USER': 'cltbld', 04:15:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360', 04:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:12 INFO - '_': '/tools/buildbot/bin/python'} 04:15:12 INFO - TEST-INFO | started process 14034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqdwLIF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:13 INFO - PID 14034 | 04:15:13 INFO - PID 14034 | (/builds/slave/test/build/application/firefox/firefox:14084): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:15:13 INFO - PID 14034 | 04:15:23 INFO - PID 14034 | RSS: Main: 151646208 04:15:23 INFO - PID 14034 | 04:15:26 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40020/tests/kraken/driver.html?testName=audio-beat-detection) 04:15:26 INFO - PID 14034 | RSS: Main: 157569024 04:15:26 INFO - PID 14034 | 04:15:29 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40020/tests/kraken/driver.html?testName=audio-dft) 04:15:30 INFO - PID 14034 | RSS: Main: 158253056 04:15:30 INFO - PID 14034 | 04:15:33 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40020/tests/kraken/driver.html?testName=audio-fft) 04:15:33 INFO - PID 14034 | RSS: Main: 154435584 04:15:33 INFO - PID 14034 | 04:15:35 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40020/tests/kraken/driver.html?testName=audio-oscillator) 04:15:36 INFO - PID 14034 | RSS: Main: 155062272 04:15:36 INFO - PID 14034 | 04:15:38 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40020/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:15:39 INFO - PID 14034 | RSS: Main: 155418624 04:15:39 INFO - PID 14034 | 04:15:42 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40020/tests/kraken/driver.html?testName=imaging-darkroom) 04:15:42 INFO - PID 14034 | RSS: Main: 158056448 04:15:42 INFO - PID 14034 | 04:15:46 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40020/tests/kraken/driver.html?testName=imaging-desaturate) 04:15:47 INFO - PID 14034 | RSS: Main: 158654464 04:15:47 INFO - PID 14034 | 04:15:50 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40020/tests/kraken/driver.html?testName=json-parse-financial) 04:15:50 INFO - PID 14034 | RSS: Main: 158732288 04:15:50 INFO - PID 14034 | 04:15:52 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40020/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:15:53 INFO - PID 14034 | RSS: Main: 158543872 04:15:53 INFO - PID 14034 | 04:15:54 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40020/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:15:55 INFO - PID 14034 | RSS: Main: 158089216 04:15:55 INFO - PID 14034 | 04:15:57 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40020/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:15:58 INFO - PID 14034 | RSS: Main: 155095040 04:15:58 INFO - PID 14034 | 04:16:00 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40020/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:16:01 INFO - PID 14034 | RSS: Main: 155488256 04:16:01 INFO - PID 14034 | 04:16:04 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40020/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:16:04 INFO - PID 14034 | RSS: Main: 156016640 04:16:04 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | Cycle 1(1): loaded http://localhost:40020/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40020/tests/kraken/driver.html?testName=ai-astar) 04:16:06 INFO - PID 14034 | RSS: Main: 156999680 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | __start_tp_report 04:16:06 INFO - PID 14034 | _x_x_mozilla_page_load 04:16:06 INFO - PID 14034 | _x_x_mozilla_page_load_details 04:16:06 INFO - PID 14034 | |i|pagename|runs| 04:16:06 INFO - PID 14034 | |0;ai-astar;107;107;108;107;108;111;107;107;108;107 04:16:06 INFO - PID 14034 | |1;audio-beat-detection;124;129;122;117;116;114;115;119;129;121 04:16:06 INFO - PID 14034 | |2;audio-dft;163;163;164;163;162;164;165;172;169;166 04:16:06 INFO - PID 14034 | |3;audio-fft;81;78;75;74;72;74;73;76;74;74 04:16:06 INFO - PID 14034 | |4;audio-oscillator;80;80;79;79;78;83;84;79;79;78 04:16:06 INFO - PID 14034 | |5;imaging-gaussian-blur;113;114;110;113;113;110;114;114;114;115 04:16:06 INFO - PID 14034 | |6;imaging-darkroom;154;149;149;148;153;148;149;149;151;149 04:16:06 INFO - PID 14034 | |7;imaging-desaturate;94;94;94;94;95;94;98;95;94;95 04:16:06 INFO - PID 14034 | |8;json-parse-financial;54;54;54;55;55;55;66;54;54;53 04:16:06 INFO - PID 14034 | |9;json-stringify-tinderbox;44;43;38;38;38;38;38;38;38;38 04:16:06 INFO - PID 14034 | |10;stanford-crypto-aes;72;71;74;78;79;76;77;76;71;70 04:16:06 INFO - PID 14034 | |11;stanford-crypto-ccm;111;114;110;111;112;111;122;122;116;110 04:16:06 INFO - PID 14034 | |12;stanford-crypto-pbkdf2;169;169;169;166;165;170;169;169;165;167 04:16:06 INFO - PID 14034 | |13;stanford-crypto-sha256-iterative;67;68;67;64;65;64;65;63;66;63 04:16:06 INFO - PID 14034 | __end_tp_report 04:16:06 INFO - PID 14034 | __start_cc_report 04:16:06 INFO - PID 14034 | _x_x_mozilla_cycle_collect,702 04:16:06 INFO - PID 14034 | __end_cc_report 04:16:06 INFO - PID 14034 | __startTimestamp1506338166769__endTimestamp 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | ------- Summary: start ------- 04:16:06 INFO - PID 14034 | Number of tests: 14 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#0] ai-astar Cycles:10 Average:107.70 Median:107.50 stddev:1.25 (1.2%) stddev-sans-first:1.30 04:16:06 INFO - PID 14034 | Values: 107.0 107.0 108.0 107.0 108.0 111.0 107.0 107.0 108.0 107.0 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#1] audio-beat-detection Cycles:10 Average:120.60 Median:121.50 stddev:5.44 (4.5%) stddev-sans-first:5.63 04:16:06 INFO - PID 14034 | Values: 124.0 129.0 122.0 117.0 116.0 114.0 115.0 119.0 129.0 121.0 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.50 stddev:3.14 (1.9%) stddev-sans-first:3.24 04:16:06 INFO - PID 14034 | Values: 163.0 163.0 164.0 163.0 162.0 164.0 165.0 172.0 169.0 166.0 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#3] audio-fft Cycles:10 Average:75.10 Median:74.50 stddev:2.64 (3.5%) stddev-sans-first:1.74 04:16:06 INFO - PID 14034 | Values: 81.0 78.0 75.0 74.0 72.0 74.0 73.0 76.0 74.0 74.0 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#4] audio-oscillator Cycles:10 Average:79.90 Median:79.50 stddev:2.02 (2.5%) stddev-sans-first:2.15 04:16:06 INFO - PID 14034 | Values: 80.0 80.0 79.0 79.0 78.0 83.0 84.0 79.0 79.0 78.0 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:114.00 stddev:1.70 (1.5%) stddev-sans-first:1.80 04:16:06 INFO - PID 14034 | Values: 113.0 114.0 110.0 113.0 113.0 110.0 114.0 114.0 114.0 115.0 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:149.00 stddev:2.08 (1.4%) stddev-sans-first:1.59 04:16:06 INFO - PID 14034 | Values: 154.0 149.0 149.0 148.0 153.0 148.0 149.0 149.0 151.0 149.0 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.50 stddev:1.25 (1.3%) stddev-sans-first:1.30 04:16:06 INFO - PID 14034 | Values: 94.0 94.0 94.0 94.0 95.0 94.0 98.0 95.0 94.0 95.0 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.50 stddev:3.78 (6.9%) stddev-sans-first:3.97 04:16:06 INFO - PID 14034 | Values: 54.0 54.0 54.0 55.0 55.0 55.0 66.0 54.0 54.0 53.0 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#9] json-stringify-tinderbox Cycles:10 Average:39.10 Median:38.00 stddev:2.33 (6.1%) stddev-sans-first:1.67 04:16:06 INFO - PID 14034 | Values: 44.0 43.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:76.00 stddev:3.24 (4.3%) stddev-sans-first:3.32 04:16:06 INFO - PID 14034 | Values: 72.0 71.0 74.0 78.0 79.0 76.0 77.0 76.0 71.0 70.0 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#11] stanford-crypto-ccm Cycles:10 Average:113.90 Median:113.00 stddev:4.65 (4.1%) stddev-sans-first:4.82 04:16:06 INFO - PID 14034 | Values: 111.0 114.0 110.0 111.0 112.0 111.0 122.0 122.0 116.0 110.0 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:169.00 stddev:1.87 (1.1%) stddev-sans-first:1.94 04:16:06 INFO - PID 14034 | Values: 169.0 169.0 169.0 166.0 165.0 170.0 169.0 169.0 165.0 167.0 04:16:06 INFO - PID 14034 | 04:16:06 INFO - PID 14034 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:1.75 (2.7%) stddev-sans-first:1.73 04:16:06 INFO - PID 14034 | Values: 67.0 68.0 67.0 64.0 65.0 64.0 65.0 63.0 66.0 63.0 04:16:06 INFO - PID 14034 | -------- Summary: end -------- 04:16:06 INFO - PID 14034 | 04:16:07 INFO - PID 14034 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:16:07 INFO - TEST-INFO | 14034: exit 0 04:16:07 INFO - TEST-OK | kraken | took 61257ms 04:16:07 INFO - SUITE-END | took 1171s 04:16:07 INFO - Completed test suite (00:19:31) 04:16:07 INFO - javascript benchmark 04:16:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8589.613130052048, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.513995330723, 3153.826539540326, 3173.904782856512, 3198.264399188187, 3204.214967333003, 6277.497800175986, 6346.428821406084, 6352.618842869425, 6392.041193820929, 6483.643399613014, 6352.872942541147, 6396.456301214403, 6559.3112723164095, 6571.3757193066585, 6573.671316434171, 5789.681567513785, 5877.85305367365, 5922.170896074553, 5952.047672372421, 5982.282126144869, 5829.358770535237, 5908.793192238272, 5935.258092738408, 5995.460408563228, 6000.96999515004, 5691.914621280664, 5771.394003629643, 5805.10020946754, 5814.854628634275, 5902.645841249518, 5842.065269556851, 5860.384659610722, 5863.8534036649, 5866.73599688015, 5899.557533185029, 5813.215215945836, 5850.76596936122, 5869.589128760988, 5886.587938844283, 5926.792562260343, 6368.172137622079, 6376.776812811529, 6405.359464053604, 6415.0, 6494.967525162391, 6699.196096468406, 6784.8303792405095, 6793.524453288272, 6901.654917254117, 6941.340572645641, 6889.896651550231, 6897.48268879836, 6983.580985140908, 6989.790306290819, 6991.755288564876, 6122.173506576644, 6306.1171435998995, 6329.68351582419, 6439.066335381391, 6463.289038205747, 7028.051213086168, 7116.395106415909, 7118.466115041289, 7120.038794762744, 7126.928730712731, 6698.430633396216, 6698.4641228701585, 6777.152855893013, 6789.0, 6792.049113124167, 6713.530052896251, 6772.085768421299, 6807.183138023469, 6819.24988251292, 6821.624810635363, 6730.697118629673, 6777.051212830208, 6779.0, 6783.559068660521, 6841.794746157623, 6794.082798822095, 6834.0, 6854.554453960476, 6878.931210687929, 6889.965550172217, 5271.341082364705, 5322.494363035506, 5380.757865896044, 5387.380451248078, 5401.000814849265, 4594.104149690845, 4616.3306320584, 4623.676342656049, 4640.32715256286, 4682.204025315705, 5808.244928159397, 5880.294364676266, 5884.205632239593, 5889.146073819272, 5933.732982015819, 6850.0, 6863.588184708933, 6924.272951340137, 6965.164180298397, 7009.228984811667, 5885.352611212763, 5900.970495147582, 5986.55100867428, 5987.670678112746, 5991.820245392558, 5775.306963164448, 5815.127730840408, 5817.621854579524, 5827.650340979555, 5889.528837692974, 6717.966410167918, 6741.932580674229, 6781.830454238683, 6782.694778734969, 6789.966050169717, 6927.134108236471, 6928.1339832520935, 6939.4448444125355, 7014.579125252501, 7021.262767409348, 6581.473482121323, 6684.665766711742, 6691.063251144941, 6776.627285499345, 6791.558548694319, 6770.424513916372, 6771.796846094625, 6790.287019863041, 6803.625800580818, 6807.591544507345, 6890.586564806128, 6947.756828510978, 6961.965190174017, 6989.7553585624255, 6991.2309645937885, 6448.484121270193, 6503.804885853432, 6600.108985287116, 6633.237177724431, 6672.199336079701, 6665.700043497957, 6690.59856408617, 6699.129113215251, 6717.9328206719265, 6736.259011508632, 6425.903611445926, 6572.80281591553, 6578.375054369827, 6654.90017649726, 6674.899876501953, 6487.740490380332, 6560.081588577698, 6568.080468734476, 6582.967085164543, 6584.868302633825, 6331.081993110881, 6404.103425520524, 6406.615603063831, 6438.581492202992, 6498.090267362668], "value": 6235.318807362819, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.689809423372, 834.3283656656394, 837.9874301885469, 840.2143995364331, 840.4327079221524, 39317.0, 42834.143317133676, 42867.78566107165, 43012.78493607527, 43151.35272970908, 40536.594634053654, 40556.59443405565, 40795.38806917899, 40988.38517422241, 41197.0, 7225.132984041922, 7298.124225092996, 7312.159101703292, 7332.0, 7349.00788393568, 7207.279272072803, 7293.307135822089, 7297.671604777771, 7324.414046876237, 7337.926620733778, 7279.854402911938, 7313.7074517019255, 7316.195218525958, 7318.560886346836, 7878.960605196995, 8002.719904803333, 8057.838843223161, 8069.031716194065, 8075.152109028585, 8077.838443231161, 7911.090224624184, 7984.720534781313, 7989.520628762293, 7989.760307190793, 7989.96005019977, 37779.622203777886, 39412.0, 40217.59782402197, 40384.192316153516, 40415.39376909348, 3537.7169826414083, 3585.0, 3587.5694916609914, 3590.5870824855215, 3591.084273510264, 33142.6685733142, 33151.171220719436, 33185.170370740685, 33189.83405082959, 33195.672173113046, 5198.246254293106, 5202.843914682566, 5205.323307969939, 5228.5555727763185, 5241.842744717626, 192234.0, 192861.0, 193467.0, 194013.02993485084, 194382.02808986005, 43126.13747725028, 43674.34488482675, 50617.746911265946, 50634.0, 50709.23936140961, 58061.0, 58936.410635893095, 58964.70517647384, 58991.41008589945, 58994.0, 15901.284442200129, 15964.600884977968, 16003.919980400024, 16028.19859007045, 16040.278187481592, 12884.291363974884, 12955.5465558705, 12980.805287920688, 12989.090763646644, 13017.284049377186, 14869.851301487062, 14955.775663365059, 15010.099394036393, 15042.473513427196, 15107.848921510864, 5760.567957403212, 5960.0, 6050.183225264621, 6109.14471973924, 6111.113888486145, 870.2863651805459, 874.3791907745444, 890.470170248701, 903.263839970422, 912.1927094521396, 22935.655965160535, 23033.539329213658, 23058.538829223322, 23081.79519532394, 23543.0, 981.0875885426622, 997.1823105053932, 998.0169533009979, 1001.1740314240635, 1004.42747633848, 12117.394130293625, 12323.630291091282, 12367.196132251374, 12387.690307742198, 12397.070219733556, 232225.0, 233445.0, 235951.0, 236390.0, 237189.0, 51508.0, 52074.21888671673, 52104.0, 52117.47882521126, 52550.47449525532, 1409.7391982483273, 1451.0495625365402, 1453.6075259679826, 1458.0522660270697, 1461.0649184521915, 22983.0, 23019.88490057539, 23142.537149257256, 23248.0, 23541.76458235464, 38053.23893522169, 38103.42844857274, 38176.61823381731, 38235.80882095572, 38251.80874095612, 186752.0, 187310.0, 187382.0, 188122.0, 188192.0, 32027.67972320247, 36727.26545469129, 36795.26409471849, 37670.434943475324, 37694.434583481816, 44189.116217676106, 46220.30669540027, 46226.76886615546, 46538.53461465342, 46562.0, 32403.837980809945, 32582.674173257965, 32727.509087364186, 32766.508502372006, 32822.0, 32873.0, 32903.67096329006, 32975.835120824246, 33028.50457243095, 33370.666293336755, 36865.63134368622, 37341.0, 37389.439158412104, 37483.250334992605, 37613.0, 31940.20149496281, 32280.35439291248, 32449.0, 32470.188245294055, 32650.51024234686, 23504.059837606303, 23584.764152358945, 23828.0, 24030.0, 24398.146064887645], "value": 17270.013253326113, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.6450797267651, 587.729644363593, 594.200799924102, 607.8510764862609, 633.6578247746218, 23004.0, 23701.288961331145, 23747.76252237477, 23795.881020594916, 23796.8810155949, 20940.58118837626, 21789.782102178975, 24689.259322220318, 24763.0, 24928.75071249287, 6679.499037572177, 6767.0, 6819.318068193191, 6820.863582728342, 6824.897626535606, 6679.231888332831, 6799.796006119825, 6814.6933387997415, 6816.488763342744, 6819.0, 6238.59449135807, 6712.194536655608, 6762.3237676232475, 6771.932280677204, 6776.864462710742, 6543.476521878239, 6559.245686746038, 6613.272540020594, 6613.702383392735, 6614.735410583571, 6104.0, 6138.263408390977, 6144.938550614482, 6164.229471316085, 6164.969175154096, 27846.721532784617, 28270.293242668893, 28297.0, 28311.0, 28322.15033548997, 2051.5281485258474, 2095.5704080663427, 2107.136074209582, 2116.6401711709045, 2116.724825772655, 18519.90740046291, 19370.128344224544, 19389.224431022743, 19405.902970485058, 19426.417207483657, 2417.782399584046, 2426.308502076917, 2486.66430031947, 2495.351208685755, 2495.4759500504915, 123637.38181309126, 127330.0, 137800.0, 141409.0, 144642.27678861644, 14403.231657695444, 14532.418703251962, 14900.18049007315, 14966.850331496546, 15208.391664333523, 23319.41701457477, 23391.181308654115, 23478.530429391318, 23523.76476235216, 23555.411114721926, 9957.402555846673, 9990.150837178775, 10038.849417258747, 10082.848757268646, 10095.848562271573, 9230.630774769068, 9254.814903702023, 9278.350515463988, 9292.210162136294, 9326.300527460467, 8946.150115738994, 8983.203359328161, 9063.32025098107, 9175.954120229357, 9178.66909298148, 2699.5275826730244, 2750.2711781377952, 2797.9860100699366, 2812.170409729135, 2857.7142285771256, 975.8975307592742, 986.7779749556292, 993.5181437003048, 1012.7417508535276, 1012.8227560176939, 18091.54771130732, 18802.717959230624, 19010.61978760417, 19209.711854322195, 19431.805681943282, 1040.8230600797883, 1051.169576034924, 1055.4353420919924, 1069.5294070608907, 1079.5681727308981, 10205.642802502025, 10561.419121948213, 10610.416427096583, 10799.730006749736, 10832.458377081115, 465006.0, 475399.0, 476540.0, 483228.0, 483863.0, 116530.0, 118590.0, 118944.0, 119612.0, 120886.39556802336, 1079.5304042741432, 1127.1208457403238, 1193.451012534244, 1201.5193922430922, 1254.8305978692943, 18745.531361716065, 18887.961162135663, 18895.338663146726, 19026.0, 19207.135678894203, 56159.0, 57250.0, 58056.70971645115, 58511.12233316419, 59320.70339648274, 72967.0, 73468.0, 74047.0, 74115.25884741299, 74662.25337746553, 14626.195559244345, 14905.25473726331, 15023.09861408319, 15055.096694198382, 15067.171305578298, 22717.88641056784, 22835.31494055181, 22948.885255573616, 23049.308520744406, 23091.19180828663, 18208.45374638763, 18295.908520457313, 18554.536136596154, 18623.348182813537, 18747.71878421852, 15491.225438728245, 15574.610634734223, 15601.453949111727, 15662.295196716403, 16233.269502872163, 17893.463196104138, 18658.72011919795, 18817.247310107443, 18999.525011874815, 19137.808621913602, 14537.636559086108, 14696.77954830657, 14701.852981470476, 14770.704585908437, 14823.40706371733, 17868.910655446638, 18034.278628855223, 18037.72943405876, 18343.449696509128, 18349.63300733951], "value": 12006.037395402825, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.8554758976513, 1367.8563750806159, 1369.7329020840934, 1370.5793586365921, 1372.4715984346024, 14979.101253924771, 15752.921235393836, 15762.684746305067, 15775.684486310281, 15785.684286314296, 15385.769213461806, 15424.383024678998, 15482.767758483631, 15502.922485387586, 15541.0, 2733.658292713406, 2854.0, 2856.585795059715, 2865.7134286571386, 2870.196345023386, 2733.2620192548, 2809.2415047937147, 2822.32264256579, 2823.957640635392, 2831.164806382112, 2635.235781623327, 2909.767218622505, 2910.1851481585086, 2910.3160757222035, 2910.5634154876725, 2765.391613844961, 2801.789865760066, 2816.6479190101236, 2818.2390754496378, 2833.7024612415707, 2693.299742067057, 2748.69764325924, 2750.4499100179846, 2759.599858020576, 2768.4878297514824, 15033.323500442506, 15439.614009649737, 15441.5367538974, 15444.5366639001, 15456.690866182726, 8074.919250807476, 8375.581220938928, 8426.705065322745, 8428.62071206791, 8439.324854011726, 5345.091334473149, 5418.91871621926, 5502.642328248651, 5533.750981205855, 5673.631213971079, 1948.7369205157406, 1973.9506512337164, 1973.9901300493405, 1977.8813271203774, 2010.7788143304224, 26825.731742682518, 26850.5972410414, 27032.32419189536, 27046.72953270462, 27152.185434436997, 6694.397504224546, 6857.382835544725, 6964.0, 7147.606881621561, 7260.346568808727, 17894.0, 17972.281108755764, 18003.819961800476, 18018.36935707244, 18029.098545072695, 7913.287804097658, 7965.402594805413, 7978.162292959272, 7986.480878742863, 8008.439409241297, 7162.785116446515, 7295.562266264041, 7333.1200255969625, 7357.705691772377, 7372.889406658905, 5078.568321692697, 5250.789968401221, 5308.946910530845, 5342.6260161788305, 5349.518543331041, 1484.094702231638, 1528.808898887639, 1574.3151728997693, 1593.55380493462, 1609.609729551615, 881.9382643215042, 897.699270744308, 898.1377877237925, 903.4127816918924, 906.0169715858367, 7372.889406658905, 7500.437467189982, 7546.056742907137, 7561.0, 7609.391248700091, 960.870282511852, 974.1476208317722, 981.3228872078244, 982.8378317577519, 988.2341185581232, 4680.438347398334, 4706.788194531255, 4754.976225118852, 4784.952150478521, 4795.520447955177, 21565.568688626452, 22326.77673223247, 22565.774342256696, 22648.433789155075, 22655.0, 21586.676199857015, 22019.559608807733, 22054.779452205592, 22104.2263520776, 22473.21343752961, 11362.091032717362, 11574.768504630028, 11580.76838463226, 11608.013318867823, 11613.6515904523, 8142.837143256983, 8270.875936860832, 8377.874331884905, 8392.916070839214, 8439.535825529654, 18476.907615461838, 18826.435206943814, 18837.811621883604, 18917.337893173673, 19237.326693566218, 19033.524161896064, 19081.42755717331, 19137.712934305717, 19189.0, 19238.326658566883, 11190.440477975906, 11396.772064558496, 11399.373034482851, 11399.943000284946, 11400.144989126014, 14008.579742607739, 14112.576622701336, 14195.503157389441, 14357.282135892954, 14395.352209150404, 11317.207795454238, 11386.373749443861, 11403.714907127389, 11431.085513159094, 11670.533178673099, 10944.343339399662, 11037.448127593749, 11125.777484450427, 11191.0, 11286.604968826052, 9978.151857091938, 9997.700068997941, 10038.949805251219, 10064.496775161359, 10087.89912100899, 6832.59004459734, 6912.27421120775, 6943.062686537455, 6970.163580370388, 7036.824079397851, 6700.262971073275, 6795.72817087311, 6822.965885170543, 6913.5506192097355, 6947.513674042971], "value": 6740.048739072195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.7385420362714, 522.9398619158796, 535.3468768102915, 545.4273013335999, 545.7516829842422, 6245.687715614213, 6300.495960323175, 6315.526335524843, 6360.356939434216, 6368.649724265164, 6157.661328626924, 6195.876082478348, 6196.729670417565, 6213.720382582784, 6229.1902052733085, 5155.329807125068, 5195.40252870919, 5202.609804264676, 5217.373915130171, 5236.528712415882, 4948.7278199699, 5187.610929180308, 5191.299174611417, 5267.604929630293, 5274.156135018397, 4942.827001054964, 4998.075356059123, 5001.7999280028935, 5015.69905805651, 5033.370828646419, 4943.085529177096, 4974.8756281093265, 5016.573591244749, 5021.5229553192385, 5022.221555658879, 4456.17560751262, 4497.392851964975, 4504.932426013613, 4547.749873756942, 4564.52072532386, 6182.289036760785, 6193.318734939198, 6199.597026193283, 6200.162977997958, 6221.595596286227, 5708.857278568027, 5744.271471051259, 5768.913466298009, 5788.3343415506915, 5792.913106303409, 6551.246606640249, 6638.137042184533, 6638.20341559016, 6645.833854153637, 6699.765508207238, 4718.197906355894, 4970.453250142481, 4980.402351717781, 4997.725125118117, 5014.342398528785, 6780.627065511395, 6781.38967492928, 6786.253512113663, 6940.410065144419, 6999.720011199546, 4996.7501624918605, 5010.473900240495, 5014.699118052856, 5034.169362055293, 5103.18349064148, 5137.409197942285, 5138.87152821175, 5144.382674079135, 5150.583589512839, 5153.123968925292, 5649.830505084854, 5699.005348128122, 5745.68398738065, 5775.422457754191, 5781.306243250837, 6601.834954126185, 6647.401733843977, 6669.866602668017, 6699.899501507482, 6736.629485378351, 1775.6359946210996, 1781.1628534588722, 1784.7679801625707, 1791.9462416127537, 1797.8471829894345, 1151.268944220426, 1214.9392530373623, 1245.3212998915612, 1249.2005116725304, 1259.3577275589516, 5731.426857314235, 5751.654900705971, 5766.192733017381, 5798.710064496759, 5828.912566311508, 6730.966345168243, 6757.966210169016, 6783.559068660521, 6786.864262714718, 6867.587944723233, 5703.087505999103, 5740.339860915965, 5770.451807078321, 5780.88438231233, 5808.651480911159, 3526.2418580005424, 3592.6229344416165, 3604.0809593554, 3606.0, 3637.4543818427446, 6458.675971425846, 6510.544261901716, 6603.141591593062, 6639.502037347122, 6654.436207491236, 6515.967420162963, 6766.966165169143, 6782.626955517395, 6818.215905170969, 6887.0, 6446.806595802133, 6467.708953097028, 6496.285408605144, 6516.2506311773805, 6538.738450462023, 6473.77341793035, 6688.699008544724, 6720.563163394364, 6737.966310168418, 6746.831329216809, 6586.80239592813, 6592.175978002558, 6605.471562275103, 6707.798766037026, 6710.66446677674, 6475.838104047437, 6506.544541882023, 6561.934380656323, 6583.835404114935, 6590.934090659224, 4981.676191047571, 4993.500649934977, 5002.374703162105, 5015.420142655052, 5079.5428411443145, 6491.819008685804, 6613.43785778195, 6712.228093769084, 6781.830454238486, 6833.521653484208, 6295.779647712308, 6424.646644434601, 6453.806385808433, 6562.179727534059, 6610.8016759497295, 6420.26166990802, 6452.838489072012, 6523.347665233438, 6545.541812073109, 6585.736570537125, 6461.0, 6487.3836985486305, 6500.382463665944, 6506.219253689587, 6512.479001679949, 6487.448566871869, 6575.736970521126, 6622.079596917033, 6648.468122550088, 6682.498812588978, 6253.937460625518, 6279.183706118175, 6317.842053948688, 6355.269144048493, 6415.71129299192], "value": 5094.709156453892, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.5662881816723, 916.1800188830996, 931.3201363005011, 933.8972713001573, 936.3352020065753, 17229.0, 17555.912220438895, 17677.204525796336, 17781.911090444562, 17847.91076044621, 18180.090995450242, 18326.08369581519, 18357.08214589272, 18840.5289867753, 19279.710804337945, 955.3646824861459, 958.5878072428853, 962.1388856973005, 962.3840741925173, 968.5447839515434, 964.62379671928, 990.5839547390077, 993.0119531066599, 993.9204863610894, 994.2841154368842, 1067.9145668346514, 1068.2308737708838, 1068.5084860963966, 1070.1706177712258, 1075.3547871277249, 1007.4408703169738, 1049.4805071489586, 1056.4928834159607, 1057.6245432871335, 1060.289605964006, 748.6182047155935, 749.0187853911339, 749.2058418076856, 749.3330935467438, 751.4589495563185, 20426.182952682022, 20573.69139462909, 20657.793422065737, 20691.58616827655, 20705.378838634864, 21392.679109813365, 21553.46116347088, 21870.562588748136, 22080.447988800246, 22125.114995400163, 17097.743533847002, 17372.0, 17797.644047119116, 18047.458576242734, 18049.458516244533, 3748.7188460865545, 3753.7372383933134, 3768.8492460301554, 3783.4324851272254, 3799.8670046548236, 144399.27800361035, 144700.0, 145710.54289457077, 146917.0, 148485.0, 16958.745618815727, 17411.825881741275, 17525.298988040337, 17539.298428062735, 17547.649047019244, 31544.36911261808, 31979.84010079935, 32110.0, 32221.0, 32279.35441291161, 8172.305354044973, 8237.588120593946, 8315.334773218128, 8385.706500272461, 8422.284105851071, 4442.533533978885, 4565.794539245676, 4587.8623641290815, 4597.517260687647, 4598.747068911175, 5583.190437386556, 5680.8863822723315, 5693.17448969897, 5705.0, 5718.599698021182, 1006.4665727164614, 1014.4876837197169, 1017.0897047142765, 1017.7506510904876, 1020.9693709188737, 697.4594689115976, 713.350850725837, 715.2168375628678, 731.9011933388924, 736.7863319637353, 11643.53425862973, 11711.472983715754, 11860.525578976916, 11867.0, 12060.216085954386, 691.401937324211, 702.2415790945767, 705.9788206353818, 711.3277952334994, 712.9572225666477, 5715.514181294553, 5836.708164591753, 5843.590948633555, 5975.462208401264, 6032.1856549365275, 120745.0, 121712.0, 121784.39107804581, 122573.0, 123068.0, 110520.0, 112374.0, 113180.43409783063, 113735.86264137253, 114802.0, 96851.51574242224, 97050.51474742581, 97156.51421742846, 99196.0, 99207.00792992122, 10593.152547796311, 10729.302595331279, 10788.838167427339, 10863.239573229797, 11133.944330278297, 42365.36451953161, 42859.35710964401, 44229.33655995227, 45008.549914500436, 45270.0, 56078.719606401704, 57274.713626433266, 57349.42650573441, 58878.82242355043, 59390.10914836367, 15905.522834314988, 16110.516684499484, 16112.758308625615, 16341.67316653684, 16348.591285217964, 17637.294508220042, 17673.469795906145, 17832.0, 17957.551061223574, 18039.278428863225, 15268.083914965138, 15418.229088545751, 15467.0, 15572.454964076203, 15615.453459128876, 16157.272922718741, 16192.271347789143, 16325.0, 16419.179041048137, 16428.589285267964, 15652.92173539125, 15878.9206053969, 15886.046837189806, 15973.520794376187, 16053.0, 11932.522699091938, 11948.163628546266, 11973.042156627624, 12357.443915023665, 12380.31908245019, 11281.0, 11372.54509819598, 11408.714782130513, 11612.477438515456, 11697.473613687234], "value": 9046.547668868017, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1421.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 108.0, 107.0, 108.0, 111.0, 107.0, 107.0, 108.0, 107.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 129.0, 122.0, 117.0, 116.0, 114.0, 115.0, 119.0, 129.0, 121.0], "value": 120.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 162.0, 164.0, 165.0, 172.0, 169.0, 166.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 75.0, 74.0, 72.0, 74.0, 73.0, 76.0, 74.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 79.0, 78.0, 83.0, 84.0, 79.0, 79.0, 78.0], "value": 79.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 110.0, 113.0, 113.0, 110.0, 114.0, 114.0, 114.0, 115.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 149.0, 149.0, 148.0, 153.0, 148.0, 149.0, 149.0, 151.0, 149.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 98.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 55.0, 55.0, 66.0, 54.0, 54.0, 53.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 39.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 74.0, 78.0, 79.0, 76.0, 77.0, 76.0, 71.0, 70.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 110.0, 111.0, 112.0, 111.0, 122.0, 122.0, 116.0, 110.0], "value": 113.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 169.0, 166.0, 165.0, 170.0, 169.0, 169.0, 165.0, 167.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 64.0, 65.0, 64.0, 65.0, 63.0, 66.0, 63.0], "value": 65.2, "unit": "score"}]}]} 04:16:08 INFO - Return code: 0 04:16:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:16:08 INFO - # TBPL SUCCESS # 04:16:08 INFO - Running post-action listener: _package_coverage_data 04:16:08 INFO - Running post-action listener: _resource_record_post_action 04:16:08 INFO - [mozharness: 2017-09-25 11:16:08.069124Z] Finished run-tests step (success) 04:16:08 INFO - Running post-run listener: _resource_record_post_run 04:16:08 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 344346624; Read time: 16; Write time: 233020 04:16:08 INFO - TinderboxPrint: CPU usage
13.1% 04:16:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:16:08 INFO - TinderboxPrint: I/O write bytes / time
344,346,624 / 233,020 04:16:08 INFO - TinderboxPrint: CPU idle
8,243.2 (86.9%) 04:16:08 INFO - TinderboxPrint: CPU user
1,194.5 (12.6%) 04:16:08 INFO - TinderboxPrint: Swap in / out
0 / 0 04:16:08 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13398016; Read time: 0; Write time: 2300 04:16:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:16:08 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 330948608; Read time: 0; Write time: 230720 04:16:08 INFO - Running post-run listener: _upload_blobber_files 04:16:08 INFO - Blob upload gear active. 04:16:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:16:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:16:08 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'] 04:16:08 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 04:16:09 INFO - (blobuploader) - INFO - Open directory for files ... 04:16:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:16:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:16:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:10 INFO - (blobuploader) - INFO - Done attempting. 04:16:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:16:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:16:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:11 INFO - (blobuploader) - INFO - Done attempting. 04:16:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:16:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:18 INFO - (blobuploader) - INFO - Done attempting. 04:16:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:16:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:16:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:19 INFO - (blobuploader) - INFO - Done attempting. 04:16:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:16:19 INFO - Return code: 0 04:16:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:16:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:16:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6109c9253f47ee5a56cc20e59e53ec59be7444d7dc8068d8da98da96697de25c653bf4c876e3fcc67d095e0b1df152c495688dbdd5c4ba3cc3b9be2cda32b7c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87c0e91f556ec606607dfdefab08cf94e2bc2f3b5be1f031d2c8dbae17140de3e32c250042d0b31b935838fe34a517921fc26ef9d5603c4430897ee5316c89ea", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8365b653b66762a9e973f1289b6b48975bf38f72066d14519982d104c4c0b89e6fec30340beeb2bd044181a94bf7624446d9ba75feaabc4aae848b3323bfa7e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37404986bf2c347241eac42d84c122fdb52132ce3bb7435f40210473d1df728f5be2610fb7e75423b4107c1a1f4e6dd5332b5951ceb74ad4827b406453708060"} 04:16:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:16:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:16:19 INFO - Contents: 04:16:19 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6109c9253f47ee5a56cc20e59e53ec59be7444d7dc8068d8da98da96697de25c653bf4c876e3fcc67d095e0b1df152c495688dbdd5c4ba3cc3b9be2cda32b7c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87c0e91f556ec606607dfdefab08cf94e2bc2f3b5be1f031d2c8dbae17140de3e32c250042d0b31b935838fe34a517921fc26ef9d5603c4430897ee5316c89ea", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8365b653b66762a9e973f1289b6b48975bf38f72066d14519982d104c4c0b89e6fec30340beeb2bd044181a94bf7624446d9ba75feaabc4aae848b3323bfa7e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37404986bf2c347241eac42d84c122fdb52132ce3bb7435f40210473d1df728f5be2610fb7e75423b4107c1a1f4e6dd5332b5951ceb74ad4827b406453708060"} 04:16:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:16:19 INFO - Copying logs to upload dir... 04:16:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:16:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.017364 ========= master_lag: -0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-25 04:16:19.572917) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 04:16:19.576130) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360 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/d6109c9253f47ee5a56cc20e59e53ec59be7444d7dc8068d8da98da96697de25c653bf4c876e3fcc67d095e0b1df152c495688dbdd5c4ba3cc3b9be2cda32b7c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87c0e91f556ec606607dfdefab08cf94e2bc2f3b5be1f031d2c8dbae17140de3e32c250042d0b31b935838fe34a517921fc26ef9d5603c4430897ee5316c89ea", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8365b653b66762a9e973f1289b6b48975bf38f72066d14519982d104c4c0b89e6fec30340beeb2bd044181a94bf7624446d9ba75feaabc4aae848b3323bfa7e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37404986bf2c347241eac42d84c122fdb52132ce3bb7435f40210473d1df728f5be2610fb7e75423b4107c1a1f4e6dd5332b5951ceb74ad4827b406453708060"} build_url:https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/SaUzvixmSkCRJGqkRd3BZQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6109c9253f47ee5a56cc20e59e53ec59be7444d7dc8068d8da98da96697de25c653bf4c876e3fcc67d095e0b1df152c495688dbdd5c4ba3cc3b9be2cda32b7c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87c0e91f556ec606607dfdefab08cf94e2bc2f3b5be1f031d2c8dbae17140de3e32c250042d0b31b935838fe34a517921fc26ef9d5603c4430897ee5316c89ea", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8365b653b66762a9e973f1289b6b48975bf38f72066d14519982d104c4c0b89e6fec30340beeb2bd044181a94bf7624446d9ba75feaabc4aae848b3323bfa7e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37404986bf2c347241eac42d84c122fdb52132ce3bb7435f40210473d1df728f5be2610fb7e75423b4107c1a1f4e6dd5332b5951ceb74ad4827b406453708060"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 04:16:19.612631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:16:19.612996) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506336932.843119-1264538360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:16:19.733634) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 04:16:19.734028) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 04:16:19.734654) ========= ========= Total master_lag: 0.58 =========