builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-076 starttime: 1505731705.92 results: success (0) revision: 4ef69bbd6816d95ade430640785971f587e2d5bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:25.919396) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:25.919861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:25.920142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:25.988418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:25.988785) ========= 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=9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 03:48:25-- 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% 45.7M=0s 2017-09-18 03:48:26 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132102 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:26.152883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:26.153182) ========= 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=9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017940 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:26.229668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:26.229958) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4ef69bbd6816d95ade430640785971f587e2d5bc --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 4ef69bbd6816d95ade430640785971f587e2d5bc --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=9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 03:48:26,229 truncating revision to first 12 chars 2017-09-18 03:48:26,229 Setting DEBUG logging. 2017-09-18 03:48:26,229 attempt 1/10 2017-09-18 03:48:26,229 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4ef69bbd6816?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 03:48:26,694 unpacking tar archive at: mozilla-central-4ef69bbd6816/testing/mozharness/ program finished with exit code 0 elapsedTime=0.753464 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:27.028829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:27.029116) ========= script_repo_revision: 4ef69bbd6816d95ade430640785971f587e2d5bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:27.029454) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:27.029762) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:27.064045) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-18 03:48:27.067458) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:48:27 INFO - MultiFileLogger online at 20170918 03:48:27 in /builds/slave/test 03:48:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:48:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:48:27 INFO - {'append_to_log': False, 03:48:27 INFO - 'base_work_dir': '/builds/slave/test', 03:48:27 INFO - 'blob_upload_branch': 'Firefox', 03:48:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:48:27 INFO - 'branch': 'Firefox', 03:48:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:48:27 INFO - 'code_coverage': False, 03:48:27 INFO - 'config_files': ('talos/linux_config.py',), 03:48:27 INFO - 'default_actions': ('clobber', 03:48:27 INFO - 'read-buildbot-config', 03:48:27 INFO - 'download-and-extract', 03:48:27 INFO - 'populate-webroot', 03:48:27 INFO - 'create-virtualenv', 03:48:27 INFO - 'install', 03:48:27 INFO - 'setup-mitmproxy', 03:48:27 INFO - 'run-tests'), 03:48:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:48:27 INFO - 'disable_ccov_upload': False, 03:48:27 INFO - 'disable_stylo': False, 03:48:27 INFO - 'download_minidump_stackwalk': True, 03:48:27 INFO - 'download_symbols': 'ondemand', 03:48:27 INFO - 'enable_stylo': False, 03:48:27 INFO - 'enable_webrender': False, 03:48:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:48:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:48:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:48:27 INFO - 'gecko_profile': False, 03:48:27 INFO - 'gecko_profile_interval': 0, 03:48:27 INFO - 'installer_path': 'installer.exe', 03:48:27 INFO - 'log_level': 'info', 03:48:27 INFO - 'log_name': 'talos', 03:48:27 INFO - 'log_to_console': True, 03:48:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:48:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:48:27 INFO - 'opt_config_files': (), 03:48:27 INFO - 'pip_index': False, 03:48:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:48:27 INFO - 'system_bits': '32', 03:48:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:48:27 INFO - 'title': 'talos-linux64-ix-076', 03:48:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:48:27 INFO - 'use_talos_json': True, 03:48:27 INFO - 'verify': 'False', 03:48:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:48:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:48:27 INFO - 'work_dir': 'build'} 03:48:27 INFO - [mozharness: 2017-09-18 10:48:27.207677Z] Running clobber step. 03:48:27 INFO - Running pre-action listener: _resource_record_pre_action 03:48:27 INFO - Running main action method: clobber 03:48:27 INFO - rmtree: /builds/slave/test/build 03:48:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:48:28 INFO - Running post-action listener: _resource_record_post_action 03:48:28 INFO - [mozharness: 2017-09-18 10:48:28.202691Z] Finished clobber step (success) 03:48:28 INFO - [mozharness: 2017-09-18 10:48:28.202789Z] Running read-buildbot-config step. 03:48:28 INFO - Running pre-action listener: _resource_record_pre_action 03:48:28 INFO - Running main action method: read_buildbot_config 03:48:28 INFO - Using buildbot properties: 03:48:28 INFO - { 03:48:28 INFO - "project": "", 03:48:28 INFO - "product": "firefox", 03:48:28 INFO - "who": "archaeopteryx@coole-files.de", 03:48:28 INFO - "installer_path": "public/build/target.tar.bz2", 03:48:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:48:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:48:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 03:48:28 INFO - "stage_platform": "linux64-pgo", 03:48:28 INFO - "basedir": "/builds/slave/test", 03:48:28 INFO - "buildnumber": 29, 03:48:28 INFO - "platform": "ubuntu64_hw", 03:48:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:48:28 INFO - "slavebuilddir": "test", 03:48:28 INFO - "taskId": "QehvDzszQVK6Eq-DDR6nXw", 03:48:28 INFO - "branch": "mozilla-central", 03:48:28 INFO - "script_repo_revision": "production", 03:48:28 INFO - "revision": "4ef69bbd6816d95ade430640785971f587e2d5bc", 03:48:28 INFO - "slavename": "talos-linux64-ix-076", 03:48:28 INFO - "repo_path": "mozilla-central" 03:48:28 INFO - } 03:48:28 INFO - Finding installer, test and symbols from parent task. 03:48:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QehvDzszQVK6Eq-DDR6nXw'}, attempt #1 03:48:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QehvDzszQVK6Eq-DDR6nXw'}, attempt #1 03:48:29 INFO - Task dependencies: cW-otTD3QsK5dWc76_Bxuw 03:48:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw'}, attempt #1 03:48:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2 03:48:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.test_packages.json 03:48:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.crashreporter-symbols.zip 03:48:29 INFO - Running post-action listener: _resource_record_post_action 03:48:29 INFO - [mozharness: 2017-09-18 10:48:29.568673Z] Finished read-buildbot-config step (success) 03:48:29 INFO - [mozharness: 2017-09-18 10:48:29.568891Z] Running download-and-extract step. 03:48:29 INFO - Running pre-action listener: _resource_record_pre_action 03:48:29 INFO - Running main action method: download_and_extract 03:48:29 INFO - mkdir: /builds/slave/test/build/tests 03:48:29 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:48:29 INFO - trying https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.test_packages.json 03:48:29 INFO - Downloading https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:48:30 INFO - Downloaded 989 bytes. 03:48:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:48:30 INFO - Using the following test package requirements: 03:48:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:48:30 INFO - u'common': [u'target.common.tests.zip'], 03:48:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:48:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:48:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:48:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:48:30 INFO - u'mozbase': [u'target.common.tests.zip'], 03:48:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:48:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:48:30 INFO - u'web-platform': [u'target.common.tests.zip', 03:48:30 INFO - u'target.web-platform.tests.tar.gz'], 03:48:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:48:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:48:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.common.tests.zip 03:48:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:48:30 INFO - Fetch https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.common.tests.zip into memory 03:48:31 INFO - Content-Length response header: 55325325 03:48:31 INFO - Bytes received: 55325325 03:48:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.talos.tests.zip 03:48:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:48:41 INFO - Fetch https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.talos.tests.zip into memory 03:48:43 INFO - Content-Length response header: 14508748 03:48:43 INFO - Bytes received: 14508748 03:48:43 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:48:43 INFO - trying https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2 03:48:43 INFO - Downloading https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:48:46 INFO - Downloaded 62106086 bytes. 03:48:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2 03:48:46 INFO - mkdir: /builds/slave/test/properties 03:48:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:48:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:48:46 INFO - Contents: 03:48:46 INFO - build_url:https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2 03:48:46 INFO - Running post-action listener: _resource_record_post_action 03:48:46 INFO - Running post-action listener: find_tests_for_verification 03:48:46 INFO - Running post-action listener: set_extra_try_arguments 03:48:46 INFO - [mozharness: 2017-09-18 10:48:46.247340Z] Finished download-and-extract step (success) 03:48:46 INFO - [mozharness: 2017-09-18 10:48:46.247504Z] Running populate-webroot step. 03:48:46 INFO - Running pre-action listener: _resource_record_pre_action 03:48:46 INFO - Running main action method: populate_webroot 03:48:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:48:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['tresize', 03:48:46 INFO - 'tcanvasmark']}, 03:48:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:48:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['dromaeo_css', 03:48:46 INFO - 'kraken']}, 03:48:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'tests': ['damp', 'tps']}, 03:48:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['damp', 'tps']}, 03:48:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:48:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['dromaeo_dom']}, 03:48:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:48:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['basic_compositor_video', 03:48:46 INFO - 'glvideo']}, 03:48:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:48:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['ts_paint_webext', 03:48:46 INFO - 'tp5o_webext']}, 03:48:46 INFO - 'other-e10s': {'tests': ['a11yr', 03:48:46 INFO - 'ts_paint', 03:48:46 INFO - 'tpaint', 03:48:46 INFO - 'sessionrestore', 03:48:46 INFO - 'sessionrestore_many_windows', 03:48:46 INFO - 'sessionrestore_no_auto_restore', 03:48:46 INFO - 'tabpaint']}, 03:48:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['a11yr', 03:48:46 INFO - 'ts_paint', 03:48:46 INFO - 'tpaint', 03:48:46 INFO - 'sessionrestore', 03:48:46 INFO - 'sessionrestore_many_windows', 03:48:46 INFO - 'sessionrestore_no_auto_restore', 03:48:46 INFO - 'tabpaint']}, 03:48:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:48:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:48:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['perf_reftest_singletons']}, 03:48:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['bloom_basic']}, 03:48:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:48:46 INFO - 'tsvgr_opacity', 03:48:46 INFO - 'tart', 03:48:46 INFO - 'tscrollx', 03:48:46 INFO - 'tsvg_static']}, 03:48:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['tsvgx', 03:48:46 INFO - 'tsvgr_opacity', 03:48:46 INFO - 'tart', 03:48:46 INFO - 'tscrollx', 03:48:46 INFO - 'tsvg_static']}, 03:48:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:48:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['tp5o']}, 03:48:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:48:46 INFO - 'talos_options': ['--mitmproxy', 03:48:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:48:46 INFO - '--firstNonBlankPaint'], 03:48:46 INFO - 'tests': ['tp6_google', 03:48:46 INFO - 'tp6_youtube', 03:48:46 INFO - 'tp6_amazon', 03:48:46 INFO - 'tp6_facebook']}, 03:48:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:48:46 INFO - 'talos_options': ['--disable-stylo', 03:48:46 INFO - '--mitmproxy', 03:48:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:48:46 INFO - '--firstNonBlankPaint'], 03:48:46 INFO - 'tests': ['tp6_google', 03:48:46 INFO - 'tp6_youtube', 03:48:46 INFO - 'tp6_amazon', 03:48:46 INFO - 'tp6_facebook']}, 03:48:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:48:46 INFO - 'talos_options': ['--stylo-threads=1', 03:48:46 INFO - '--mitmproxy', 03:48:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:48:46 INFO - '--firstNonBlankPaint'], 03:48:46 INFO - 'tests': ['tp6_google', 03:48:46 INFO - 'tp6_youtube', 03:48:46 INFO - 'tp6_amazon', 03:48:46 INFO - 'tp6_facebook']}, 03:48:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'talos_options': ['--xperf_path', 03:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:46 INFO - 'tests': ['tp5n']}, 03:48:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'talos_options': ['--disable-stylo', 03:48:46 INFO - '--xperf_path', 03:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:46 INFO - 'tests': ['tp5n']}}} 03:48:46 INFO - Running post-action listener: _resource_record_post_action 03:48:46 INFO - [mozharness: 2017-09-18 10:48:46.267325Z] Finished populate-webroot step (success) 03:48:46 INFO - [mozharness: 2017-09-18 10:48:46.267415Z] Running create-virtualenv step. 03:48:46 INFO - Running pre-action listener: _resource_record_pre_action 03:48:46 INFO - Running main action method: create_virtualenv 03:48:46 INFO - Creating virtualenv /builds/slave/test/build/venv 03:48:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:48:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:48:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:48:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:48:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:48:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:48:47 INFO - Installing pip...............done. 03:48:47 INFO - Return code: 0 03:48:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:48:47 INFO - Reading from file tmpfile_stdout 03:48:47 INFO - Output received: 03:48:47 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:48:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:48:47 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:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:47 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:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:47 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 0x1ab51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25090>, '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 0x1e25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', '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:48:47 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:48:47 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:48:47 INFO - Using env: {'DISPLAY': ':0', 03:48:47 INFO - 'HOME': '/home/cltbld', 03:48:47 INFO - 'LANG': 'en_US.UTF-8', 03:48:47 INFO - 'LANGUAGE': 'en_US:en', 03:48:47 INFO - 'LOGNAME': 'cltbld', 03:48:47 INFO - 'MAIL': '/var/mail/cltbld', 03:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:47 INFO - 'MOZ_NO_REMOTE': '1', 03:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:47 INFO - 'NO_EM_RESTART': '1', 03:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:47 INFO - 'PWD': '/builds/slave/test', 03:48:47 INFO - 'SHELL': '/bin/bash', 03:48:47 INFO - 'SHLVL': '1', 03:48:47 INFO - 'TERM': 'linux', 03:48:47 INFO - 'TMOUT': '86400', 03:48:47 INFO - 'USER': 'cltbld', 03:48:47 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', 03:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:47 INFO - '_': '/tools/buildbot/bin/python'} 03:48:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:48:48 INFO - Downloading/unpacking pip>=1.5 03:48:48 INFO - Running setup.py egg_info for package pip 03:48:48 INFO - warning: no files found matching 'pip/cacert.pem' 03:48:48 INFO - warning: no files found matching '*.html' under directory 'docs' 03:48:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:48:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:48:48 INFO - Installing collected packages: pip 03:48:48 INFO - Found existing installation: pip 1.1 03:48:48 INFO - Uninstalling pip: 03:48:48 INFO - Successfully uninstalled pip 03:48:48 INFO - Running setup.py install for pip 03:48:48 INFO - warning: no files found matching 'pip/cacert.pem' 03:48:48 INFO - warning: no files found matching '*.html' under directory 'docs' 03:48:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:48:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:48:48 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Successfully installed pip 03:48:48 INFO - Cleaning up... 03:48:48 INFO - Return code: 0 03:48:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:48 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 0x1ab51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25090>, '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 0x1e25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', '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:48:48 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:48:48 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:48:48 INFO - Using env: {'DISPLAY': ':0', 03:48:48 INFO - 'HOME': '/home/cltbld', 03:48:48 INFO - 'LANG': 'en_US.UTF-8', 03:48:48 INFO - 'LANGUAGE': 'en_US:en', 03:48:48 INFO - 'LOGNAME': 'cltbld', 03:48:48 INFO - 'MAIL': '/var/mail/cltbld', 03:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:48 INFO - 'MOZ_NO_REMOTE': '1', 03:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:48 INFO - 'NO_EM_RESTART': '1', 03:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:48 INFO - 'PWD': '/builds/slave/test', 03:48:48 INFO - 'SHELL': '/bin/bash', 03:48:48 INFO - 'SHLVL': '1', 03:48:48 INFO - 'TERM': 'linux', 03:48:48 INFO - 'TMOUT': '86400', 03:48:48 INFO - 'USER': 'cltbld', 03:48:48 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', 03:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:48 INFO - '_': '/tools/buildbot/bin/python'} 03:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:48 INFO - Downloading/unpacking psutil>=3.1.1 03:48:48 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:48:48 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:48:48 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:48:48 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:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:48:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:49 INFO - Installing collected packages: psutil 03:48:49 INFO - Running setup.py install for psutil 03:48:49 INFO - building 'psutil._psutil_linux' extension 03:48:49 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:48:50 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:48:50 INFO - building 'psutil._psutil_posix' extension 03:48:50 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:48:50 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:48:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:50 INFO - Successfully installed psutil 03:48:50 INFO - Cleaning up... 03:48:50 INFO - Return code: 0 03:48:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25090>, '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 0x1e25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', '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:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:48:50 INFO - Using env: {'DISPLAY': ':0', 03:48:50 INFO - 'HOME': '/home/cltbld', 03:48:50 INFO - 'LANG': 'en_US.UTF-8', 03:48:50 INFO - 'LANGUAGE': 'en_US:en', 03:48:50 INFO - 'LOGNAME': 'cltbld', 03:48:50 INFO - 'MAIL': '/var/mail/cltbld', 03:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:50 INFO - 'MOZ_NO_REMOTE': '1', 03:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:50 INFO - 'NO_EM_RESTART': '1', 03:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:50 INFO - 'PWD': '/builds/slave/test', 03:48:50 INFO - 'SHELL': '/bin/bash', 03:48:50 INFO - 'SHLVL': '1', 03:48:50 INFO - 'TERM': 'linux', 03:48:50 INFO - 'TMOUT': '86400', 03:48:50 INFO - 'USER': 'cltbld', 03:48:50 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', 03:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:50 INFO - '_': '/tools/buildbot/bin/python'} 03:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:48:51 INFO - Installing collected packages: mozsystemmonitor 03:48:51 INFO - Running setup.py install for mozsystemmonitor 03:48:51 INFO - Successfully installed mozsystemmonitor 03:48:51 INFO - Cleaning up... 03:48:52 INFO - Return code: 0 03:48:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ab51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25090>, '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 0x1e25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', '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:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:48:52 INFO - Using env: {'DISPLAY': ':0', 03:48:52 INFO - 'HOME': '/home/cltbld', 03:48:52 INFO - 'LANG': 'en_US.UTF-8', 03:48:52 INFO - 'LANGUAGE': 'en_US:en', 03:48:52 INFO - 'LOGNAME': 'cltbld', 03:48:52 INFO - 'MAIL': '/var/mail/cltbld', 03:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:52 INFO - 'MOZ_NO_REMOTE': '1', 03:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:52 INFO - 'NO_EM_RESTART': '1', 03:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:52 INFO - 'PWD': '/builds/slave/test', 03:48:52 INFO - 'SHELL': '/bin/bash', 03:48:52 INFO - 'SHLVL': '1', 03:48:52 INFO - 'TERM': 'linux', 03:48:52 INFO - 'TMOUT': '86400', 03:48:52 INFO - 'USER': 'cltbld', 03:48:52 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', 03:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:52 INFO - '_': '/tools/buildbot/bin/python'} 03:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:52 INFO - Downloading/unpacking jsonschema==2.5.1 03:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:48:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:48:53 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:48:53 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:48:53 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:48:53 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:48:53 INFO - Downloading functools32-3.2.3-2.tar.gz 03:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:48:54 INFO - warning: no files found matching '*.txt' 03:48:54 INFO - no previously-included directories found matching 'build' 03:48:54 INFO - no previously-included directories found matching 'dist' 03:48:54 INFO - no previously-included directories found matching '.git*' 03:48:54 INFO - Installing collected packages: jsonschema, functools32 03:48:54 INFO - Running setup.py install for functools32 03:48:54 INFO - warning: no files found matching '*.txt' 03:48:54 INFO - no previously-included directories found matching 'build' 03:48:54 INFO - no previously-included directories found matching 'dist' 03:48:54 INFO - no previously-included directories found matching '.git*' 03:48:54 INFO - Successfully installed jsonschema functools32 03:48:54 INFO - Cleaning up... 03:48:55 INFO - Return code: 0 03:48:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:48: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:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48: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:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ab51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25090>, '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 0x1e25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', '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:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:48:55 INFO - Using env: {'DISPLAY': ':0', 03:48:55 INFO - 'HOME': '/home/cltbld', 03:48:55 INFO - 'LANG': 'en_US.UTF-8', 03:48:55 INFO - 'LANGUAGE': 'en_US:en', 03:48:55 INFO - 'LOGNAME': 'cltbld', 03:48:55 INFO - 'MAIL': '/var/mail/cltbld', 03:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:55 INFO - 'MOZ_NO_REMOTE': '1', 03:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:55 INFO - 'NO_EM_RESTART': '1', 03:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:55 INFO - 'PWD': '/builds/slave/test', 03:48:55 INFO - 'SHELL': '/bin/bash', 03:48:55 INFO - 'SHLVL': '1', 03:48:55 INFO - 'TERM': 'linux', 03:48:55 INFO - 'TMOUT': '86400', 03:48:55 INFO - 'USER': 'cltbld', 03:48:55 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', 03:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:55 INFO - '_': '/tools/buildbot/bin/python'} 03:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:48:55 INFO - Cleaning up... 03:48:55 INFO - Return code: 0 03:48:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:48: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:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48: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:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ab51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25090>, '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 0x1e25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', '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:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:48:55 INFO - Using env: {'DISPLAY': ':0', 03:48:55 INFO - 'HOME': '/home/cltbld', 03:48:55 INFO - 'LANG': 'en_US.UTF-8', 03:48:55 INFO - 'LANGUAGE': 'en_US:en', 03:48:55 INFO - 'LOGNAME': 'cltbld', 03:48:55 INFO - 'MAIL': '/var/mail/cltbld', 03:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:55 INFO - 'MOZ_NO_REMOTE': '1', 03:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:55 INFO - 'NO_EM_RESTART': '1', 03:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:55 INFO - 'PWD': '/builds/slave/test', 03:48:55 INFO - 'SHELL': '/bin/bash', 03:48:55 INFO - 'SHLVL': '1', 03:48:55 INFO - 'TERM': 'linux', 03:48:55 INFO - 'TMOUT': '86400', 03:48:55 INFO - 'USER': 'cltbld', 03:48:55 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', 03:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:55 INFO - '_': '/tools/buildbot/bin/python'} 03:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:56 INFO - Downloading blobuploader-1.2.4.tar.gz 03:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:48:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:48:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:57 INFO - Downloading docopt-0.6.1.tar.gz 03:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:48:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:48:57 INFO - Running setup.py install for blobuploader 03:48:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:48:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:48:57 INFO - Running setup.py install for requests 03:48:57 INFO - Running setup.py install for docopt 03:48:57 INFO - Successfully installed blobuploader requests docopt 03:48:57 INFO - Cleaning up... 03:48:57 INFO - Return code: 0 03:48:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48: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:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48: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:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:57 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 0x1ab51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25090>, '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 0x1e25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', '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:48:57 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:48:57 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:48:57 INFO - Using env: {'DISPLAY': ':0', 03:48:57 INFO - 'HOME': '/home/cltbld', 03:48:57 INFO - 'LANG': 'en_US.UTF-8', 03:48:57 INFO - 'LANGUAGE': 'en_US:en', 03:48:57 INFO - 'LOGNAME': 'cltbld', 03:48:57 INFO - 'MAIL': '/var/mail/cltbld', 03:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:57 INFO - 'MOZ_NO_REMOTE': '1', 03:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:57 INFO - 'NO_EM_RESTART': '1', 03:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:57 INFO - 'PWD': '/builds/slave/test', 03:48:57 INFO - 'SHELL': '/bin/bash', 03:48:57 INFO - 'SHLVL': '1', 03:48:57 INFO - 'TERM': 'linux', 03:48:57 INFO - 'TMOUT': '86400', 03:48:57 INFO - 'USER': 'cltbld', 03:48:57 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', 03:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:57 INFO - '_': '/tools/buildbot/bin/python'} 03:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:58 INFO - Running setup.py (path:/tmp/pip-RrgnVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:58 INFO - Running setup.py (path:/tmp/pip-6RvJMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:58 INFO - Running setup.py (path:/tmp/pip-_FRJig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:58 INFO - Running setup.py (path:/tmp/pip-nWOg9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:58 INFO - Running setup.py (path:/tmp/pip-lXiPbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:58 INFO - Running setup.py (path:/tmp/pip-k9HV5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:58 INFO - Running setup.py (path:/tmp/pip-KB__Ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:58 INFO - Running setup.py (path:/tmp/pip-jna2Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:58 INFO - Running setup.py (path:/tmp/pip-5XR2jT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:58 INFO - Running setup.py (path:/tmp/pip-4TiYas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:58 INFO - Running setup.py (path:/tmp/pip-vS3y3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:58 INFO - Running setup.py (path:/tmp/pip-czaVLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:58 INFO - Running setup.py (path:/tmp/pip-WXZW1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:58 INFO - Running setup.py (path:/tmp/pip-ocI8D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:59 INFO - Running setup.py (path:/tmp/pip-Mf4dYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:59 INFO - Running setup.py (path:/tmp/pip-H7RpGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:59 INFO - Running setup.py (path:/tmp/pip-NN4xiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:48:59 INFO - Running setup.py install for manifestparser 03:48:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:48:59 INFO - Running setup.py install for mozcrash 03:48:59 INFO - Running setup.py install for mozdebug 03:48:59 INFO - Running setup.py install for mozdevice 03:48:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:48:59 INFO - Running setup.py install for mozfile 03:48:59 INFO - Running setup.py install for mozhttpd 03:48:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:48:59 INFO - Running setup.py install for mozinfo 03:48:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:48:59 INFO - Running setup.py install for mozInstall 03:49:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Running setup.py install for mozleak 03:49:00 INFO - Running setup.py install for mozlog 03:49:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Running setup.py install for moznetwork 03:49:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Running setup.py install for mozprocess 03:49:00 INFO - Running setup.py install for mozprofile 03:49:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Running setup.py install for mozrunner 03:49:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Running setup.py install for mozscreenshot 03:49:00 INFO - Running setup.py install for moztest 03:49:00 INFO - Running setup.py install for mozversion 03:49:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:49:00 INFO - Cleaning up... 03:49:00 INFO - Return code: 0 03:49:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:00 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 0x1ab51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25090>, '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 0x1e25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', '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:49:00 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:49:00 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:49:00 INFO - Using env: {'DISPLAY': ':0', 03:49:00 INFO - 'HOME': '/home/cltbld', 03:49:00 INFO - 'LANG': 'en_US.UTF-8', 03:49:00 INFO - 'LANGUAGE': 'en_US:en', 03:49:00 INFO - 'LOGNAME': 'cltbld', 03:49:00 INFO - 'MAIL': '/var/mail/cltbld', 03:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:00 INFO - 'MOZ_NO_REMOTE': '1', 03:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:00 INFO - 'NO_EM_RESTART': '1', 03:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:00 INFO - 'PWD': '/builds/slave/test', 03:49:00 INFO - 'SHELL': '/bin/bash', 03:49:00 INFO - 'SHLVL': '1', 03:49:00 INFO - 'TERM': 'linux', 03:49:00 INFO - 'TMOUT': '86400', 03:49:00 INFO - 'USER': 'cltbld', 03:49:00 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', 03:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:01 INFO - '_': '/tools/buildbot/bin/python'} 03:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:49:01 INFO - Running setup.py (path:/tmp/pip-GDA0hP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:49:01 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:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:49:01 INFO - Running setup.py (path:/tmp/pip-C4IJuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:49:01 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:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:49:01 INFO - Running setup.py (path:/tmp/pip-9lxpC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:49:01 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:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:49:01 INFO - Running setup.py (path:/tmp/pip-jyEkNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:49:01 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:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:49:01 INFO - Running setup.py (path:/tmp/pip-51YfG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:49:01 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:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:49:01 INFO - Running setup.py (path:/tmp/pip-cERk_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:49:01 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:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:49:01 INFO - Running setup.py (path:/tmp/pip-MXf8T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:49:01 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:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:49:01 INFO - Running setup.py (path:/tmp/pip-UOozOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:49:01 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:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:49:01 INFO - Running setup.py (path:/tmp/pip-sPfqSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:49:01 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:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:49:01 INFO - Running setup.py (path:/tmp/pip-GsW_Z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:49:01 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:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:49:01 INFO - Running setup.py (path:/tmp/pip-TVjIn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:49:01 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:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:49:01 INFO - Running setup.py (path:/tmp/pip-UEbORO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:49:02 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:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:49:02 INFO - Running setup.py (path:/tmp/pip-HbAkhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:49:02 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:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:49:02 INFO - Running setup.py (path:/tmp/pip-RioLJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:49:02 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:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:02 INFO - Running setup.py (path:/tmp/pip-TcJaJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:02 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:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:49:02 INFO - Running setup.py (path:/tmp/pip-B_ksGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:49:02 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:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:49:02 INFO - Running setup.py (path:/tmp/pip-O4DHoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:49:02 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:49:02 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:49:02 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:49:02 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:49:02 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:49:02 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:49:02 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:49:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:03 INFO - Downloading blessings-1.6.tar.gz 03:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:49:03 INFO - Installing collected packages: blessings 03:49:03 INFO - Running setup.py install for blessings 03:49:03 INFO - Successfully installed blessings 03:49:03 INFO - Cleaning up... 03:49:03 INFO - Return code: 0 03:49:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:49:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:49:03 INFO - Reading from file tmpfile_stdout 03:49:03 INFO - Current package versions: 03:49:03 INFO - argparse == 1.2.1 03:49:03 INFO - blessings == 1.6 03:49:03 INFO - blobuploader == 1.2.4 03:49:03 INFO - docopt == 0.6.1 03:49:03 INFO - functools32 == 3.2.3-2 03:49:03 INFO - jsonschema == 2.5.1 03:49:03 INFO - manifestparser == 1.1 03:49:03 INFO - mozInstall == 1.13 03:49:03 INFO - mozcrash == 1.0 03:49:03 INFO - mozdebug == 0.1 03:49:03 INFO - mozdevice == 0.51 03:49:03 INFO - mozfile == 1.2 03:49:03 INFO - mozhttpd == 0.7 03:49:03 INFO - mozinfo == 0.10 03:49:03 INFO - mozleak == 0.1 03:49:03 INFO - mozlog == 3.5 03:49:03 INFO - moznetwork == 0.27 03:49:03 INFO - mozprocess == 0.25 03:49:03 INFO - mozprofile == 0.28 03:49:03 INFO - mozrunner == 6.13 03:49:03 INFO - mozscreenshot == 0.1 03:49:03 INFO - mozsystemmonitor == 0.3 03:49:03 INFO - moztest == 0.8 03:49:03 INFO - mozversion == 1.4 03:49:03 INFO - psutil == 3.1.1 03:49:03 INFO - requests == 1.2.3 03:49:03 INFO - wsgiref == 0.1.2 03:49:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49: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:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49: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:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:03 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 0x1ab51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25090>, '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 0x1e25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', '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:49:03 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:49:03 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:49:03 INFO - Using env: {'DISPLAY': ':0', 03:49:03 INFO - 'HOME': '/home/cltbld', 03:49:03 INFO - 'LANG': 'en_US.UTF-8', 03:49:03 INFO - 'LANGUAGE': 'en_US:en', 03:49:03 INFO - 'LOGNAME': 'cltbld', 03:49:03 INFO - 'MAIL': '/var/mail/cltbld', 03:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:03 INFO - 'MOZ_NO_REMOTE': '1', 03:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:03 INFO - 'NO_EM_RESTART': '1', 03:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:03 INFO - 'PWD': '/builds/slave/test', 03:49:03 INFO - 'SHELL': '/bin/bash', 03:49:03 INFO - 'SHLVL': '1', 03:49:03 INFO - 'TERM': 'linux', 03:49:03 INFO - 'TMOUT': '86400', 03:49:03 INFO - 'USER': 'cltbld', 03:49:03 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', 03:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:03 INFO - '_': '/tools/buildbot/bin/python'} 03:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:04 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:49:04 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:49:04 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:49:04 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:49:04 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:49:04 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:49:04 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:49:04 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:49:04 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:49:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:49:05 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:49:05 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:49:05 INFO - Installing collected packages: simplejson 03:49:05 INFO - Running setup.py install for simplejson 03:49:05 INFO - building 'simplejson._speedups' extension 03:49:05 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:49:06 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:49:06 INFO - Successfully installed simplejson 03:49:06 INFO - Cleaning up... 03:49:06 INFO - Return code: 0 03:49:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:49: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:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49: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:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25090>, '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 0x1e25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', '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:49: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', 'jsonschema'] in /builds/slave/test/build 03:49: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 jsonschema 03:49:06 INFO - Using env: {'DISPLAY': ':0', 03:49:06 INFO - 'HOME': '/home/cltbld', 03:49:06 INFO - 'LANG': 'en_US.UTF-8', 03:49:06 INFO - 'LANGUAGE': 'en_US:en', 03:49:06 INFO - 'LOGNAME': 'cltbld', 03:49:06 INFO - 'MAIL': '/var/mail/cltbld', 03:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:06 INFO - 'MOZ_NO_REMOTE': '1', 03:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:06 INFO - 'NO_EM_RESTART': '1', 03:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:06 INFO - 'PWD': '/builds/slave/test', 03:49:06 INFO - 'SHELL': '/bin/bash', 03:49:06 INFO - 'SHLVL': '1', 03:49:06 INFO - 'TERM': 'linux', 03:49:06 INFO - 'TMOUT': '86400', 03:49:06 INFO - 'USER': 'cltbld', 03:49:06 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', 03:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:06 INFO - '_': '/tools/buildbot/bin/python'} 03:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:49:06 INFO - Cleaning up... 03:49:06 INFO - Return code: 0 03:49:06 INFO - Running post-action listener: _resource_record_post_action 03:49:06 INFO - Running post-action listener: _start_resource_monitoring 03:49:06 INFO - Starting resource monitoring. 03:49:06 INFO - [mozharness: 2017-09-18 10:49:06.698978Z] Finished create-virtualenv step (success) 03:49:06 INFO - [mozharness: 2017-09-18 10:49:06.699492Z] Running install step. 03:49:06 INFO - Running pre-action listener: _resource_record_pre_action 03:49:06 INFO - Running main action method: install 03:49:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:49:06 INFO - Reading from file tmpfile_stdout 03:49:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:49:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:49:07 INFO - Reading from file tmpfile_stdout 03:49:07 INFO - Output received: 03:49:07 INFO - Usage: mozinstall [options] installer 03:49:07 INFO - Options: 03:49:07 INFO - -h, --help show this help message and exit 03:49:07 INFO - -d DEST, --destination=DEST 03:49:07 INFO - Directory to install application into. [default: 03:49:07 INFO - "/builds/slave/test"] 03:49:07 INFO - --app=APP Application being installed. [default: firefox] 03:49:07 INFO - mkdir: /builds/slave/test/build/application 03:49:07 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:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:49:24 INFO - Reading from file tmpfile_stdout 03:49:24 INFO - Output received: 03:49:24 INFO - /builds/slave/test/build/application/firefox/firefox 03:49:24 INFO - Running post-action listener: _resource_record_post_action 03:49:24 INFO - [mozharness: 2017-09-18 10:49:24.648379Z] Finished install step (success) 03:49:24 INFO - [mozharness: 2017-09-18 10:49:24.648632Z] Running setup-mitmproxy step. 03:49:24 INFO - Running pre-action listener: _resource_record_pre_action 03:49:24 INFO - Running main action method: setup_mitmproxy 03:49:24 INFO - Skipping: mitmproxy is not required 03:49:24 INFO - Running post-action listener: _resource_record_post_action 03:49:24 INFO - [mozharness: 2017-09-18 10:49:24.649765Z] Finished setup-mitmproxy step (success) 03:49:24 INFO - [mozharness: 2017-09-18 10:49:24.650030Z] Running run-tests step. 03:49:24 INFO - Running pre-action listener: _resource_record_pre_action 03:49:24 INFO - Running pre-action listener: _set_gcov_prefix 03:49:24 INFO - Running main action method: run_tests 03:49:24 WARNING - Try message not found. 03:49:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:49:24 INFO - Python 2.7.3 03:49:24 INFO - Return code: 0 03:49:24 INFO - grabbing minidump binary from tooltool 03:49:24 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:49:24 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 0x1e25090>, '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 0x1e25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:49:24 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:49:24 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:49:24 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:49:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:49:24 INFO - Return code: 0 03:49:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:49:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:49:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:49:24 INFO - ENV: RUST_BACKTRACE is now full 03:49:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:49:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:49:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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:49:24 INFO - Using env: {'DISPLAY': ':0', 03:49:24 INFO - 'HOME': '/home/cltbld', 03:49:24 INFO - 'LANG': 'en_US.UTF-8', 03:49:24 INFO - 'LANGUAGE': 'en_US:en', 03:49:24 INFO - 'LOGNAME': 'cltbld', 03:49:24 INFO - 'MAIL': '/var/mail/cltbld', 03:49:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:49:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:24 INFO - 'MOZ_NO_REMOTE': '1', 03:49:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:24 INFO - 'NO_EM_RESTART': '1', 03:49:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:24 INFO - 'PWD': '/builds/slave/test', 03:49:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:49:24 INFO - 'RUST_BACKTRACE': 'full', 03:49:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:49:24 INFO - 'SHELL': '/bin/bash', 03:49:24 INFO - 'SHLVL': '1', 03:49:24 INFO - 'TERM': 'linux', 03:49:24 INFO - 'TMOUT': '86400', 03:49:24 INFO - 'USER': 'cltbld', 03:49:24 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', 03:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:24 INFO - '_': '/tools/buildbot/bin/python'} 03:49:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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:49:25 INFO - mozversion application_buildid: 20170918093138 03:49:25 INFO - mozversion application_changeset: 4ef69bbd6816d95ade430640785971f587e2d5bc 03:49:25 INFO - mozversion application_display_name: Nightly 03:49:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:49:25 INFO - mozversion application_name: Firefox 03:49:25 INFO - mozversion application_remotingname: firefox 03:49:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:49:25 INFO - mozversion application_vendor: Mozilla 03:49:25 INFO - mozversion application_version: 57.0a1 03:49:25 INFO - mozversion platform_buildid: 20170918093138 03:49:25 INFO - mozversion platform_changeset: 4ef69bbd6816d95ade430640785971f587e2d5bc 03:49:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:49:25 INFO - mozversion platform_version: 57.0a1 03:49:25 INFO - using testdate: 1505731765 03:49:25 INFO - actual date: 1505731765 03:49:25 INFO - starting webserver on 'localhost:47280' 03:49:25 INFO - SUITE-START | Running 2 tests 03:49:25 INFO - TEST-START | dromaeo_css 03:49:25 INFO - Initialising browser for dromaeo_css test... 03:49:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47280/getInfo.html -profile /tmp/tmpM_WULq/profile 03:49:25 INFO - TEST-INFO | started process 27648 (/builds/slave/test/build/application/firefox/firefox http://localhost:47280/getInfo.html) 03:49:30 INFO - TEST-INFO | 27648: exit 0 03:49:30 INFO - Browser initialized. 03:49:30 INFO - Running cycle 1/1 for dromaeo_css test... 03:49:30 INFO - Using env: {'DISPLAY': ':0', 03:49:30 INFO - 'HOME': '/home/cltbld', 03:49:30 INFO - 'JSGC_DISABLE_POISONING': '1', 03:49:30 INFO - 'LANG': 'en_US.UTF-8', 03:49:30 INFO - 'LANGUAGE': 'en_US:en', 03:49:30 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:49:30 INFO - 'LOGNAME': 'cltbld', 03:49:30 INFO - 'MAIL': '/var/mail/cltbld', 03:49:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:49:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:49:30 INFO - 'MOZ_CRASHREPORTER': '1', 03:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:30 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:49:30 INFO - 'MOZ_NO_REMOTE': '1', 03:49:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:30 INFO - 'NO_EM_RESTART': '1', 03:49:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:30 INFO - 'PWD': '/builds/slave/test', 03:49:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:49:30 INFO - 'RUST_BACKTRACE': 'full', 03:49:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:49:30 INFO - 'SHELL': '/bin/bash', 03:49:30 INFO - 'SHLVL': '1', 03:49:30 INFO - 'STYLO_FORCE_DISABLED': '1', 03:49:30 INFO - 'TERM': 'linux', 03:49:30 INFO - 'TMOUT': '86400', 03:49:30 INFO - 'USER': 'cltbld', 03:49:30 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', 03:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:30 INFO - '_': '/tools/buildbot/bin/python'} 03:49:30 INFO - TEST-INFO | started process 27886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM_WULq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:31 INFO - PID 27886 | 03:49:31 INFO - PID 27886 | (/builds/slave/test/build/application/firefox/firefox:27936): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:49:31 INFO - PID 27886 | 03:49:42 INFO - PID 27886 | RSS: Main: 147701760 03:49:42 INFO - PID 27886 | 03:52:38 INFO - PID 27886 | Cycle 1(1): loaded http://localhost:47280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47280/tests/dromaeo/cssquery-ext.html) 03:52:40 INFO - PID 27886 | RSS: Main: 149131264 03:52:40 INFO - PID 27886 | 03:55:41 INFO - PID 27886 | Cycle 1(1): loaded http://localhost:47280/tests/dromaeo/cssquery-ext.html (next: http://localhost:47280/tests/dromaeo/cssquery-jquery.html) 03:55:42 INFO - PID 27886 | RSS: Main: 148885504 03:55:42 INFO - PID 27886 | 03:58:43 INFO - PID 27886 | Cycle 1(1): loaded http://localhost:47280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47280/tests/dromaeo/cssquery-mootools.html) 03:58:44 INFO - PID 27886 | RSS: Main: 150716416 03:58:44 INFO - PID 27886 | 04:01:46 INFO - PID 27886 | Cycle 1(1): loaded http://localhost:47280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47280/tests/dromaeo/cssquery-prototype.html) 04:01:46 INFO - PID 27886 | RSS: Main: 149336064 04:01:46 INFO - PID 27886 | 04:04:49 INFO - PID 27886 | Cycle 1(1): loaded http://localhost:47280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47280/tests/dromaeo/cssquery-yui.html) 04:04:50 INFO - PID 27886 | RSS: Main: 151257088 04:04:50 INFO - PID 27886 | 04:07:51 INFO - PID 27886 | Cycle 1(1): loaded http://localhost:47280/tests/dromaeo/cssquery-yui.html (next: http://localhost:47280/tests/dromaeo/cssquery-dojo.html) 04:07:52 INFO - PID 27886 | RSS: Main: 153370624 04:07:52 INFO - PID 27886 | 04:07:52 INFO - PID 27886 | __start_tp_report 04:07:52 INFO - PID 27886 | _x_x_mozilla_page_load 04:07:52 INFO - PID 27886 | _x_x_mozilla_page_load_details 04:07:52 INFO - PID 27886 | |i|pagename|runs| 04:07:52 INFO - PID 27886 | |0;dojo.html;3834.118152824852;3843.846246150154;3845.557760857502;3845.846166153354;3853.460515527825;6203.131561581376;6219;6264.655443950581;6358.80923572293;6358.936410635893;6265.592736472137;6303.212098487689;6313.589616674924;6319.241690997075;6355.046742988554;5646.322441307028;5669.121286200645;5710.628809127415;5713.971430142843;5731.140328950649;5685.488306052454;5774.220480235177;5776.335721392052;5784.421557844224;5808.332041815203;141.04251895106336;5576.888462230732;5591.692456914889;5637.971810140964;5796.333421656522;5625.324961004665;5713.428657134254;5726.627769195031;5755.194272801811;5764.971175144139;5668.716564171775;5691.203231547586;5764.164196191528;5773.3072031356505;5783.0747080467345;6275.560710750249;6320;6331.905021424683;6353.745850166034;6427;6860.0738900248825;6875.896861547081;6940.548864323853;6953.548019378774;6956.965215173942;6773.966130169367;6848.7260509579555;6866.793996180123;6927.653617319164;6996.160460744743;6207.565470417073;6283.5287353448675;6287.1198032275515;6290.716917738713;6292.622442653455;6918.584884906922;6929.896051559231;7002.859942801218;7118.501704880712;7133.3936615388275;6735.696893639798;6773.356531129535;6794.898076528856;6819.318068193141;6829.7268109276065;6824.6928888200155;6848;6901;6916.792496225121;6942.028116063755;6728.831779205559;6761.628110453874;6814.591124532544;6839.62382068991;6847.589144651337;6842.110525631736;6850.965745171242;6878.931210687929;6890.965545172242;6900.482463815234;4929.334539837076;4992.425871024806;4992.525710057611;4997.050560393586;5005.974970125126;4475.082608065339;4490.932636010462;4507.3689683444345;4517.864464066083;4538.954610453853;6122.632642041492;6223.1287619733275;6236.968815155986;6237.844053898598;6301.527385446018;6885.483588730865;6904.516683832084;6907.516473846783;6925.134358205224;6953.965230173918;6222.3466536013975;6248.156498872594;6255.093011513396;6313.810585682437;6328.240611126695;5529.060059789846;5546.528545073633;5607.43925607436;5611.382747897728;5611.9438805612235;6983.580985140908;7055.964720176366;7077.469189810785;7084.539504932163;7089.645517724093;6779.728810847708;6822.079019332525;6832.350926661959;6855.348741869514;6900.2409734928115;7082.5396349237135;7101.751438699621;7172.318629730167;7197.532160409557;7224.349808517259;6761;6766.323367663194;6831;6854;6859.862802743817;6798.456123510008;6871.415929646036;6871.759488417882;6978.511504194657;6983.825404364931;6597.60414375139;6638.20341559016;6672.933270667231;6678.766243181465;6685.53201275906;6646.401823835878;6672.299408562031;6729.596224226366;6738.561993470409;6744;6552.508561857784;6558.245801732862;6632.734690612515;6657.101291325609;6669.633170175687;6591.373819487141;6612.23959244693;6673.065770791996;6700.061991321317;6762.019507171531;6470.967645161744;6484.448821850196;6487.837804054936;6489.707963141765;6495.772647957298 04:07:52 INFO - PID 27886 | |1;ext.html;917.2845180759006;930.4835816122059;948.8624149498323;968.5641461342395;981.0238812381676;42646.786766066165;43214;43220.13559728808;43240.783796081014;43339.78330108353;40867.79566102165;41026.7948660257;41147.17705645885;41273.904457165685;41286.793566032204;7214.675339609704;7279.090113735783;7282.490225684204;7325;7331.413486921034;7258.201597824235;7350.889736653954;7368.0421545199315;7370.0418945537;7374.668139933689;7825.100113486965;8041.356691464669;8057.395695322845;8066.193380661945;8076.676932922676;7938.761837144895;8005.3195478384405;8015;8018.198180181994;8024.358051355906;7742.458027938046;7864.213578642147;7892.881606775903;7930.444868859182;7937.8809317859705;39297.60702392968;39412.60587394118;39518.802405987786;39807.40288895669;39836.20327593461;3701.38927077032;3756.380197267475;3761.887143385703;3775.6979441644603;3777.6788972937334;32196;32449;32609.673903261137;32630.673693263;32809.50785738192;5317.494837990384;5362.249285100089;5368.355797304349;5389.595780316492;5481.205225242357;210054;210863;211699;211704.99999999846;213633.9318303414;50841.23738143931;51044.74477627588;51085.744571277646;51185.744071279405;51401.48598514042;53899.19151212656;54034.729826350616;54146.7292663542;54290.45709542933;54400.727996360554;16452.83547164537;16907.323707051826;16952.152392380332;16968.40610578624;16985.235664394884;13590.864091359157;13704.451821927012;13740.725185496234;13748.587542373745;13750.724985500234;14461.566153015427;14820.555383338517;14876.404943802127;14971;14987.40050397972;5992.430719081767;6044.304904935901;6118.265808102967;6174.783882564178;6180.66006369645;1094.781043791229;1098.2531878322818;1108.5233349659563;1108.733903863067;1124.8706398764248;25005;25185;25191.74808251894;25211.243662690147;25318.74681253201;1207.945642446092;1211.2732360583755;1215.3619349841404;1217.6407959651924;1222.2605323779164;12972.481100756053;13171.736565268833;13293.734125317633;13419.396127174301;13429.39567719455;263465;267345;267566;267571;268151;52880;53152.46847531475;55883;59804;60032.09951850726;1501.9774703379458;1527.0990115831712;1547.9148646824533;1552.95341139766;1554.8678362339328;28979.275518112216;29314.267143321587;29691.85154074216;30159.69840301569;30377.24056898595;39331.21337573175;39465.210695786496;39640.00899977524;39752.60247397489;39912.60087399089;230596;232144;232195;232264;232638;34378;34651.48022779711;34733.30533389268;34777.47833782445;34826.651733483355;43013.56986430221;44202.33696494491;44446;44713.10573788441;45260.773696131306;32949.341013180085;33198.170045748084;33308.167295817795;33625.15937101592;33896;33027.83486082554;33063.33873322472;33081.50377744384;33134.33731325312;33385.666143338254;38762.22475550417;39039.024024399616;39076;39181.41227881641;39390.409143863435;32589.18527036843;32678.34643307073;33038.66961330452;33194.170145746546;33334.16664583405;24782.256532304058;25005.87497062503;25378.873105634353;25382;25504.744952550238 04:07:52 INFO - PID 27886 | |2;jquery.html;577.4110407384468;584.5791030458072;600.4355905448881;604.262799384751;613.6011592464898;23484;24143.879280603593;24189.879050604723;24238.999999999978;24275.27174184773;24692.75307246927;25563.488730225385;25757.484850302983;26073.86963065182;26147.47705045898;6750.696218670147;6762.797116086501;6791.898121528181;6805.421539169151;6810.046593476917;6500.902486462707;6748.561343512656;6776.457883369343;6800.557963732366;6842.418394436479;6748.966255168717;6758.357955994173;6763.289854565273;6773.729050837986;6774.119364482611;6484.578502397353;6751.493637977147;6755.7973260802255;6762.425193858528;6771.559848609874;6292.307846136921;6297.559170858041;6298.68506574674;6306.905396419057;6309.179806625155;29912.10263692093;30412;30426;30430.239244018856;30491;2296.1619009061737;2346.495503466763;2347.8239132065164;2347.94130146746;2349.083857295639;20004.199832006703;21102.26142085035;21193.5761284775;21195.47011324714;21214.5757084859;2528.355269406308;2556.744325567447;2622.659054322945;2629.671291088614;2634.0912385227257;143713.28143359322;145718;149483;149595;154276.2286188562;15179.696406071816;15815.446459373867;15859.286332115082;16191.352345906032;16220.51338459848;25253;25258.621120683205;25297.620535691978;25452.236432907044;25481.745182547937;10580.206484513692;10614;10623.893761062445;10739.570417183382;10854.620088296871;9740.17208537268;9754.46350450718;9840.16358609512;9848.507574621384;9932.65235716761;9568.904310956941;9592.95203523978;9702.90297097034;9811.455989806342;9964.651237206663;2766.502029634685;2835.702251263629;2868.3116052147334;2952.778541609388;3071.508558630608;1040.3393844908537;1049.8425236214475;1060.925735198544;1068.5779117248644;1068.6206396729206;20505.17979280812;20684;20828.27101051456;21039;21219.575608487743;1108.6230681568145;1114.492905727908;1115.5091759625739;1122.2144498850837;1127.3630398824637;11255.437228138724;11670.657874344559;11833.384979857863;11892.821607675893;11899.583514576949;642880;647747;649691;653550;662730;131841.3407932954;136795;136847.31576342255;138989;139976;1213.3690480949856;1218.5125949620046;1243.483954159032;1245.40843099527;1248.2011512631923;19145.13846876866;19382.903085485046;19406;19441.51396215106;19557.413277601696;62809;63391.36608634039;64021;64129.67935160294;64484.67757661369;84179.5791021041;84392.15607843843;84500.57749711213;84530.57734711288;84681;14775.630609234855;15231;15405.691886162438;15419.691606168039;15430.228488575302;23475.76524234736;23645.881770591724;23797.762022379553;23843.403914902265;24330.87834560816;19056.142473588443;19730.605387891876;19744.30894918671;19902.601947961248;20055.398338049883;15798.842011579736;16524.834751652812;16582.17089145514;16660.58348541296;16762.078085705405;19519.8048019518;19884.70172947436;19907.004649767743;19993.600447968503;20090.296839610543;15073;15170.620734481727;15185.696286074437;15187.620309492351;15231.466898658493;18230.635387291914;19346.516337091685;19470.12384442675;19484.805151948298;19497.317593884145 04:07:52 INFO - PID 27886 | |3;mootools.html;1394.783808509681;1497.0568541818652;1501.8047653805004;1508.3363320139138;1515.719591875503;16534.586635334123;17207.139643017847;17215.74176387352;17218.39735609254;17225.913870430646;16787.74818377722;16916.238769255382;16948.0678562679;16965.15174241289;16987.3205071797;2639.2873924040496;2671.839689618624;2699.85150816705;2699.9865000674968;2719.360950176707;2661.7072122066556;2681.4234939488006;2696.9460610787773;2697.4739925714493;2699.2981824725616;2606.1660268714018;2614.189601223617;2622.449285650016;2626.802989775765;2676.69218039925;2650.8144429889817;2690.4619076184645;2690.6502154719956;2691.165738621024;2691.7308269173122;2505.6993160820816;2614.75159859813;2640.8019398545184;2647.5234457797587;2663.280914153187;16800;16836.326546938108;16992.830071699373;17008.744868826976;17025.829741702673;8212.548309842956;8450.408471407003;8461.66153353865;8483.406161568693;8489.957550212272;5400.162974738922;5520.447955204448;5591.692456914868;5597.104463285896;5652.067408877571;2099.800518950697;2128.861623994451;2133.9466513337134;2149.3337065509586;2186.278528085744;29587.852060739773;29635.851820740972;29696;29800.254993625116;29870.402591948256;6929.44564434844;6930;6963.721451141898;7136.143662760398;7155.89266161008;19656.606867862847;19672.90163549173;19673.311434099738;19682.60634787325;19702.704459432833;8037.115917249098;8272.33821294295;8276.08963014068;8285.171482851787;8303.252707256375;7464.813379665552;7480.251974802476;7637.847243055107;7697.191794861571;7705.653245603961;5260.605454590921;5314.176302673091;5360.839174824761;5387.838364849061;5556.666600004012;1512.0851884609872;1527.6715506166006;1546.955804831734;1570.4738912464452;1609.7022050920616;951.5622813505727;963.7927845513249;965.942293188957;971.6162115964155;971.6259240192577;9741.123298903132;9763.414195148314;9818.45998470091;9960.850587241197;9990;1023.8157131716363;1042.9478526073665;1049.1344640671477;1055.3087727538475;1094.8248280275118;5882.705864706833;5905.202797622352;5931.042755890546;5972.074328479006;5989.610675306091;23476.295711128692;24541.877290613433;25031.499370012498;25049.373765656004;25052.49895002126;23799.52400952006;23983.160589379288;24085.51828963411;24360.878195608908;24751.38121546976;12365.938170309091;12515.937420313023;12675.936620317023;12799.936000319938;12877.35613219354;9664.98517655636;9836.262280329147;9907.108360247612;9956.20350371954;9991.450470224207;20701.27545535899;20923.686144707535;21290.148394064065;21631.45921351979;21903.452413689785;22034.669479957494;22063.448413789785;22069.006894689457;22143.77856221417;22184.889075554518;11992.820107698566;12254.387280635754;12335.814962775386;12341.69145771327;12383.133180677267;15370.385184592491;15431.61420964485;15603.843961560238;15617.765733514234;15621.609459763142;11617.941910290394;12120.393980301125;12234.143609947218;12263.26420414778;12294.385280735749;11570.76858462843;11576.305421674726;11954.10344224204;11960.940195298968;12054.0959428045;11167.38579378142;11397.202195846212;11493.712657183638;11503.712407189887;11508.079353651856;7688.077430708127;7695.115061767744;7710.228977102245;7712.305892469704;7782.727604533814;7871.409644276817;7934.880976785237;7963.920360796318;7993.320567751573;8023 04:07:52 INFO - PID 27886 | |4;prototype.html;534.8208350202684;538.6929450213379;548.5282656915055;551.5807985930692;579.5827004556718;6288.968555157224;6354.301026887045;6372.968135159318;6398.744050237985;6427.903581446282;6272.153259309992;6281;6307.211598550181;6313.9684301578545;6364.517838043167;4978.6017118630425;5078.162103252959;5096.4648711885275;5246.973765131179;5252.65857719247;5090.0328937501945;5094.592432605401;5108.8978220435565;5117.078925793356;5139.100657384962;5071.315372424712;5082.263071854579;5084.440711521748;5105.3873535175835;5122.795088196468;5084.898302033957;5101.846944591687;5102.515261050195;5124.692518448905;5129.487051294878;4612.238980568202;4617.8152873885;4643.628509719214;4648.861029047905;4653.488116307203;6118.919567347079;6254.124422580842;6269.185005949197;6295.338989406092;6336.303006669263;5882.441168089024;5914.994450943307;5943.881122377571;5958.344582095966;5961.599024229303;6744.054727984135;6749.595024298509;6752.797416077526;6796.150481189851;6801.897971530381;5074.720890351029;5125.82059627915;5131.89664222194;5144.125498665236;5150.922736158923;7002.194747603989;7047.295270472911;7098;7099.716011359539;7127.679254433563;5263.157894736823;5304.745483169638;5310.097283461821;5314.840554783363;5333.759980800874;5332.893342133136;5341.786328546815;5381.78472861089;5382.111951527954;5385.192221166856;5609.279499442767;5914.733836977261;5918.496927761103;5940.762369505258;5945.34601193877;6601.966990165019;6615.801525954229;6635.303293154246;6693.899591506131;6704.396604305636;1803.1435068342694;1819.89990550521;1841.4383612998165;1842.2262649687164;1845.4740398986226;1181.6041626055196;1287.2469605280828;1297.2800095946652;1309.109805332364;1314.5990472905664;6078.6048906820915;6220.533459990519;6249.96875015622;6258.937410625836;6273.215848018997;6893.75871844483;6910.550814197061;6934.895976560356;6942;6962.477814163958;6218.968905155536;6281;6307.810765677037;6316.9368306317265;6317.905231421532;3620.728445366608;3620.9818950905606;3626.1841085756023;3636.709063274932;3679.6504332088407;7179.92820071803;7213.026241457336;7253.347198752032;7272.672729727175;7282.380997615156;7094.92905070953;7111.359977601937;7150.177729561063;7196.812525933267;7267.800812865924;7046.788596341913;7063.82340441493;7146.428285737128;7156.642167891689;7230.855382892418;6679.833004174934;6699.464042876461;6794.184697836094;6917.89623155643;6926.58440493572;6782.525223234326;6784.744822207907;6885.380315771605;6904.551204171713;6970.825729356807;7047.823804404726;7120.821979450555;7192.532485388433;7234.819129521804;7271.218551454927;5656.858578535405;5726.455986681259;5739.167820666064;5769.9711501442225;5803.071508558611;6914.476216181159;6930.410915072275;6948.6525673715105;7024.613646249505;7030.50786444944;6724.29394913527;6730.93269067303;6756.324367563401;6762.700681768222;6772.05191273232;6614.206295244601;6644.302348253557;6665.700043497957;6725.966370168314;6731.778513090766;6517.4460170886005;6524.412802847766;6545.574537655038;6594.340565943559;6658;6323.36766323364;6403.29563747978;6596.505262105457;6694.196696396463;6741.325867413416;6447.904431060018;6564.6389448578875;6568.507361947969;6588.8023359299295;6628.304028077176 04:07:52 INFO - PID 27886 | |5;yui.html;895.1361935732017;931.8276118918001;933.8225737109949;979.5934687104852;985.280745056109;19866.602667946634;20626.896865515653;20644.793552064475;20658.999999999964;20742.377728668147;18077.81922180778;18788.248470061215;18904.81095189048;19258;19378.515537111543;1025.697419261318;1041.812473754724;1048.4495639789134;1048.7745134796016;1052.0741747262437;1027.234710140946;1070.3203465799195;1071.3786004117633;1071.860658114444;1075.596651255779;1138.3056335635256;1140.8345789860466;1141.1099342512853;1141.4406940599129;1143.3082984794205;1126.8929451702074;1135.2790977729119;1135.9261647992853;1136.33524388233;1137.1869113583787;830.7383174300137;832.6086739232551;832.8667413213857;833.1585099049943;833.7332053742805;18392;18396.908015459838;18440.354587589503;18549.07254637276;18779.34272300463;22341.55316893653;22573.435664108365;23111.422214444607;23126.190583329502;23295.252856035866;18248;18544.629107417775;18702.812971870244;18707.53231169218;18707.71938420925;3805.334066538345;3954.802259887023;3977.6817854571564;4016.6184212499766;4044.635982761536;113703;132849;147495.2625236867;154057;156033;18176.909115454604;18404.907975460035;18856.52858678544;19104.713429298572;19125.61748765017;34090.829545852604;34258.31483370319;34438.31123377518;34457;34500.654993449745;9436.480993545421;9756.853647195298;9836.163926066221;9856.50717464124;9872.1608663263;4602.3786788783755;4652.092841895797;4660;4691.5308469152815;4712.528747125329;5736.6558006519745;5830.970845145747;5836.533077353802;5851.502622277154;5887.175795388649;1086.918481113904;1112.3103675721104;1124.1175677093443;1127.0701671121358;1129.4917287220783;705.2172088981226;708.77319257837;713.5076797010047;718.8706032914125;731.1920328037442;12872;13113.409896554678;13165.802512962313;13807.309634518233;13964.162150271017;694.1427337238506;696.9266432363678;703.3880523944201;707.0419581467141;714.9070620819364;6212.81361559154;6222.408871157233;6226.719797609118;6237.844053898689;6271.498280137578;149146.25426872796;150412.2479387618;150427;151246;155220;122278;123272;124263.378683106;124996;128369;107781;108739.45630271798;111329.44335278434;112877;113700.43149784363;11500.539978401104;11624;11795.646130616095;11914.52341906314;11996.460159292677;57502.13746793718;57855.421445786684;57947;58311.4168858306;59293.407065930514;70065;70518.64740676264;72161;73453.63273183814;74468.62765686137;16496.83503165001;16760.74858877142;16767;16898.32406703718;16907.830921690627;17955.281788728305;18162;18219.45341639753;18308.993005384833;18326.26694932241;18090.547736306697;18155.636887262444;18458;18594.81405185931;18664;17532.474025779247;17633.735493967342;17752.46742597724;17934;17945.37191198354;16367.59081022984;16412.015279083294;16511.504654860375;16579.751303730212;16709.582260443585;13264;13315.66710832237;13453.443845669291;13546;13765.449382024606;12413.875861241271;12691.93654031724;12726.17279876805;12789.61631151067;12818 04:07:52 INFO - PID 27886 | __end_tp_report 04:07:52 INFO - PID 27886 | __start_cc_report 04:07:52 INFO - PID 27886 | _x_x_mozilla_cycle_collect,277 04:07:52 INFO - PID 27886 | __end_cc_report 04:07:52 INFO - PID 27886 | __startTimestamp1505732872203__endTimestamp 04:07:52 INFO - PID 27886 | 04:07:52 INFO - PID 27886 | ------- Summary: start ------- 04:07:52 INFO - PID 27886 | Number of tests: 6 04:07:52 INFO - PID 27886 | 04:07:52 INFO - PID 27886 | [#0] dojo.html Cycles:165 Average:6274.58 Median:6591.37 stddev:896.36 (13.6%) stddev-sans-first:878.43 04:07:52 INFO - PID 27886 | Values: 3834.1 3843.8 3845.6 3845.8 3853.5 6203.1 6219.0 6264.7 6358.8 6358.9 6265.6 6303.2 6313.6 6319.2 6355.0 5646.3 5669.1 5710.6 5714.0 5731.1 5685.5 5774.2 5776.3 5784.4 5808.3 141.0 5576.9 5591.7 5638.0 5796.3 5625.3 5713.4 5726.6 5755.2 5765.0 5668.7 5691.2 5764.2 5773.3 5783.1 6275.6 6320.0 6331.9 6353.7 6427.0 6860.1 6875.9 6940.5 6953.5 6957.0 6774.0 6848.7 6866.8 6927.7 6996.2 6207.6 6283.5 6287.1 6290.7 6292.6 6918.6 6929.9 7002.9 7118.5 7133.4 6735.7 6773.4 6794.9 6819.3 6829.7 6824.7 6848.0 6901.0 6916.8 6942.0 6728.8 6761.6 6814.6 6839.6 6847.6 6842.1 6851.0 6878.9 6891.0 6900.5 4929.3 4992.4 4992.5 4997.1 5006.0 4475.1 4490.9 4507.4 4517.9 4539.0 6122.6 6223.1 6237.0 6237.8 6301.5 6885.5 6904.5 6907.5 6925.1 6954.0 6222.3 6248.2 6255.1 6313.8 6328.2 5529.1 5546.5 5607.4 5611.4 5611.9 6983.6 7056.0 7077.5 7084.5 7089.6 6779.7 6822.1 6832.4 6855.3 6900.2 7082.5 7101.8 7172.3 7197.5 7224.3 6761.0 6766.3 6831.0 6854.0 6859.9 6798.5 6871.4 6871.8 6978.5 6983.8 6597.6 6638.2 6672.9 6678.8 6685.5 6646.4 6672.3 6729.6 6738.6 6744.0 6552.5 6558.2 6632.7 6657.1 6669.6 6591.4 6612.2 6673.1 6700.1 6762.0 6471.0 6484.4 6487.8 6489.7 6495.8 04:07:52 INFO - PID 27886 | 04:07:52 INFO - PID 27886 | [#1] ext.html Cycles:180 Average:41191.04 Median:3728.88 stddev:61764.53 (1656.4%) stddev-sans-first:61863.77 04:07:52 INFO - PID 27886 | Values: 917.3 930.5 948.9 968.6 981.0 42646.8 43214.0 43220.1 43240.8 43339.8 40867.8 41026.8 41147.2 41273.9 41286.8 7214.7 7279.1 7282.5 7325.0 7331.4 7258.2 7350.9 7368.0 7370.0 7374.7 7825.1 8041.4 8057.4 8066.2 8076.7 7938.8 8005.3 8015.0 8018.2 8024.4 7742.5 7864.2 7892.9 7930.4 7937.9 39297.6 39412.6 39518.8 39807.4 39836.2 3701.4 3756.4 3761.9 3775.7 3777.7 32196.0 32449.0 32609.7 32630.7 32809.5 5317.5 5362.2 5368.4 5389.6 5481.2 210054.0 210863.0 211699.0 211705.0 213633.9 50841.2 51044.7 51085.7 51185.7 51401.5 53899.2 54034.7 54146.7 54290.5 54400.7 16452.8 16907.3 16952.2 16968.4 16985.2 13590.9 13704.5 13740.7 13748.6 13750.7 14461.6 14820.6 14876.4 14971.0 14987.4 5992.4 6044.3 6118.3 6174.8 6180.7 1094.8 1098.3 1108.5 1108.7 1124.9 25005.0 25185.0 25191.7 25211.2 25318.7 1207.9 1211.3 1215.4 1217.6 1222.3 12972.5 13171.7 13293.7 13419.4 13429.4 263465.0 267345.0 267566.0 267571.0 268151.0 52880.0 53152.5 55883.0 59804.0 60032.1 1502.0 1527.1 1547.9 1553.0 1554.9 28979.3 29314.3 29691.9 30159.7 30377.2 39331.2 39465.2 39640.0 39752.6 39912.6 230596.0 232144.0 232195.0 232264.0 232638.0 34378.0 34651.5 34733.3 34777.5 34826.7 43013.6 44202.3 44446.0 44713.1 45260.8 32949.3 33198.2 33308.2 33625.2 33896.0 33027.8 33063.3 33081.5 33134.3 33385.7 38762.2 39039.0 39076.0 39181.4 39390.4 32589.2 32678.3 33038.7 33194.2 33334.2 24782.3 25005.9 25378.9 25382.0 25504.7 04:07:52 INFO - PID 27886 | 04:07:52 INFO - PID 27886 | [#2] jquery.html Cycles:180 Average:41221.69 Median:12916.54 stddev:108643.53 (841.1%) stddev-sans-first:108905.45 04:07:52 INFO - PID 27886 | Values: 577.4 584.6 600.4 604.3 613.6 23484.0 24143.9 24189.9 24239.0 24275.3 24692.8 25563.5 25757.5 26073.9 26147.5 6750.7 6762.8 6791.9 6805.4 6810.0 6500.9 6748.6 6776.5 6800.6 6842.4 6749.0 6758.4 6763.3 6773.7 6774.1 6484.6 6751.5 6755.8 6762.4 6771.6 6292.3 6297.6 6298.7 6306.9 6309.2 29912.1 30412.0 30426.0 30430.2 30491.0 2296.2 2346.5 2347.8 2347.9 2349.1 20004.2 21102.3 21193.6 21195.5 21214.6 2528.4 2556.7 2622.7 2629.7 2634.1 143713.3 145718.0 149483.0 149595.0 154276.2 15179.7 15815.4 15859.3 16191.4 16220.5 25253.0 25258.6 25297.6 25452.2 25481.7 10580.2 10614.0 10623.9 10739.6 10854.6 9740.2 9754.5 9840.2 9848.5 9932.7 9568.9 9593.0 9702.9 9811.5 9964.7 2766.5 2835.7 2868.3 2952.8 3071.5 1040.3 1049.8 1060.9 1068.6 1068.6 20505.2 20684.0 20828.3 21039.0 21219.6 1108.6 1114.5 1115.5 1122.2 1127.4 11255.4 11670.7 11833.4 11892.8 11899.6 642880.0 647747.0 649691.0 653550.0 662730.0 131841.3 136795.0 136847.3 138989.0 139976.0 1213.4 1218.5 1243.5 1245.4 1248.2 19145.1 19382.9 19406.0 19441.5 19557.4 62809.0 63391.4 64021.0 64129.7 64484.7 84179.6 84392.2 84500.6 84530.6 84681.0 14775.6 15231.0 15405.7 15419.7 15430.2 23475.8 23645.9 23797.8 23843.4 24330.9 19056.1 19730.6 19744.3 19902.6 20055.4 15798.8 16524.8 16582.2 16660.6 16762.1 19519.8 19884.7 19907.0 19993.6 20090.3 15073.0 15170.6 15185.7 15187.6 15231.5 18230.6 19346.5 19470.1 19484.8 19497.3 04:07:52 INFO - PID 27886 | 04:07:52 INFO - PID 27886 | [#3] mootools.html Cycles:180 Average:10343.36 Median:13829.33 stddev:7643.09 (55.3%) stddev-sans-first:7634.96 04:07:52 INFO - PID 27886 | Values: 1394.8 1497.1 1501.8 1508.3 1515.7 16534.6 17207.1 17215.7 17218.4 17225.9 16787.7 16916.2 16948.1 16965.2 16987.3 2639.3 2671.8 2699.9 2700.0 2719.4 2661.7 2681.4 2696.9 2697.5 2699.3 2606.2 2614.2 2622.4 2626.8 2676.7 2650.8 2690.5 2690.7 2691.2 2691.7 2505.7 2614.8 2640.8 2647.5 2663.3 16800.0 16836.3 16992.8 17008.7 17025.8 8212.5 8450.4 8461.7 8483.4 8490.0 5400.2 5520.4 5591.7 5597.1 5652.1 2099.8 2128.9 2133.9 2149.3 2186.3 29587.9 29635.9 29696.0 29800.3 29870.4 6929.4 6930.0 6963.7 7136.1 7155.9 19656.6 19672.9 19673.3 19682.6 19702.7 8037.1 8272.3 8276.1 8285.2 8303.3 7464.8 7480.3 7637.8 7697.2 7705.7 5260.6 5314.2 5360.8 5387.8 5556.7 1512.1 1527.7 1547.0 1570.5 1609.7 951.6 963.8 965.9 971.6 971.6 9741.1 9763.4 9818.5 9960.9 9990.0 1023.8 1042.9 1049.1 1055.3 1094.8 5882.7 5905.2 5931.0 5972.1 5989.6 23476.3 24541.9 25031.5 25049.4 25052.5 23799.5 23983.2 24085.5 24360.9 24751.4 12365.9 12515.9 12675.9 12799.9 12877.4 9665.0 9836.3 9907.1 9956.2 9991.5 20701.3 20923.7 21290.1 21631.5 21903.5 22034.7 22063.4 22069.0 22143.8 22184.9 11992.8 12254.4 12335.8 12341.7 12383.1 15370.4 15431.6 15603.8 15617.8 15621.6 11617.9 12120.4 12234.1 12263.3 12294.4 11570.8 11576.3 11954.1 11960.9 12054.1 11167.4 11397.2 11493.7 11503.7 11508.1 7688.1 7695.1 7710.2 7712.3 7782.7 7871.4 7934.9 7963.9 7993.3 8023.0 04:07:52 INFO - PID 27886 | 04:07:52 INFO - PID 27886 | [#4] prototype.html Cycles:180 Average:5750.44 Median:6310.89 stddev:1611.02 (25.5%) stddev-sans-first:1567.25 04:07:52 INFO - PID 27886 | Values: 534.8 538.7 548.5 551.6 579.6 6289.0 6354.3 6373.0 6398.7 6427.9 6272.2 6281.0 6307.2 6314.0 6364.5 4978.6 5078.2 5096.5 5247.0 5252.7 5090.0 5094.6 5108.9 5117.1 5139.1 5071.3 5082.3 5084.4 5105.4 5122.8 5084.9 5101.8 5102.5 5124.7 5129.5 4612.2 4617.8 4643.6 4648.9 4653.5 6118.9 6254.1 6269.2 6295.3 6336.3 5882.4 5915.0 5943.9 5958.3 5961.6 6744.1 6749.6 6752.8 6796.2 6801.9 5074.7 5125.8 5131.9 5144.1 5150.9 7002.2 7047.3 7098.0 7099.7 7127.7 5263.2 5304.7 5310.1 5314.8 5333.8 5332.9 5341.8 5381.8 5382.1 5385.2 5609.3 5914.7 5918.5 5940.8 5945.3 6602.0 6615.8 6635.3 6693.9 6704.4 1803.1 1819.9 1841.4 1842.2 1845.5 1181.6 1287.2 1297.3 1309.1 1314.6 6078.6 6220.5 6250.0 6258.9 6273.2 6893.8 6910.6 6934.9 6942.0 6962.5 6219.0 6281.0 6307.8 6316.9 6317.9 3620.7 3621.0 3626.2 3636.7 3679.7 7179.9 7213.0 7253.3 7272.7 7282.4 7094.9 7111.4 7150.2 7196.8 7267.8 7046.8 7063.8 7146.4 7156.6 7230.9 6679.8 6699.5 6794.2 6917.9 6926.6 6782.5 6784.7 6885.4 6904.6 6970.8 7047.8 7120.8 7192.5 7234.8 7271.2 5656.9 5726.5 5739.2 5770.0 5803.1 6914.5 6930.4 6948.7 7024.6 7030.5 6724.3 6730.9 6756.3 6762.7 6772.1 6614.2 6644.3 6665.7 6726.0 6731.8 6517.4 6524.4 6545.6 6594.3 6658.0 6323.4 6403.3 6596.5 6694.2 6741.3 6447.9 6564.6 6568.5 6588.8 6628.3 04:07:52 INFO - PID 27886 | 04:07:52 INFO - PID 27886 | [#5] yui.html Cycles:180 Average:27457.74 Median:18394.45 stddev:40319.38 (219.2%) stddev-sans-first:40383.16 04:07:52 INFO - PID 27886 | Values: 895.1 931.8 933.8 979.6 985.3 19866.6 20626.9 20644.8 20659.0 20742.4 18077.8 18788.2 18904.8 19258.0 19378.5 1025.7 1041.8 1048.4 1048.8 1052.1 1027.2 1070.3 1071.4 1071.9 1075.6 1138.3 1140.8 1141.1 1141.4 1143.3 1126.9 1135.3 1135.9 1136.3 1137.2 830.7 832.6 832.9 833.2 833.7 18392.0 18396.9 18440.4 18549.1 18779.3 22341.6 22573.4 23111.4 23126.2 23295.3 18248.0 18544.6 18702.8 18707.5 18707.7 3805.3 3954.8 3977.7 4016.6 4044.6 113703.0 132849.0 147495.3 154057.0 156033.0 18176.9 18404.9 18856.5 19104.7 19125.6 34090.8 34258.3 34438.3 34457.0 34500.7 9436.5 9756.9 9836.2 9856.5 9872.2 4602.4 4652.1 4660.0 4691.5 4712.5 5736.7 5831.0 5836.5 5851.5 5887.2 1086.9 1112.3 1124.1 1127.1 1129.5 705.2 708.8 713.5 718.9 731.2 12872.0 13113.4 13165.8 13807.3 13964.2 694.1 696.9 703.4 707.0 714.9 6212.8 6222.4 6226.7 6237.8 6271.5 149146.3 150412.2 150427.0 151246.0 155220.0 122278.0 123272.0 124263.4 124996.0 128369.0 107781.0 108739.5 111329.4 112877.0 113700.4 11500.5 11624.0 11795.6 11914.5 11996.5 57502.1 57855.4 57947.0 58311.4 59293.4 70065.0 70518.6 72161.0 73453.6 74468.6 16496.8 16760.7 16767.0 16898.3 16907.8 17955.3 18162.0 18219.5 18309.0 18326.3 18090.5 18155.6 18458.0 18594.8 18664.0 17532.5 17633.7 17752.5 17934.0 17945.4 16367.6 16412.0 16511.5 16579.8 16709.6 13264.0 13315.7 13453.4 13546.0 13765.4 12413.9 12691.9 12726.2 12789.6 12818.0 04:07:52 INFO - PID 27886 | -------- Summary: end -------- 04:07:52 INFO - PID 27886 | 04:07:52 INFO - TEST-INFO | 27886: exit 0 04:07:52 INFO - TEST-OK | dromaeo_css | took 1107857ms 04:07:52 INFO - TEST-START | kraken 04:07:52 INFO - Initialising browser for kraken test... 04:07:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47280/getInfo.html -profile /tmp/tmpMRj4g5/profile 04:07:52 INFO - TEST-INFO | started process 28255 (/builds/slave/test/build/application/firefox/firefox http://localhost:47280/getInfo.html) 04:07:57 INFO - TEST-INFO | 28255: exit 0 04:07:58 INFO - Browser initialized. 04:07:58 INFO - Running cycle 1/1 for kraken test... 04:07:58 INFO - Using env: {'DISPLAY': ':0', 04:07:58 INFO - 'HOME': '/home/cltbld', 04:07:58 INFO - 'JSGC_DISABLE_POISONING': '1', 04:07:58 INFO - 'LANG': 'en_US.UTF-8', 04:07:58 INFO - 'LANGUAGE': 'en_US:en', 04:07:58 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:07:58 INFO - 'LOGNAME': 'cltbld', 04:07:58 INFO - 'MAIL': '/var/mail/cltbld', 04:07:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:07:58 INFO - 'MOZ_CRASHREPORTER': '1', 04:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:58 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:07:58 INFO - 'MOZ_NO_REMOTE': '1', 04:07:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:58 INFO - 'NO_EM_RESTART': '1', 04:07:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:58 INFO - 'PWD': '/builds/slave/test', 04:07:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:58 INFO - 'RUST_BACKTRACE': 'full', 04:07:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:07:58 INFO - 'SHELL': '/bin/bash', 04:07:58 INFO - 'SHLVL': '1', 04:07:58 INFO - 'STYLO_FORCE_DISABLED': '1', 04:07:58 INFO - 'TERM': 'linux', 04:07:58 INFO - 'TMOUT': '86400', 04:07:58 INFO - 'USER': 'cltbld', 04:07:58 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841', 04:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:58 INFO - '_': '/tools/buildbot/bin/python'} 04:07:58 INFO - TEST-INFO | started process 28490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMRj4g5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:58 INFO - PID 28490 | 04:07:58 INFO - PID 28490 | (/builds/slave/test/build/application/firefox/firefox:28540): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:07:58 INFO - PID 28490 | 04:08:09 INFO - PID 28490 | RSS: Main: 147587072 04:08:09 INFO - PID 28490 | 04:08:11 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47280/tests/kraken/driver.html?testName=audio-beat-detection) 04:08:12 INFO - PID 28490 | RSS: Main: 153735168 04:08:12 INFO - PID 28490 | 04:08:15 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47280/tests/kraken/driver.html?testName=audio-dft) 04:08:15 INFO - PID 28490 | RSS: Main: 154148864 04:08:15 INFO - PID 28490 | 04:08:18 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47280/tests/kraken/driver.html?testName=audio-fft) 04:08:19 INFO - PID 28490 | RSS: Main: 149413888 04:08:19 INFO - PID 28490 | 04:08:21 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47280/tests/kraken/driver.html?testName=audio-oscillator) 04:08:21 INFO - PID 28490 | RSS: Main: 150421504 04:08:21 INFO - PID 28490 | 04:08:24 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:08:24 INFO - PID 28490 | RSS: Main: 150016000 04:08:24 INFO - PID 28490 | 04:08:27 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47280/tests/kraken/driver.html?testName=imaging-darkroom) 04:08:28 INFO - PID 28490 | RSS: Main: 150073344 04:08:28 INFO - PID 28490 | 04:08:31 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47280/tests/kraken/driver.html?testName=imaging-desaturate) 04:08:32 INFO - PID 28490 | RSS: Main: 151736320 04:08:32 INFO - PID 28490 | 04:08:35 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47280/tests/kraken/driver.html?testName=json-parse-financial) 04:08:35 INFO - PID 28490 | RSS: Main: 152862720 04:08:35 INFO - PID 28490 | 04:08:37 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:08:38 INFO - PID 28490 | RSS: Main: 152715264 04:08:38 INFO - PID 28490 | 04:08:39 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:08:40 INFO - PID 28490 | RSS: Main: 152875008 04:08:40 INFO - PID 28490 | 04:08:42 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:08:42 INFO - PID 28490 | RSS: Main: 149962752 04:08:42 INFO - PID 28490 | 04:08:45 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:08:45 INFO - PID 28490 | RSS: Main: 149929984 04:08:45 INFO - PID 28490 | 04:08:48 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:49 INFO - PID 28490 | RSS: Main: 150323200 04:08:49 INFO - PID 28490 | 04:08:50 INFO - PID 28490 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47280/tests/kraken/driver.html?testName=ai-astar) 04:08:51 INFO - PID 28490 | RSS: Main: 151998464 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | __start_tp_report 04:08:51 INFO - PID 28490 | _x_x_mozilla_page_load 04:08:51 INFO - PID 28490 | _x_x_mozilla_page_load_details 04:08:51 INFO - PID 28490 | |i|pagename|runs| 04:08:51 INFO - PID 28490 | |0;ai-astar;105;104;105;106;106;95;104;105;105;105 04:08:51 INFO - PID 28490 | |1;audio-beat-detection;111;112;113;113;113;112;138;113;122;110 04:08:51 INFO - PID 28490 | |2;audio-dft;160;161;161;161;163;160;162;161;164;170 04:08:51 INFO - PID 28490 | |3;audio-fft;73;73;74;75;76;75;76;74;74;74 04:08:51 INFO - PID 28490 | |4;audio-oscillator;78;79;78;79;79;79;79;79;78;79 04:08:51 INFO - PID 28490 | |5;imaging-gaussian-blur;113;113;113;113;116;113;114;114;113;113 04:08:51 INFO - PID 28490 | |6;imaging-darkroom;151;150;151;148;149;149;149;149;151;149 04:08:51 INFO - PID 28490 | |7;imaging-desaturate;93;94;94;93;93;94;94;94;100;94 04:08:51 INFO - PID 28490 | |8;json-parse-financial;46;44;45;45;45;45;46;46;43;44 04:08:51 INFO - PID 28490 | |9;json-stringify-tinderbox;38;40;39;38;39;39;38;39;39;38 04:08:51 INFO - PID 28490 | |10;stanford-crypto-aes;71;70;70;71;70;70;72;74;73;71 04:08:51 INFO - PID 28490 | |11;stanford-crypto-ccm;102;110;104;107;109;105;110;111;103;107 04:08:51 INFO - PID 28490 | |12;stanford-crypto-pbkdf2;152;159;152;155;151;162;151;150;152;147 04:08:51 INFO - PID 28490 | |13;stanford-crypto-sha256-iterative;57;57;59;57;65;61;61;61;59;60 04:08:51 INFO - PID 28490 | __end_tp_report 04:08:51 INFO - PID 28490 | __start_cc_report 04:08:51 INFO - PID 28490 | _x_x_mozilla_cycle_collect,735 04:08:51 INFO - PID 28490 | __end_cc_report 04:08:51 INFO - PID 28490 | __startTimestamp1505732931188__endTimestamp 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | ------- Summary: start ------- 04:08:51 INFO - PID 28490 | Number of tests: 14 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#0] ai-astar Cycles:10 Average:104.00 Median:105.00 stddev:3.23 (3.1%) stddev-sans-first:3.41 04:08:51 INFO - PID 28490 | Values: 105.0 104.0 105.0 106.0 106.0 95.0 104.0 105.0 105.0 105.0 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#1] audio-beat-detection Cycles:10 Average:115.70 Median:113.00 stddev:8.49 (7.5%) stddev-sans-first:8.83 04:08:51 INFO - PID 28490 | Values: 111.0 112.0 113.0 113.0 113.0 112.0 138.0 113.0 122.0 110.0 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#2] audio-dft Cycles:10 Average:162.30 Median:161.50 stddev:2.98 (1.8%) stddev-sans-first:3.05 04:08:51 INFO - PID 28490 | Values: 160.0 161.0 161.0 161.0 163.0 160.0 162.0 161.0 164.0 170.0 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#3] audio-fft Cycles:10 Average:74.40 Median:74.50 stddev:1.07 (1.4%) stddev-sans-first:1.01 04:08:51 INFO - PID 28490 | Values: 73.0 73.0 74.0 75.0 76.0 75.0 76.0 74.0 74.0 74.0 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:79.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 04:08:51 INFO - PID 28490 | Values: 78.0 79.0 78.0 79.0 79.0 79.0 79.0 79.0 78.0 79.0 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:113.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 04:08:51 INFO - PID 28490 | Values: 113.0 113.0 113.0 113.0 116.0 113.0 114.0 114.0 113.0 113.0 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:149.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 04:08:51 INFO - PID 28490 | Values: 151.0 150.0 151.0 148.0 149.0 149.0 149.0 149.0 151.0 149.0 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:2.06 (2.2%) stddev-sans-first:2.13 04:08:51 INFO - PID 28490 | Values: 93.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 100.0 94.0 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#8] json-parse-financial Cycles:10 Average:44.90 Median:45.00 stddev:0.99 (2.2%) stddev-sans-first:0.97 04:08:51 INFO - PID 28490 | Values: 46.0 44.0 45.0 45.0 45.0 45.0 46.0 46.0 43.0 44.0 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#9] json-stringify-tinderbox Cycles:10 Average:38.70 Median:39.00 stddev:0.67 (1.7%) stddev-sans-first:0.67 04:08:51 INFO - PID 28490 | Values: 38.0 40.0 39.0 38.0 39.0 39.0 38.0 39.0 39.0 38.0 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#10] stanford-crypto-aes Cycles:10 Average:71.20 Median:71.00 stddev:1.40 (2.0%) stddev-sans-first:1.48 04:08:51 INFO - PID 28490 | Values: 71.0 70.0 70.0 71.0 70.0 70.0 72.0 74.0 73.0 71.0 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#11] stanford-crypto-ccm Cycles:10 Average:106.80 Median:108.00 stddev:3.19 (3.0%) stddev-sans-first:2.87 04:08:51 INFO - PID 28490 | Values: 102.0 110.0 104.0 107.0 109.0 105.0 110.0 111.0 103.0 107.0 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:152.00 stddev:4.43 (2.9%) stddev-sans-first:4.68 04:08:51 INFO - PID 28490 | Values: 152.0 159.0 152.0 155.0 151.0 162.0 151.0 150.0 152.0 147.0 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.70 Median:60.50 stddev:2.50 (4.1%) stddev-sans-first:2.45 04:08:51 INFO - PID 28490 | Values: 57.0 57.0 59.0 57.0 65.0 61.0 61.0 61.0 59.0 60.0 04:08:51 INFO - PID 28490 | -------- Summary: end -------- 04:08:51 INFO - PID 28490 | 04:08:51 INFO - PID 28490 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:08:51 INFO - TEST-INFO | 28490: exit 0 04:08:51 INFO - TEST-OK | kraken | took 59087ms 04:08:51 INFO - SUITE-END | took 1166s 04:08:52 INFO - Completed test suite (00:19:27) 04:08:52 INFO - javascript benchmark 04:08:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9024.771156910774, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3834.118152824852, 3843.846246150154, 3845.557760857502, 3845.846166153354, 3853.460515527825, 6203.131561581376, 6219.0, 6264.655443950581, 6358.80923572293, 6358.936410635893, 6265.592736472137, 6303.212098487689, 6313.589616674924, 6319.241690997075, 6355.046742988554, 5646.322441307028, 5669.121286200645, 5710.628809127415, 5713.971430142843, 5731.140328950649, 5685.488306052454, 5774.220480235177, 5776.335721392052, 5784.421557844224, 5808.332041815203, 141.04251895106336, 5576.888462230732, 5591.692456914889, 5637.971810140964, 5796.333421656522, 5625.324961004665, 5713.428657134254, 5726.627769195031, 5755.194272801811, 5764.971175144139, 5668.716564171775, 5691.203231547586, 5764.164196191528, 5773.3072031356505, 5783.0747080467345, 6275.560710750249, 6320.0, 6331.905021424683, 6353.745850166034, 6427.0, 6860.0738900248825, 6875.896861547081, 6940.548864323853, 6953.548019378774, 6956.965215173942, 6773.966130169367, 6848.7260509579555, 6866.793996180123, 6927.653617319164, 6996.160460744743, 6207.565470417073, 6283.5287353448675, 6287.1198032275515, 6290.716917738713, 6292.622442653455, 6918.584884906922, 6929.896051559231, 7002.859942801218, 7118.501704880712, 7133.3936615388275, 6735.696893639798, 6773.356531129535, 6794.898076528856, 6819.318068193141, 6829.7268109276065, 6824.6928888200155, 6848.0, 6901.0, 6916.792496225121, 6942.028116063755, 6728.831779205559, 6761.628110453874, 6814.591124532544, 6839.62382068991, 6847.589144651337, 6842.110525631736, 6850.965745171242, 6878.931210687929, 6890.965545172242, 6900.482463815234, 4929.334539837076, 4992.425871024806, 4992.525710057611, 4997.050560393586, 5005.974970125126, 4475.082608065339, 4490.932636010462, 4507.3689683444345, 4517.864464066083, 4538.954610453853, 6122.632642041492, 6223.1287619733275, 6236.968815155986, 6237.844053898598, 6301.527385446018, 6885.483588730865, 6904.516683832084, 6907.516473846783, 6925.134358205224, 6953.965230173918, 6222.3466536013975, 6248.156498872594, 6255.093011513396, 6313.810585682437, 6328.240611126695, 5529.060059789846, 5546.528545073633, 5607.43925607436, 5611.382747897728, 5611.9438805612235, 6983.580985140908, 7055.964720176366, 7077.469189810785, 7084.539504932163, 7089.645517724093, 6779.728810847708, 6822.079019332525, 6832.350926661959, 6855.348741869514, 6900.2409734928115, 7082.5396349237135, 7101.751438699621, 7172.318629730167, 7197.532160409557, 7224.349808517259, 6761.0, 6766.323367663194, 6831.0, 6854.0, 6859.862802743817, 6798.456123510008, 6871.415929646036, 6871.759488417882, 6978.511504194657, 6983.825404364931, 6597.60414375139, 6638.20341559016, 6672.933270667231, 6678.766243181465, 6685.53201275906, 6646.401823835878, 6672.299408562031, 6729.596224226366, 6738.561993470409, 6744.0, 6552.508561857784, 6558.245801732862, 6632.734690612515, 6657.101291325609, 6669.633170175687, 6591.373819487141, 6612.23959244693, 6673.065770791996, 6700.061991321317, 6762.019507171531, 6470.967645161744, 6484.448821850196, 6487.837804054936, 6489.707963141765, 6495.772647957298], "value": 6214.427517309701, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [917.2845180759006, 930.4835816122059, 948.8624149498323, 968.5641461342395, 981.0238812381676, 42646.786766066165, 43214.0, 43220.13559728808, 43240.783796081014, 43339.78330108353, 40867.79566102165, 41026.7948660257, 41147.17705645885, 41273.904457165685, 41286.793566032204, 7214.675339609704, 7279.090113735783, 7282.490225684204, 7325.0, 7331.413486921034, 7258.201597824235, 7350.889736653954, 7368.0421545199315, 7370.0418945537, 7374.668139933689, 7825.100113486965, 8041.356691464669, 8057.395695322845, 8066.193380661945, 8076.676932922676, 7938.761837144895, 8005.3195478384405, 8015.0, 8018.198180181994, 8024.358051355906, 7742.458027938046, 7864.213578642147, 7892.881606775903, 7930.444868859182, 7937.8809317859705, 39297.60702392968, 39412.60587394118, 39518.802405987786, 39807.40288895669, 39836.20327593461, 3701.38927077032, 3756.380197267475, 3761.887143385703, 3775.6979441644603, 3777.6788972937334, 32196.0, 32449.0, 32609.673903261137, 32630.673693263, 32809.50785738192, 5317.494837990384, 5362.249285100089, 5368.355797304349, 5389.595780316492, 5481.205225242357, 210054.0, 210863.0, 211699.0, 211704.99999999846, 213633.9318303414, 50841.23738143931, 51044.74477627588, 51085.744571277646, 51185.744071279405, 51401.48598514042, 53899.19151212656, 54034.729826350616, 54146.7292663542, 54290.45709542933, 54400.727996360554, 16452.83547164537, 16907.323707051826, 16952.152392380332, 16968.40610578624, 16985.235664394884, 13590.864091359157, 13704.451821927012, 13740.725185496234, 13748.587542373745, 13750.724985500234, 14461.566153015427, 14820.555383338517, 14876.404943802127, 14971.0, 14987.40050397972, 5992.430719081767, 6044.304904935901, 6118.265808102967, 6174.783882564178, 6180.66006369645, 1094.781043791229, 1098.2531878322818, 1108.5233349659563, 1108.733903863067, 1124.8706398764248, 25005.0, 25185.0, 25191.74808251894, 25211.243662690147, 25318.74681253201, 1207.945642446092, 1211.2732360583755, 1215.3619349841404, 1217.6407959651924, 1222.2605323779164, 12972.481100756053, 13171.736565268833, 13293.734125317633, 13419.396127174301, 13429.39567719455, 263465.0, 267345.0, 267566.0, 267571.0, 268151.0, 52880.0, 53152.46847531475, 55883.0, 59804.0, 60032.09951850726, 1501.9774703379458, 1527.0990115831712, 1547.9148646824533, 1552.95341139766, 1554.8678362339328, 28979.275518112216, 29314.267143321587, 29691.85154074216, 30159.69840301569, 30377.24056898595, 39331.21337573175, 39465.210695786496, 39640.00899977524, 39752.60247397489, 39912.60087399089, 230596.0, 232144.0, 232195.0, 232264.0, 232638.0, 34378.0, 34651.48022779711, 34733.30533389268, 34777.47833782445, 34826.651733483355, 43013.56986430221, 44202.33696494491, 44446.0, 44713.10573788441, 45260.773696131306, 32949.341013180085, 33198.170045748084, 33308.167295817795, 33625.15937101592, 33896.0, 33027.83486082554, 33063.33873322472, 33081.50377744384, 33134.33731325312, 33385.666143338254, 38762.22475550417, 39039.024024399616, 39076.0, 39181.41227881641, 39390.409143863435, 32589.18527036843, 32678.34643307073, 33038.66961330452, 33194.170145746546, 33334.16664583405, 24782.256532304058, 25005.87497062503, 25378.873105634353, 25382.0, 25504.744952550238], "value": 18193.633628559946, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.4110407384468, 584.5791030458072, 600.4355905448881, 604.262799384751, 613.6011592464898, 23484.0, 24143.879280603593, 24189.879050604723, 24238.999999999978, 24275.27174184773, 24692.75307246927, 25563.488730225385, 25757.484850302983, 26073.86963065182, 26147.47705045898, 6750.696218670147, 6762.797116086501, 6791.898121528181, 6805.421539169151, 6810.046593476917, 6500.902486462707, 6748.561343512656, 6776.457883369343, 6800.557963732366, 6842.418394436479, 6748.966255168717, 6758.357955994173, 6763.289854565273, 6773.729050837986, 6774.119364482611, 6484.578502397353, 6751.493637977147, 6755.7973260802255, 6762.425193858528, 6771.559848609874, 6292.307846136921, 6297.559170858041, 6298.68506574674, 6306.905396419057, 6309.179806625155, 29912.10263692093, 30412.0, 30426.0, 30430.239244018856, 30491.0, 2296.1619009061737, 2346.495503466763, 2347.8239132065164, 2347.94130146746, 2349.083857295639, 20004.199832006703, 21102.26142085035, 21193.5761284775, 21195.47011324714, 21214.5757084859, 2528.355269406308, 2556.744325567447, 2622.659054322945, 2629.671291088614, 2634.0912385227257, 143713.28143359322, 145718.0, 149483.0, 149595.0, 154276.2286188562, 15179.696406071816, 15815.446459373867, 15859.286332115082, 16191.352345906032, 16220.51338459848, 25253.0, 25258.621120683205, 25297.620535691978, 25452.236432907044, 25481.745182547937, 10580.206484513692, 10614.0, 10623.893761062445, 10739.570417183382, 10854.620088296871, 9740.17208537268, 9754.46350450718, 9840.16358609512, 9848.507574621384, 9932.65235716761, 9568.904310956941, 9592.95203523978, 9702.90297097034, 9811.455989806342, 9964.651237206663, 2766.502029634685, 2835.702251263629, 2868.3116052147334, 2952.778541609388, 3071.508558630608, 1040.3393844908537, 1049.8425236214475, 1060.925735198544, 1068.5779117248644, 1068.6206396729206, 20505.17979280812, 20684.0, 20828.27101051456, 21039.0, 21219.575608487743, 1108.6230681568145, 1114.492905727908, 1115.5091759625739, 1122.2144498850837, 1127.3630398824637, 11255.437228138724, 11670.657874344559, 11833.384979857863, 11892.821607675893, 11899.583514576949, 642880.0, 647747.0, 649691.0, 653550.0, 662730.0, 131841.3407932954, 136795.0, 136847.31576342255, 138989.0, 139976.0, 1213.3690480949856, 1218.5125949620046, 1243.483954159032, 1245.40843099527, 1248.2011512631923, 19145.13846876866, 19382.903085485046, 19406.0, 19441.51396215106, 19557.413277601696, 62809.0, 63391.36608634039, 64021.0, 64129.67935160294, 64484.67757661369, 84179.5791021041, 84392.15607843843, 84500.57749711213, 84530.57734711288, 84681.0, 14775.630609234855, 15231.0, 15405.691886162438, 15419.691606168039, 15430.228488575302, 23475.76524234736, 23645.881770591724, 23797.762022379553, 23843.403914902265, 24330.87834560816, 19056.142473588443, 19730.605387891876, 19744.30894918671, 19902.601947961248, 20055.398338049883, 15798.842011579736, 16524.834751652812, 16582.17089145514, 16660.58348541296, 16762.078085705405, 19519.8048019518, 19884.70172947436, 19907.004649767743, 19993.600447968503, 20090.296839610543, 15073.0, 15170.620734481727, 15185.696286074437, 15187.620309492351, 15231.466898658493, 18230.635387291914, 19346.516337091685, 19470.12384442675, 19484.805151948298, 19497.317593884145], "value": 12809.383980346805, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.783808509681, 1497.0568541818652, 1501.8047653805004, 1508.3363320139138, 1515.719591875503, 16534.586635334123, 17207.139643017847, 17215.74176387352, 17218.39735609254, 17225.913870430646, 16787.74818377722, 16916.238769255382, 16948.0678562679, 16965.15174241289, 16987.3205071797, 2639.2873924040496, 2671.839689618624, 2699.85150816705, 2699.9865000674968, 2719.360950176707, 2661.7072122066556, 2681.4234939488006, 2696.9460610787773, 2697.4739925714493, 2699.2981824725616, 2606.1660268714018, 2614.189601223617, 2622.449285650016, 2626.802989775765, 2676.69218039925, 2650.8144429889817, 2690.4619076184645, 2690.6502154719956, 2691.165738621024, 2691.7308269173122, 2505.6993160820816, 2614.75159859813, 2640.8019398545184, 2647.5234457797587, 2663.280914153187, 16800.0, 16836.326546938108, 16992.830071699373, 17008.744868826976, 17025.829741702673, 8212.548309842956, 8450.408471407003, 8461.66153353865, 8483.406161568693, 8489.957550212272, 5400.162974738922, 5520.447955204448, 5591.692456914868, 5597.104463285896, 5652.067408877571, 2099.800518950697, 2128.861623994451, 2133.9466513337134, 2149.3337065509586, 2186.278528085744, 29587.852060739773, 29635.851820740972, 29696.0, 29800.254993625116, 29870.402591948256, 6929.44564434844, 6930.0, 6963.721451141898, 7136.143662760398, 7155.89266161008, 19656.606867862847, 19672.90163549173, 19673.311434099738, 19682.60634787325, 19702.704459432833, 8037.115917249098, 8272.33821294295, 8276.08963014068, 8285.171482851787, 8303.252707256375, 7464.813379665552, 7480.251974802476, 7637.847243055107, 7697.191794861571, 7705.653245603961, 5260.605454590921, 5314.176302673091, 5360.839174824761, 5387.838364849061, 5556.666600004012, 1512.0851884609872, 1527.6715506166006, 1546.955804831734, 1570.4738912464452, 1609.7022050920616, 951.5622813505727, 963.7927845513249, 965.942293188957, 971.6162115964155, 971.6259240192577, 9741.123298903132, 9763.414195148314, 9818.45998470091, 9960.850587241197, 9990.0, 1023.8157131716363, 1042.9478526073665, 1049.1344640671477, 1055.3087727538475, 1094.8248280275118, 5882.705864706833, 5905.202797622352, 5931.042755890546, 5972.074328479006, 5989.610675306091, 23476.295711128692, 24541.877290613433, 25031.499370012498, 25049.373765656004, 25052.49895002126, 23799.52400952006, 23983.160589379288, 24085.51828963411, 24360.878195608908, 24751.38121546976, 12365.938170309091, 12515.937420313023, 12675.936620317023, 12799.936000319938, 12877.35613219354, 9664.98517655636, 9836.262280329147, 9907.108360247612, 9956.20350371954, 9991.450470224207, 20701.27545535899, 20923.686144707535, 21290.148394064065, 21631.45921351979, 21903.452413689785, 22034.669479957494, 22063.448413789785, 22069.006894689457, 22143.77856221417, 22184.889075554518, 11992.820107698566, 12254.387280635754, 12335.814962775386, 12341.69145771327, 12383.133180677267, 15370.385184592491, 15431.61420964485, 15603.843961560238, 15617.765733514234, 15621.609459763142, 11617.941910290394, 12120.393980301125, 12234.143609947218, 12263.26420414778, 12294.385280735749, 11570.76858462843, 11576.305421674726, 11954.10344224204, 11960.940195298968, 12054.0959428045, 11167.38579378142, 11397.202195846212, 11493.712657183638, 11503.712407189887, 11508.079353651856, 7688.077430708127, 7695.115061767744, 7710.228977102245, 7712.305892469704, 7782.727604533814, 7871.409644276817, 7934.880976785237, 7963.920360796318, 7993.320567751573, 8023.0], "value": 7224.7471865888765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.8208350202684, 538.6929450213379, 548.5282656915055, 551.5807985930692, 579.5827004556718, 6288.968555157224, 6354.301026887045, 6372.968135159318, 6398.744050237985, 6427.903581446282, 6272.153259309992, 6281.0, 6307.211598550181, 6313.9684301578545, 6364.517838043167, 4978.6017118630425, 5078.162103252959, 5096.4648711885275, 5246.973765131179, 5252.65857719247, 5090.0328937501945, 5094.592432605401, 5108.8978220435565, 5117.078925793356, 5139.100657384962, 5071.315372424712, 5082.263071854579, 5084.440711521748, 5105.3873535175835, 5122.795088196468, 5084.898302033957, 5101.846944591687, 5102.515261050195, 5124.692518448905, 5129.487051294878, 4612.238980568202, 4617.8152873885, 4643.628509719214, 4648.861029047905, 4653.488116307203, 6118.919567347079, 6254.124422580842, 6269.185005949197, 6295.338989406092, 6336.303006669263, 5882.441168089024, 5914.994450943307, 5943.881122377571, 5958.344582095966, 5961.599024229303, 6744.054727984135, 6749.595024298509, 6752.797416077526, 6796.150481189851, 6801.897971530381, 5074.720890351029, 5125.82059627915, 5131.89664222194, 5144.125498665236, 5150.922736158923, 7002.194747603989, 7047.295270472911, 7098.0, 7099.716011359539, 7127.679254433563, 5263.157894736823, 5304.745483169638, 5310.097283461821, 5314.840554783363, 5333.759980800874, 5332.893342133136, 5341.786328546815, 5381.78472861089, 5382.111951527954, 5385.192221166856, 5609.279499442767, 5914.733836977261, 5918.496927761103, 5940.762369505258, 5945.34601193877, 6601.966990165019, 6615.801525954229, 6635.303293154246, 6693.899591506131, 6704.396604305636, 1803.1435068342694, 1819.89990550521, 1841.4383612998165, 1842.2262649687164, 1845.4740398986226, 1181.6041626055196, 1287.2469605280828, 1297.2800095946652, 1309.109805332364, 1314.5990472905664, 6078.6048906820915, 6220.533459990519, 6249.96875015622, 6258.937410625836, 6273.215848018997, 6893.75871844483, 6910.550814197061, 6934.895976560356, 6942.0, 6962.477814163958, 6218.968905155536, 6281.0, 6307.810765677037, 6316.9368306317265, 6317.905231421532, 3620.728445366608, 3620.9818950905606, 3626.1841085756023, 3636.709063274932, 3679.6504332088407, 7179.92820071803, 7213.026241457336, 7253.347198752032, 7272.672729727175, 7282.380997615156, 7094.92905070953, 7111.359977601937, 7150.177729561063, 7196.812525933267, 7267.800812865924, 7046.788596341913, 7063.82340441493, 7146.428285737128, 7156.642167891689, 7230.855382892418, 6679.833004174934, 6699.464042876461, 6794.184697836094, 6917.89623155643, 6926.58440493572, 6782.525223234326, 6784.744822207907, 6885.380315771605, 6904.551204171713, 6970.825729356807, 7047.823804404726, 7120.821979450555, 7192.532485388433, 7234.819129521804, 7271.218551454927, 5656.858578535405, 5726.455986681259, 5739.167820666064, 5769.9711501442225, 5803.071508558611, 6914.476216181159, 6930.410915072275, 6948.6525673715105, 7024.613646249505, 7030.50786444944, 6724.29394913527, 6730.93269067303, 6756.324367563401, 6762.700681768222, 6772.05191273232, 6614.206295244601, 6644.302348253557, 6665.700043497957, 6725.966370168314, 6731.778513090766, 6517.4460170886005, 6524.412802847766, 6545.574537655038, 6594.340565943559, 6658.0, 6323.36766323364, 6403.29563747978, 6596.505262105457, 6694.196696396463, 6741.325867413416, 6447.904431060018, 6564.6389448578875, 6568.507361947969, 6588.8023359299295, 6628.304028077176], "value": 5279.218350512628, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.1361935732017, 931.8276118918001, 933.8225737109949, 979.5934687104852, 985.280745056109, 19866.602667946634, 20626.896865515653, 20644.793552064475, 20658.999999999964, 20742.377728668147, 18077.81922180778, 18788.248470061215, 18904.81095189048, 19258.0, 19378.515537111543, 1025.697419261318, 1041.812473754724, 1048.4495639789134, 1048.7745134796016, 1052.0741747262437, 1027.234710140946, 1070.3203465799195, 1071.3786004117633, 1071.860658114444, 1075.596651255779, 1138.3056335635256, 1140.8345789860466, 1141.1099342512853, 1141.4406940599129, 1143.3082984794205, 1126.8929451702074, 1135.2790977729119, 1135.9261647992853, 1136.33524388233, 1137.1869113583787, 830.7383174300137, 832.6086739232551, 832.8667413213857, 833.1585099049943, 833.7332053742805, 18392.0, 18396.908015459838, 18440.354587589503, 18549.07254637276, 18779.34272300463, 22341.55316893653, 22573.435664108365, 23111.422214444607, 23126.190583329502, 23295.252856035866, 18248.0, 18544.629107417775, 18702.812971870244, 18707.53231169218, 18707.71938420925, 3805.334066538345, 3954.802259887023, 3977.6817854571564, 4016.6184212499766, 4044.635982761536, 113703.0, 132849.0, 147495.2625236867, 154057.0, 156033.0, 18176.909115454604, 18404.907975460035, 18856.52858678544, 19104.713429298572, 19125.61748765017, 34090.829545852604, 34258.31483370319, 34438.31123377518, 34457.0, 34500.654993449745, 9436.480993545421, 9756.853647195298, 9836.163926066221, 9856.50717464124, 9872.1608663263, 4602.3786788783755, 4652.092841895797, 4660.0, 4691.5308469152815, 4712.528747125329, 5736.6558006519745, 5830.970845145747, 5836.533077353802, 5851.502622277154, 5887.175795388649, 1086.918481113904, 1112.3103675721104, 1124.1175677093443, 1127.0701671121358, 1129.4917287220783, 705.2172088981226, 708.77319257837, 713.5076797010047, 718.8706032914125, 731.1920328037442, 12872.0, 13113.409896554678, 13165.802512962313, 13807.309634518233, 13964.162150271017, 694.1427337238506, 696.9266432363678, 703.3880523944201, 707.0419581467141, 714.9070620819364, 6212.81361559154, 6222.408871157233, 6226.719797609118, 6237.844053898689, 6271.498280137578, 149146.25426872796, 150412.2479387618, 150427.0, 151246.0, 155220.0, 122278.0, 123272.0, 124263.378683106, 124996.0, 128369.0, 107781.0, 108739.45630271798, 111329.44335278434, 112877.0, 113700.43149784363, 11500.539978401104, 11624.0, 11795.646130616095, 11914.52341906314, 11996.460159292677, 57502.13746793718, 57855.421445786684, 57947.0, 58311.4168858306, 59293.407065930514, 70065.0, 70518.64740676264, 72161.0, 73453.63273183814, 74468.62765686137, 16496.83503165001, 16760.74858877142, 16767.0, 16898.32406703718, 16907.830921690627, 17955.281788728305, 18162.0, 18219.45341639753, 18308.993005384833, 18326.26694932241, 18090.547736306697, 18155.636887262444, 18458.0, 18594.81405185931, 18664.0, 17532.474025779247, 17633.735493967342, 17752.46742597724, 17934.0, 17945.37191198354, 16367.59081022984, 16412.015279083294, 16511.504654860375, 16579.751303730212, 16709.582260443585, 13264.0, 13315.66710832237, 13453.443845669291, 13546.0, 13765.449382024606, 12413.875861241271, 12691.93654031724, 12726.17279876805, 12789.61631151067, 12818.0], "value": 9780.259814930097, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1366.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 105.0, 106.0, 106.0, 95.0, 104.0, 105.0, 105.0, 105.0], "value": 104.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 113.0, 113.0, 113.0, 112.0, 138.0, 113.0, 122.0, 110.0], "value": 115.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 163.0, 160.0, 162.0, 161.0, 164.0, 170.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 75.0, 76.0, 75.0, 76.0, 74.0, 74.0, 74.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 79.0, 79.0, 79.0, 79.0, 79.0, 78.0, 79.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 116.0, 113.0, 114.0, 114.0, 113.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 148.0, 149.0, 149.0, 149.0, 149.0, 151.0, 149.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 100.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 44.0, 45.0, 45.0, 45.0, 45.0, 46.0, 46.0, 43.0, 44.0], "value": 44.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 40.0, 39.0, 38.0, 39.0, 39.0, 38.0, 39.0, 39.0, 38.0], "value": 38.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 71.0, 70.0, 70.0, 72.0, 74.0, 73.0, 71.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 104.0, 107.0, 109.0, 105.0, 110.0, 111.0, 103.0, 107.0], "value": 106.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 159.0, 152.0, 155.0, 151.0, 162.0, 151.0, 150.0, 152.0, 147.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 59.0, 57.0, 65.0, 61.0, 61.0, 61.0, 59.0, 60.0], "value": 59.7, "unit": "score"}]}]} 04:08:52 INFO - Return code: 0 04:08:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:08:52 INFO - # TBPL SUCCESS # 04:08:52 INFO - Running post-action listener: _package_coverage_data 04:08:52 INFO - Running post-action listener: _resource_record_post_action 04:08:52 INFO - [mozharness: 2017-09-18 11:08:52.465746Z] Finished run-tests step (success) 04:08:52 INFO - Running post-run listener: _resource_record_post_run 04:08:52 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 327888896; Read time: 0; Write time: 227892 04:08:52 INFO - TinderboxPrint: CPU usage
13.1% 04:08:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:08:52 INFO - TinderboxPrint: I/O write bytes / time
327,888,896 / 227,892 04:08:52 INFO - TinderboxPrint: CPU idle
8,212.8 (86.9%) 04:08:52 INFO - TinderboxPrint: CPU user
1,186.7 (12.6%) 04:08:52 INFO - TinderboxPrint: Swap in / out
0 / 0 04:08:52 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9408512; Read time: 0; Write time: 760 04:08:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:08:52 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 0; Write bytes: 317865984; Read time: 0; Write time: 227132 04:08:53 INFO - Running post-run listener: _upload_blobber_files 04:08:53 INFO - Blob upload gear active. 04:08:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:08:53 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:08:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:08:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:08:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:08:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:08:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:54 INFO - (blobuploader) - INFO - Done attempting. 04:08:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:08:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:09:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:00 INFO - (blobuploader) - INFO - Done attempting. 04:09:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:09:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:09:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:02 INFO - (blobuploader) - INFO - Done attempting. 04:09:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:09:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:09:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:02 INFO - (blobuploader) - INFO - Done attempting. 04:09:02 INFO - (blobuploader) - INFO - Iteration through files over. 04:09:02 INFO - Return code: 0 04:09:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:09:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:09:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48f81cf57a8b3d2ef6ec317624b199ca26aeaa116888cb97c5b541cbdc992aa88ed9698241f23d70f132d7b97acf3a6a0b3ae22699effee06f21dde5f68575bf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7fa28bb3b069075df3b2b9e4252091971a42e9c0830d5e8b8dfd0a1d079623f428c23adada1f85a6b8a76aa802d3e5c82fa10d47203ebc4fbe3f74e2c12b7f2", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbe581f1dd7d3deb88c265d71a233e95d665ddb4b5044b6d3a44211a1c09ea034d2f1c0cda38690b17bd6a579e0b6cb86de315dcf011ba654db8e0fb596064f1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc958be9c81d5b46736834ca8a9361c043ff070f9dc1a628c16d3d07e03c8396efa02367959cf96336e699679804a90b3df3411c27dcc638cf31f57e2cca26ed"} 04:09:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:09:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:09:02 INFO - Contents: 04:09:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48f81cf57a8b3d2ef6ec317624b199ca26aeaa116888cb97c5b541cbdc992aa88ed9698241f23d70f132d7b97acf3a6a0b3ae22699effee06f21dde5f68575bf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7fa28bb3b069075df3b2b9e4252091971a42e9c0830d5e8b8dfd0a1d079623f428c23adada1f85a6b8a76aa802d3e5c82fa10d47203ebc4fbe3f74e2c12b7f2", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbe581f1dd7d3deb88c265d71a233e95d665ddb4b5044b6d3a44211a1c09ea034d2f1c0cda38690b17bd6a579e0b6cb86de315dcf011ba654db8e0fb596064f1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc958be9c81d5b46736834ca8a9361c043ff070f9dc1a628c16d3d07e03c8396efa02367959cf96336e699679804a90b3df3411c27dcc638cf31f57e2cca26ed"} 04:09:02 INFO - Running post-run listener: copy_logs_to_upload_dir 04:09:02 INFO - Copying logs to upload dir... 04:09:02 INFO - mkdir: /builds/slave/test/build/upload/logs 04:09:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.994148 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-18 04:09:03.093204) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 04:09:03.099474) ========= 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=9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841 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/sha512/48f81cf57a8b3d2ef6ec317624b199ca26aeaa116888cb97c5b541cbdc992aa88ed9698241f23d70f132d7b97acf3a6a0b3ae22699effee06f21dde5f68575bf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7fa28bb3b069075df3b2b9e4252091971a42e9c0830d5e8b8dfd0a1d079623f428c23adada1f85a6b8a76aa802d3e5c82fa10d47203ebc4fbe3f74e2c12b7f2", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbe581f1dd7d3deb88c265d71a233e95d665ddb4b5044b6d3a44211a1c09ea034d2f1c0cda38690b17bd6a579e0b6cb86de315dcf011ba654db8e0fb596064f1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc958be9c81d5b46736834ca8a9361c043ff070f9dc1a628c16d3d07e03c8396efa02367959cf96336e699679804a90b3df3411c27dcc638cf31f57e2cca26ed"} build_url:https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48f81cf57a8b3d2ef6ec317624b199ca26aeaa116888cb97c5b541cbdc992aa88ed9698241f23d70f132d7b97acf3a6a0b3ae22699effee06f21dde5f68575bf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7fa28bb3b069075df3b2b9e4252091971a42e9c0830d5e8b8dfd0a1d079623f428c23adada1f85a6b8a76aa802d3e5c82fa10d47203ebc4fbe3f74e2c12b7f2", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbe581f1dd7d3deb88c265d71a233e95d665ddb4b5044b6d3a44211a1c09ea034d2f1c0cda38690b17bd6a579e0b6cb86de315dcf011ba654db8e0fb596064f1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc958be9c81d5b46736834ca8a9361c043ff070f9dc1a628c16d3d07e03c8396efa02367959cf96336e699679804a90b3df3411c27dcc638cf31f57e2cca26ed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 04:09:03.129644) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 04:09:03.129925) ========= 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=9bfb7e13875ed353a705960e000001c0-1505730309.395655-1718972841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 04:09:03.209980) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 04:09:03.213338) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 04:09:03.213708) ========= ========= Total master_lag: 0.26 =========