builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-048 starttime: 1506689785.21 results: success (0) revision: cd9c8c48e4b3ded47a776f757008f3dcf570c59c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:25.212284) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:25.212658) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:25.212967) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:25.325862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:25.326127) ========= 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=fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-29 05:56: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% 61.2M=0s 2017-09-29 05:56:25 (61.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114882 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:25.469579) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:25.469939) ========= 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=fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018734 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:25.527900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:25.528226) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cd9c8c48e4b3ded47a776f757008f3dcf570c59c --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 cd9c8c48e4b3ded47a776f757008f3dcf570c59c --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=fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 05:56:25,678 truncating revision to first 12 chars 2017-09-29 05:56:25,678 Setting DEBUG logging. 2017-09-29 05:56:25,678 attempt 1/10 2017-09-29 05:56:25,678 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cd9c8c48e4b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 05:56:26,051 unpacking tar archive at: mozilla-central-cd9c8c48e4b3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.711526 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:26.275703) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:26.276047) ========= script_repo_revision: cd9c8c48e4b3ded47a776f757008f3dcf570c59c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:26.276418) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:26.276685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 05:56:26.293466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-29 05:56:26.296803) ========= /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=fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:56:26 INFO - MultiFileLogger online at 20170929 05:56:26 in /builds/slave/test 05:56:26 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 05:56:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:56:26 INFO - {'append_to_log': False, 05:56:26 INFO - 'base_work_dir': '/builds/slave/test', 05:56:26 INFO - 'blob_upload_branch': 'Firefox', 05:56:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:56:26 INFO - 'branch': 'Firefox', 05:56:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:56:26 INFO - 'code_coverage': False, 05:56:26 INFO - 'config_files': ('talos/linux_config.py',), 05:56:26 INFO - 'default_actions': ('clobber', 05:56:26 INFO - 'read-buildbot-config', 05:56:26 INFO - 'download-and-extract', 05:56:26 INFO - 'populate-webroot', 05:56:26 INFO - 'create-virtualenv', 05:56:26 INFO - 'install', 05:56:26 INFO - 'setup-mitmproxy', 05:56:26 INFO - 'run-tests'), 05:56:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:56:26 INFO - 'disable_ccov_upload': False, 05:56:26 INFO - 'disable_stylo': False, 05:56:26 INFO - 'download_minidump_stackwalk': True, 05:56:26 INFO - 'download_symbols': 'ondemand', 05:56:26 INFO - 'enable_stylo': False, 05:56:26 INFO - 'enable_webrender': False, 05:56:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:56:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:56:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:56:26 INFO - 'gecko_profile': False, 05:56:26 INFO - 'gecko_profile_interval': 0, 05:56:26 INFO - 'installer_path': 'installer.exe', 05:56:26 INFO - 'log_level': 'info', 05:56:26 INFO - 'log_name': 'talos', 05:56:26 INFO - 'log_to_console': True, 05:56:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:56:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:56:26 INFO - 'opt_config_files': (), 05:56:26 INFO - 'pip_index': False, 05:56:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 05:56:26 INFO - 'system_bits': '32', 05:56:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:56:26 INFO - 'title': 'talos-linux64-ix-048', 05:56:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:56:26 INFO - 'use_talos_json': True, 05:56:26 INFO - 'verify': 'False', 05:56:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:56:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:56:26 INFO - 'work_dir': 'build'} 05:56:26 INFO - [mozharness: 2017-09-29 12:56:26.585112Z] Running clobber step. 05:56:26 INFO - Running pre-action listener: _resource_record_pre_action 05:56:26 INFO - Running main action method: clobber 05:56:26 INFO - rmtree: /builds/slave/test/build 05:56:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:56:27 INFO - Running post-action listener: _resource_record_post_action 05:56:27 INFO - [mozharness: 2017-09-29 12:56:27.603507Z] Finished clobber step (success) 05:56:27 INFO - [mozharness: 2017-09-29 12:56:27.603604Z] Running read-buildbot-config step. 05:56:27 INFO - Running pre-action listener: _resource_record_pre_action 05:56:27 INFO - Running main action method: read_buildbot_config 05:56:27 INFO - Using buildbot properties: 05:56:27 INFO - { 05:56:27 INFO - "project": "", 05:56:27 INFO - "product": "firefox", 05:56:27 INFO - "who": "archaeopteryx@coole-files.de", 05:56:27 INFO - "installer_path": "public/build/target.tar.bz2", 05:56:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 05:56:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:56:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 05:56:27 INFO - "stage_platform": "linux64-pgo", 05:56:27 INFO - "basedir": "/builds/slave/test", 05:56:27 INFO - "buildnumber": 74, 05:56:27 INFO - "platform": "ubuntu64_hw", 05:56:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:56:27 INFO - "slavebuilddir": "test", 05:56:27 INFO - "taskId": "EilPrM3_TU6nnAROr-Qxcw", 05:56:27 INFO - "branch": "mozilla-central", 05:56:27 INFO - "script_repo_revision": "production", 05:56:27 INFO - "revision": "cd9c8c48e4b3ded47a776f757008f3dcf570c59c", 05:56:27 INFO - "slavename": "talos-linux64-ix-048", 05:56:27 INFO - "repo_path": "mozilla-central" 05:56:27 INFO - } 05:56:27 INFO - Finding installer, test and symbols from parent task. 05:56:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EilPrM3_TU6nnAROr-Qxcw'}, attempt #1 05:56:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EilPrM3_TU6nnAROr-Qxcw'}, attempt #1 05:56:28 INFO - Task dependencies: HJIuBy1HRP21tCyn9W2sCA 05:56:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA'}, attempt #1 05:56:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.tar.bz2 05:56:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.test_packages.json 05:56:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.crashreporter-symbols.zip 05:56:29 INFO - Running post-action listener: _resource_record_post_action 05:56:29 INFO - [mozharness: 2017-09-29 12:56:29.075399Z] Finished read-buildbot-config step (success) 05:56:29 INFO - [mozharness: 2017-09-29 12:56:29.075618Z] Running download-and-extract step. 05:56:29 INFO - Running pre-action listener: _resource_record_pre_action 05:56:29 INFO - Running main action method: download_and_extract 05:56:29 INFO - mkdir: /builds/slave/test/build/tests 05:56: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')]} 05:56:29 INFO - trying https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.test_packages.json 05:56:29 INFO - Downloading https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:56:29 INFO - Downloaded 989 bytes. 05:56:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:56:29 INFO - Using the following test package requirements: 05:56:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:56:29 INFO - u'common': [u'target.common.tests.zip'], 05:56:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:56:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:56:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:56:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:56:29 INFO - u'mozbase': [u'target.common.tests.zip'], 05:56:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:56:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:56:29 INFO - u'web-platform': [u'target.common.tests.zip', 05:56:29 INFO - u'target.web-platform.tests.tar.gz'], 05:56:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:56:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 05:56:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.common.tests.zip 05:56:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:56:29 INFO - Fetch https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.common.tests.zip into memory 05:56:32 INFO - Content-Length response header: 55923140 05:56:32 INFO - Bytes received: 55923140 05:56:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.talos.tests.zip 05:56:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:56:43 INFO - Fetch https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.talos.tests.zip into memory 05:56:44 INFO - Content-Length response header: 14521355 05:56:44 INFO - Bytes received: 14521355 05:56:45 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')]} 05:56:45 INFO - trying https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.tar.bz2 05:56:45 INFO - Downloading https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:56:46 INFO - Downloaded 62382482 bytes. 05:56:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.tar.bz2 05:56:47 INFO - mkdir: /builds/slave/test/properties 05:56:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:56:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:56:47 INFO - Contents: 05:56:47 INFO - build_url:https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.tar.bz2 05:56:47 INFO - Running post-action listener: _resource_record_post_action 05:56:47 INFO - Running post-action listener: find_tests_for_verification 05:56:47 INFO - Running post-action listener: set_extra_try_arguments 05:56:47 INFO - [mozharness: 2017-09-29 12:56:47.019996Z] Finished download-and-extract step (success) 05:56:47 INFO - [mozharness: 2017-09-29 12:56:47.020095Z] Running populate-webroot step. 05:56:47 INFO - Running pre-action listener: _resource_record_pre_action 05:56:47 INFO - Running main action method: populate_webroot 05:56:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:56:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:56:47 INFO - 'tests': ['tresize', 05:56:47 INFO - 'tcanvasmark']}, 05:56:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:56:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:56:47 INFO - 'tests': ['dromaeo_css', 05:56:47 INFO - 'kraken']}, 05:56:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:56:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:56:47 INFO - 'talos_options': ['--disable-stylo'], 05:56:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:56:47 INFO - 'tests': ['damp', 'tps']}, 05:56:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:56:47 INFO - 'talos_options': ['--disable-stylo'], 05:56:47 INFO - 'tests': ['damp', 'tps']}, 05:56:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:56:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:56:47 INFO - 'tests': ['dromaeo_dom']}, 05:56:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:56:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:56:47 INFO - 'tests': ['basic_compositor_video', 05:56:47 INFO - 'glvideo']}, 05:56:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:56:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:56:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:56:47 INFO - 'talos_options': ['--disable-stylo'], 05:56:47 INFO - 'tests': ['ts_paint_webext', 05:56:47 INFO - 'tp5o_webext']}, 05:56:47 INFO - 'other-e10s': {'tests': ['a11yr', 05:56:47 INFO - 'ts_paint', 05:56:47 INFO - 'tpaint', 05:56:47 INFO - 'sessionrestore', 05:56:47 INFO - 'sessionrestore_many_windows', 05:56:47 INFO - 'sessionrestore_no_auto_restore', 05:56:47 INFO - 'tabpaint', 05:56:47 INFO - 'cpstartup']}, 05:56:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:56:47 INFO - 'tests': ['a11yr', 05:56:47 INFO - 'ts_paint', 05:56:47 INFO - 'tpaint', 05:56:47 INFO - 'sessionrestore', 05:56:47 INFO - 'sessionrestore_many_windows', 05:56:47 INFO - 'sessionrestore_no_auto_restore', 05:56:47 INFO - 'tabpaint', 05:56:47 INFO - 'cpstartup']}, 05:56:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 05:56:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 05:56:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:56:47 INFO - 'tests': ['perf_reftest_singletons']}, 05:56:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:56:47 INFO - 'tests': ['perf_reftest']}, 05:56:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:56:47 INFO - 'tsvgr_opacity', 05:56:47 INFO - 'tart', 05:56:47 INFO - 'tscrollx', 05:56:47 INFO - 'tsvg_static']}, 05:56:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:56:47 INFO - 'tests': ['tsvgx', 05:56:47 INFO - 'tsvgr_opacity', 05:56:47 INFO - 'tart', 05:56:47 INFO - 'tscrollx', 05:56:47 INFO - 'tsvg_static']}, 05:56:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:56:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:56:47 INFO - 'talos_options': ['--disable-stylo'], 05:56:47 INFO - 'tests': ['tp5o']}, 05:56:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:56:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 05:56:47 INFO - 'talos_options': ['--mitmproxy', 05:56:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:56:47 INFO - '--firstNonBlankPaint'], 05:56:47 INFO - 'tests': ['tp6_google', 05:56:47 INFO - 'tp6_youtube', 05:56:47 INFO - 'tp6_amazon', 05:56:47 INFO - 'tp6_facebook']}, 05:56:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:56:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 05:56:47 INFO - 'talos_options': ['--disable-stylo', 05:56:47 INFO - '--mitmproxy', 05:56:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:56:47 INFO - '--firstNonBlankPaint'], 05:56:47 INFO - 'tests': ['tp6_google', 05:56:47 INFO - 'tp6_youtube', 05:56:47 INFO - 'tp6_amazon', 05:56:47 INFO - 'tp6_facebook']}, 05:56:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:56:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 05:56:47 INFO - 'talos_options': ['--stylo-threads=1', 05:56:47 INFO - '--mitmproxy', 05:56:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:56:47 INFO - '--firstNonBlankPaint'], 05:56:47 INFO - 'tests': ['tp6_google', 05:56:47 INFO - 'tp6_youtube', 05:56:47 INFO - 'tp6_amazon', 05:56:47 INFO - 'tp6_facebook']}, 05:56:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:56:47 INFO - 'talos_options': ['--xperf_path', 05:56:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:47 INFO - 'tests': ['tp5n']}, 05:56:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:56:47 INFO - 'talos_options': ['--disable-stylo', 05:56:47 INFO - '--xperf_path', 05:56:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:47 INFO - 'tests': ['tp5n']}}} 05:56:47 INFO - Running post-action listener: _resource_record_post_action 05:56:47 INFO - [mozharness: 2017-09-29 12:56:47.043945Z] Finished populate-webroot step (success) 05:56:47 INFO - [mozharness: 2017-09-29 12:56:47.044035Z] Running create-virtualenv step. 05:56:47 INFO - Running pre-action listener: _resource_record_pre_action 05:56:47 INFO - Running main action method: create_virtualenv 05:56:47 INFO - Creating virtualenv /builds/slave/test/build/venv 05:56:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:56:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:56:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:56:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:56:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:56:47 INFO - Installing distribute.............................................................................................................................................................................................done. 05:56:47 INFO - Installing pip...............done. 05:56:47 INFO - Return code: 0 05:56:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:56:48 INFO - Reading from file tmpfile_stdout 05:56:48 INFO - Output received: 05:56:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:56:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56: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')]} 05:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1113b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b5d60>, '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 0x12b6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b6ef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', '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 05:56: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', 'pip>=1.5'] in /builds/slave/test/build 05:56: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 pip>=1.5 05:56:48 INFO - Using env: {'DISPLAY': ':0', 05:56:48 INFO - 'HOME': '/home/cltbld', 05:56:48 INFO - 'LANG': 'en_US.UTF-8', 05:56:48 INFO - 'LANGUAGE': 'en_US:en', 05:56:48 INFO - 'LOGNAME': 'cltbld', 05:56:48 INFO - 'MAIL': '/var/mail/cltbld', 05:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:48 INFO - 'MOZ_NO_REMOTE': '1', 05:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:48 INFO - 'NO_EM_RESTART': '1', 05:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:48 INFO - 'PWD': '/builds/slave/test', 05:56:48 INFO - 'SHELL': '/bin/bash', 05:56:48 INFO - 'SHLVL': '1', 05:56:48 INFO - 'TERM': 'linux', 05:56:48 INFO - 'TMOUT': '86400', 05:56:48 INFO - 'USER': 'cltbld', 05:56:48 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', 05:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:48 INFO - '_': '/tools/buildbot/bin/python'} 05:56:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:56:49 INFO - Downloading/unpacking pip>=1.5 05:56:49 INFO - Running setup.py egg_info for package pip 05:56:49 INFO - warning: no files found matching 'pip/cacert.pem' 05:56:49 INFO - warning: no files found matching '*.html' under directory 'docs' 05:56:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:56:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:56:49 INFO - Installing collected packages: pip 05:56:49 INFO - Found existing installation: pip 1.1 05:56:49 INFO - Uninstalling pip: 05:56:49 INFO - Successfully uninstalled pip 05:56:49 INFO - Running setup.py install for pip 05:56:49 INFO - warning: no files found matching 'pip/cacert.pem' 05:56:49 INFO - warning: no files found matching '*.html' under directory 'docs' 05:56:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:56:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:56:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:56:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:56:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:56:49 INFO - Successfully installed pip 05:56:49 INFO - Cleaning up... 05:56:49 INFO - Return code: 0 05:56:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:49 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 0xf4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1113b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b5d60>, '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 0x12b6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b6ef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', '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 05:56:49 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 05:56:49 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 05:56:49 INFO - Using env: {'DISPLAY': ':0', 05:56:49 INFO - 'HOME': '/home/cltbld', 05:56:49 INFO - 'LANG': 'en_US.UTF-8', 05:56:49 INFO - 'LANGUAGE': 'en_US:en', 05:56:49 INFO - 'LOGNAME': 'cltbld', 05:56:49 INFO - 'MAIL': '/var/mail/cltbld', 05:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:49 INFO - 'MOZ_NO_REMOTE': '1', 05:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:49 INFO - 'NO_EM_RESTART': '1', 05:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:49 INFO - 'PWD': '/builds/slave/test', 05:56:49 INFO - 'SHELL': '/bin/bash', 05:56:49 INFO - 'SHLVL': '1', 05:56:49 INFO - 'TERM': 'linux', 05:56:49 INFO - 'TMOUT': '86400', 05:56:49 INFO - 'USER': 'cltbld', 05:56:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', 05:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:49 INFO - '_': '/tools/buildbot/bin/python'} 05:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:49 INFO - Downloading/unpacking psutil>=3.1.1 05:56:49 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 05:56:49 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 05:56:49 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 05:56:49 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 05:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:56:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:50 INFO - Installing collected packages: psutil 05:56:50 INFO - Running setup.py install for psutil 05:56:50 INFO - building 'psutil._psutil_linux' extension 05:56:50 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 05:56: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 05:56:50 INFO - building 'psutil._psutil_posix' extension 05:56: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 05:56:51 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 05:56:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:51 INFO - Successfully installed psutil 05:56:51 INFO - Cleaning up... 05:56:51 INFO - Return code: 0 05:56:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:56:51 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')]} 05:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:51 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')]} 05:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:51 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 0xf4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1113b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b5d60>, '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 0x12b6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b6ef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', '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 05:56:51 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 05:56:51 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 05:56:51 INFO - Using env: {'DISPLAY': ':0', 05:56:51 INFO - 'HOME': '/home/cltbld', 05:56:51 INFO - 'LANG': 'en_US.UTF-8', 05:56:51 INFO - 'LANGUAGE': 'en_US:en', 05:56:51 INFO - 'LOGNAME': 'cltbld', 05:56:51 INFO - 'MAIL': '/var/mail/cltbld', 05:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:51 INFO - 'MOZ_NO_REMOTE': '1', 05:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:51 INFO - 'NO_EM_RESTART': '1', 05:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:51 INFO - 'PWD': '/builds/slave/test', 05:56:51 INFO - 'SHELL': '/bin/bash', 05:56:51 INFO - 'SHLVL': '1', 05:56:51 INFO - 'TERM': 'linux', 05:56:51 INFO - 'TMOUT': '86400', 05:56:51 INFO - 'USER': 'cltbld', 05:56:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', 05:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:51 INFO - '_': '/tools/buildbot/bin/python'} 05:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:56:51 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 05:56:51 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 05:56:51 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 05:56:51 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 05:56:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:56:52 INFO - Installing collected packages: mozsystemmonitor 05:56:52 INFO - Running setup.py install for mozsystemmonitor 05:56:52 INFO - Successfully installed mozsystemmonitor 05:56:52 INFO - Cleaning up... 05:56:53 INFO - Return code: 0 05:56:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1113b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b5d60>, '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 0x12b6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b6ef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', '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 05:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:56:53 INFO - Using env: {'DISPLAY': ':0', 05:56:53 INFO - 'HOME': '/home/cltbld', 05:56:53 INFO - 'LANG': 'en_US.UTF-8', 05:56:53 INFO - 'LANGUAGE': 'en_US:en', 05:56:53 INFO - 'LOGNAME': 'cltbld', 05:56:53 INFO - 'MAIL': '/var/mail/cltbld', 05:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:53 INFO - 'MOZ_NO_REMOTE': '1', 05:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:53 INFO - 'NO_EM_RESTART': '1', 05:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:53 INFO - 'PWD': '/builds/slave/test', 05:56:53 INFO - 'SHELL': '/bin/bash', 05:56:53 INFO - 'SHLVL': '1', 05:56:53 INFO - 'TERM': 'linux', 05:56:53 INFO - 'TMOUT': '86400', 05:56:53 INFO - 'USER': 'cltbld', 05:56:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', 05:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:53 INFO - '_': '/tools/buildbot/bin/python'} 05:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:54 INFO - Downloading/unpacking jsonschema==2.5.1 05:56:54 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 05:56:54 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 05:56:54 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 05:56:54 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 05:56:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:56:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:56: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 05:56: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 05:56: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 05:56: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 05:56:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:56:55 INFO - warning: no files found matching '*.txt' 05:56:55 INFO - no previously-included directories found matching 'build' 05:56:55 INFO - no previously-included directories found matching 'dist' 05:56:55 INFO - no previously-included directories found matching '.git*' 05:56:55 INFO - Installing collected packages: jsonschema, functools32 05:56:55 INFO - Running setup.py install for functools32 05:56:55 INFO - warning: no files found matching '*.txt' 05:56:55 INFO - no previously-included directories found matching 'build' 05:56:55 INFO - no previously-included directories found matching 'dist' 05:56:55 INFO - no previously-included directories found matching '.git*' 05:56:55 INFO - Successfully installed jsonschema functools32 05:56:55 INFO - Cleaning up... 05:56:55 INFO - Return code: 0 05:56:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56: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')]} 05:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56: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 0xf4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1113b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b5d60>, '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 0x12b6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b6ef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', '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 05:56: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 05:56: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 05:56:55 INFO - Using env: {'DISPLAY': ':0', 05:56:55 INFO - 'HOME': '/home/cltbld', 05:56:55 INFO - 'LANG': 'en_US.UTF-8', 05:56:55 INFO - 'LANGUAGE': 'en_US:en', 05:56:55 INFO - 'LOGNAME': 'cltbld', 05:56:55 INFO - 'MAIL': '/var/mail/cltbld', 05:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:55 INFO - 'MOZ_NO_REMOTE': '1', 05:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:55 INFO - 'NO_EM_RESTART': '1', 05:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:55 INFO - 'PWD': '/builds/slave/test', 05:56:55 INFO - 'SHELL': '/bin/bash', 05:56:55 INFO - 'SHLVL': '1', 05:56:55 INFO - 'TERM': 'linux', 05:56:55 INFO - 'TMOUT': '86400', 05:56:55 INFO - 'USER': 'cltbld', 05:56:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', 05:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:55 INFO - '_': '/tools/buildbot/bin/python'} 05:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:56:56 INFO - Cleaning up... 05:56:56 INFO - Return code: 0 05:56:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1113b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b5d60>, '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 0x12b6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b6ef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', '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 05:56:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:56:56 INFO - Using env: {'DISPLAY': ':0', 05:56:56 INFO - 'HOME': '/home/cltbld', 05:56:56 INFO - 'LANG': 'en_US.UTF-8', 05:56:56 INFO - 'LANGUAGE': 'en_US:en', 05:56:56 INFO - 'LOGNAME': 'cltbld', 05:56:56 INFO - 'MAIL': '/var/mail/cltbld', 05:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:56 INFO - 'MOZ_NO_REMOTE': '1', 05:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:56 INFO - 'NO_EM_RESTART': '1', 05:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:56 INFO - 'PWD': '/builds/slave/test', 05:56:56 INFO - 'SHELL': '/bin/bash', 05:56:56 INFO - 'SHLVL': '1', 05:56:56 INFO - 'TERM': 'linux', 05:56:56 INFO - 'TMOUT': '86400', 05:56:56 INFO - 'USER': 'cltbld', 05:56:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', 05:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:56 INFO - '_': '/tools/buildbot/bin/python'} 05:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:56: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 05:56: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 05:56: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 05:56: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 05:56:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:56:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:56:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:58 INFO - Downloading docopt-0.6.1.tar.gz 05:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:56:58 INFO - Installing collected packages: blobuploader, requests, docopt 05:56:58 INFO - Running setup.py install for blobuploader 05:56:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:56:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:56:58 INFO - Running setup.py install for requests 05:56:59 INFO - Running setup.py install for docopt 05:56:59 INFO - Successfully installed blobuploader requests docopt 05:56:59 INFO - Cleaning up... 05:56:59 INFO - Return code: 0 05:56:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:59 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 0xf4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1113b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b5d60>, '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 0x12b6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b6ef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', '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 05:56:59 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 05:56:59 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 05:56:59 INFO - Using env: {'DISPLAY': ':0', 05:56:59 INFO - 'HOME': '/home/cltbld', 05:56:59 INFO - 'LANG': 'en_US.UTF-8', 05:56:59 INFO - 'LANGUAGE': 'en_US:en', 05:56:59 INFO - 'LOGNAME': 'cltbld', 05:56:59 INFO - 'MAIL': '/var/mail/cltbld', 05:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:59 INFO - 'MOZ_NO_REMOTE': '1', 05:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:59 INFO - 'NO_EM_RESTART': '1', 05:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:59 INFO - 'PWD': '/builds/slave/test', 05:56:59 INFO - 'SHELL': '/bin/bash', 05:56:59 INFO - 'SHLVL': '1', 05:56:59 INFO - 'TERM': 'linux', 05:56:59 INFO - 'TMOUT': '86400', 05:56:59 INFO - 'USER': 'cltbld', 05:56:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', 05:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:59 INFO - '_': '/tools/buildbot/bin/python'} 05:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:56:59 INFO - Running setup.py (path:/tmp/pip-OwTWV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:56:59 INFO - Running setup.py (path:/tmp/pip-vKvQYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:56:59 INFO - Running setup.py (path:/tmp/pip-89w_uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:56:59 INFO - Running setup.py (path:/tmp/pip-3Qe81y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:56:59 INFO - Running setup.py (path:/tmp/pip-bSAg0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:56:59 INFO - Running setup.py (path:/tmp/pip-gHYQd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:56:59 INFO - Running setup.py (path:/tmp/pip-dLrnd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:56:59 INFO - Running setup.py (path:/tmp/pip-_vVqpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:00 INFO - Running setup.py (path:/tmp/pip-HpTh4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:00 INFO - Running setup.py (path:/tmp/pip-xa39sZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:00 INFO - Running setup.py (path:/tmp/pip-LWde0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:00 INFO - Running setup.py (path:/tmp/pip-y9zBYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:00 INFO - Running setup.py (path:/tmp/pip-rvdf_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:00 INFO - Running setup.py (path:/tmp/pip-Ossd46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:00 INFO - Running setup.py (path:/tmp/pip-36gBO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:00 INFO - Running setup.py (path:/tmp/pip-NCbU4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:00 INFO - Running setup.py (path:/tmp/pip-JVfiD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:57:00 INFO - Running setup.py install for manifestparser 05:57:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:57:00 INFO - Running setup.py install for mozcrash 05:57:00 INFO - Running setup.py install for mozdebug 05:57:00 INFO - Running setup.py install for mozdevice 05:57:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for mozfile 05:57:01 INFO - Running setup.py install for mozhttpd 05:57:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for mozinfo 05:57:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for mozInstall 05:57:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for mozleak 05:57:01 INFO - Running setup.py install for mozlog 05:57:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for moznetwork 05:57:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for mozprocess 05:57:01 INFO - Running setup.py install for mozprofile 05:57:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for mozrunner 05:57:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:57:02 INFO - Running setup.py install for mozscreenshot 05:57:02 INFO - Running setup.py install for moztest 05:57:02 INFO - Running setup.py install for mozversion 05:57:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:57:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:57:02 INFO - Cleaning up... 05:57:02 INFO - Return code: 0 05:57:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:02 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')]} 05:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:02 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')]} 05:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:02 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 0xf4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1113b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b5d60>, '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 0x12b6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b6ef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', '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 05:57:02 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 05:57:02 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 05:57:02 INFO - Using env: {'DISPLAY': ':0', 05:57:02 INFO - 'HOME': '/home/cltbld', 05:57:02 INFO - 'LANG': 'en_US.UTF-8', 05:57:02 INFO - 'LANGUAGE': 'en_US:en', 05:57:02 INFO - 'LOGNAME': 'cltbld', 05:57:02 INFO - 'MAIL': '/var/mail/cltbld', 05:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:02 INFO - 'MOZ_NO_REMOTE': '1', 05:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:02 INFO - 'NO_EM_RESTART': '1', 05:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:02 INFO - 'PWD': '/builds/slave/test', 05:57:02 INFO - 'SHELL': '/bin/bash', 05:57:02 INFO - 'SHLVL': '1', 05:57:02 INFO - 'TERM': 'linux', 05:57:02 INFO - 'TMOUT': '86400', 05:57:02 INFO - 'USER': 'cltbld', 05:57:02 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', 05:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:02 INFO - '_': '/tools/buildbot/bin/python'} 05:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:02 INFO - Running setup.py (path:/tmp/pip-ncvUUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:02 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)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:02 INFO - Running setup.py (path:/tmp/pip-FAWaIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:02 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)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:02 INFO - Running setup.py (path:/tmp/pip-pue_Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:02 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)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:02 INFO - Running setup.py (path:/tmp/pip-mcJROk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:02 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)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:02 INFO - Running setup.py (path:/tmp/pip-xiDzkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:02 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)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:02 INFO - Running setup.py (path:/tmp/pip-edzBO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:03 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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:03 INFO - Running setup.py (path:/tmp/pip-0c_LOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:03 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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:03 INFO - Running setup.py (path:/tmp/pip-0839Ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:03 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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:03 INFO - Running setup.py (path:/tmp/pip-hsQGFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:03 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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:03 INFO - Running setup.py (path:/tmp/pip-kNpFBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:03 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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:03 INFO - Running setup.py (path:/tmp/pip-iHCf8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:03 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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:03 INFO - Running setup.py (path:/tmp/pip-Jqvis4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:03 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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:03 INFO - Running setup.py (path:/tmp/pip-cx85OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:03 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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:03 INFO - Running setup.py (path:/tmp/pip-Cd9uXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:03 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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:03 INFO - Running setup.py (path:/tmp/pip-DrapJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:03 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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:03 INFO - Running setup.py (path:/tmp/pip-rsnVsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:03 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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:03 INFO - Running setup.py (path:/tmp/pip-x_BRjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:03 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)) 05:57:03 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)) 05:57:03 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)) 05:57:03 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)) 05:57:03 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)) 05:57:03 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)) 05:57:03 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)) 05:57:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:04 INFO - Downloading blessings-1.6.tar.gz 05:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:57:05 INFO - Installing collected packages: blessings 05:57:05 INFO - Running setup.py install for blessings 05:57:05 INFO - Successfully installed blessings 05:57:05 INFO - Cleaning up... 05:57:05 INFO - Return code: 0 05:57:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:57:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:05 INFO - Reading from file tmpfile_stdout 05:57:05 INFO - Current package versions: 05:57:05 INFO - argparse == 1.2.1 05:57:05 INFO - blessings == 1.6 05:57:05 INFO - blobuploader == 1.2.4 05:57:05 INFO - docopt == 0.6.1 05:57:05 INFO - functools32 == 3.2.3-2 05:57:05 INFO - jsonschema == 2.5.1 05:57:05 INFO - manifestparser == 1.1 05:57:05 INFO - mozInstall == 1.13 05:57:05 INFO - mozcrash == 1.0 05:57:05 INFO - mozdebug == 0.1 05:57:05 INFO - mozdevice == 0.51 05:57:05 INFO - mozfile == 1.2 05:57:05 INFO - mozhttpd == 0.7 05:57:05 INFO - mozinfo == 0.10 05:57:05 INFO - mozleak == 0.1 05:57:05 INFO - mozlog == 3.5 05:57:05 INFO - moznetwork == 0.27 05:57:05 INFO - mozprocess == 0.25 05:57:05 INFO - mozprofile == 0.28 05:57:05 INFO - mozrunner == 6.13 05:57:05 INFO - mozscreenshot == 0.1 05:57:05 INFO - mozsystemmonitor == 0.3 05:57:05 INFO - moztest == 0.8 05:57:05 INFO - mozversion == 1.4 05:57:05 INFO - psutil == 3.1.1 05:57:05 INFO - requests == 1.2.3 05:57:05 INFO - wsgiref == 0.1.2 05:57:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:05 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 0xf4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1113b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b5d60>, '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 0x12b6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b6ef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', '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 05:57:05 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 05:57:05 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 05:57:05 INFO - Using env: {'DISPLAY': ':0', 05:57:05 INFO - 'HOME': '/home/cltbld', 05:57:05 INFO - 'LANG': 'en_US.UTF-8', 05:57:05 INFO - 'LANGUAGE': 'en_US:en', 05:57:05 INFO - 'LOGNAME': 'cltbld', 05:57:05 INFO - 'MAIL': '/var/mail/cltbld', 05:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:05 INFO - 'MOZ_NO_REMOTE': '1', 05:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:05 INFO - 'NO_EM_RESTART': '1', 05:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:05 INFO - 'PWD': '/builds/slave/test', 05:57:05 INFO - 'SHELL': '/bin/bash', 05:57:05 INFO - 'SHLVL': '1', 05:57:05 INFO - 'TERM': 'linux', 05:57:05 INFO - 'TMOUT': '86400', 05:57:05 INFO - 'USER': 'cltbld', 05:57:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', 05:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:05 INFO - '_': '/tools/buildbot/bin/python'} 05:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:05 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)) 05:57:05 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)) 05:57:05 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)) 05:57:05 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)) 05:57:05 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)) 05:57:05 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)) 05:57:05 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)) 05:57:05 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)) 05:57:05 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)) 05:57:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:57:06 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)) 05:57:06 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)) 05:57:06 INFO - Installing collected packages: simplejson 05:57:06 INFO - Running setup.py install for simplejson 05:57:06 INFO - building 'simplejson._speedups' extension 05:57:06 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 05:57:07 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 05:57:07 INFO - Successfully installed simplejson 05:57:07 INFO - Cleaning up... 05:57:07 INFO - Return code: 0 05:57:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:07 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 0xf4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1113b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b5d60>, '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 0x12b6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b6ef0>, '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': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', '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 05:57:07 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 05:57:07 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 05:57:07 INFO - Using env: {'DISPLAY': ':0', 05:57:07 INFO - 'HOME': '/home/cltbld', 05:57:07 INFO - 'LANG': 'en_US.UTF-8', 05:57:07 INFO - 'LANGUAGE': 'en_US:en', 05:57:07 INFO - 'LOGNAME': 'cltbld', 05:57:07 INFO - 'MAIL': '/var/mail/cltbld', 05:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:07 INFO - 'MOZ_NO_REMOTE': '1', 05:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:07 INFO - 'NO_EM_RESTART': '1', 05:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:07 INFO - 'PWD': '/builds/slave/test', 05:57:07 INFO - 'SHELL': '/bin/bash', 05:57:07 INFO - 'SHLVL': '1', 05:57:07 INFO - 'TERM': 'linux', 05:57:07 INFO - 'TMOUT': '86400', 05:57:07 INFO - 'USER': 'cltbld', 05:57:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', 05:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:07 INFO - '_': '/tools/buildbot/bin/python'} 05:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:57:08 INFO - Cleaning up... 05:57:08 INFO - Return code: 0 05:57:08 INFO - Running post-action listener: _resource_record_post_action 05:57:08 INFO - Running post-action listener: _start_resource_monitoring 05:57:08 INFO - Starting resource monitoring. 05:57:08 INFO - [mozharness: 2017-09-29 12:57:08.138324Z] Finished create-virtualenv step (success) 05:57:08 INFO - [mozharness: 2017-09-29 12:57:08.138791Z] Running install step. 05:57:08 INFO - Running pre-action listener: _resource_record_pre_action 05:57:08 INFO - Running main action method: install 05:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:08 INFO - Reading from file tmpfile_stdout 05:57:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:57:08 INFO - Reading from file tmpfile_stdout 05:57:08 INFO - Output received: 05:57:08 INFO - Usage: mozinstall [options] installer 05:57:08 INFO - Options: 05:57:08 INFO - -h, --help show this help message and exit 05:57:08 INFO - -d DEST, --destination=DEST 05:57:08 INFO - Directory to install application into. [default: 05:57:08 INFO - "/builds/slave/test"] 05:57:08 INFO - --app=APP Application being installed. [default: firefox] 05:57:08 INFO - mkdir: /builds/slave/test/build/application 05:57:08 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'] 05:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:57:26 INFO - Reading from file tmpfile_stdout 05:57:26 INFO - Output received: 05:57:26 INFO - /builds/slave/test/build/application/firefox/firefox 05:57:26 INFO - Running post-action listener: _resource_record_post_action 05:57:26 INFO - [mozharness: 2017-09-29 12:57:26.135359Z] Finished install step (success) 05:57:26 INFO - [mozharness: 2017-09-29 12:57:26.135611Z] Running setup-mitmproxy step. 05:57:26 INFO - Running pre-action listener: _resource_record_pre_action 05:57:26 INFO - Running main action method: setup_mitmproxy 05:57:26 INFO - Skipping: mitmproxy is not required 05:57:26 INFO - Running post-action listener: _resource_record_post_action 05:57:26 INFO - [mozharness: 2017-09-29 12:57:26.136753Z] Finished setup-mitmproxy step (success) 05:57:26 INFO - [mozharness: 2017-09-29 12:57:26.136990Z] Running run-tests step. 05:57:26 INFO - Running pre-action listener: _resource_record_pre_action 05:57:26 INFO - Running pre-action listener: _set_gcov_prefix 05:57:26 INFO - Running main action method: run_tests 05:57:26 WARNING - Try message not found. 05:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:57:26 INFO - Python 2.7.3 05:57:26 INFO - Return code: 0 05:57:26 INFO - grabbing minidump binary from tooltool 05:57:26 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')]} 05:57:26 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 0x12b5d60>, '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 0x12b6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b6ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:57:26 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 05:57:26 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 05:57:26 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 05:57:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:57:26 INFO - Return code: 0 05:57:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:57:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:57:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:57:26 INFO - ENV: RUST_BACKTRACE is now full 05:57:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:57:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:57:26 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/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 05:57:26 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/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 05:57:26 INFO - Using env: {'DISPLAY': ':0', 05:57:26 INFO - 'HOME': '/home/cltbld', 05:57:26 INFO - 'LANG': 'en_US.UTF-8', 05:57:26 INFO - 'LANGUAGE': 'en_US:en', 05:57:26 INFO - 'LOGNAME': 'cltbld', 05:57:26 INFO - 'MAIL': '/var/mail/cltbld', 05:57:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:57:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:26 INFO - 'MOZ_NO_REMOTE': '1', 05:57:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:26 INFO - 'NO_EM_RESTART': '1', 05:57:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:26 INFO - 'PWD': '/builds/slave/test', 05:57:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:57:26 INFO - 'RUST_BACKTRACE': 'full', 05:57:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:57:26 INFO - 'SHELL': '/bin/bash', 05:57:26 INFO - 'SHLVL': '1', 05:57:26 INFO - 'TERM': 'linux', 05:57:26 INFO - 'TMOUT': '86400', 05:57:26 INFO - 'USER': 'cltbld', 05:57:26 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', 05:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:26 INFO - '_': '/tools/buildbot/bin/python'} 05:57:26 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/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 05:57:26 INFO - mozversion application_buildid: 20170929113110 05:57:26 INFO - mozversion application_changeset: cd9c8c48e4b3ded47a776f757008f3dcf570c59c 05:57:26 INFO - mozversion application_display_name: Nightly 05:57:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:57:26 INFO - mozversion application_name: Firefox 05:57:26 INFO - mozversion application_remotingname: firefox 05:57:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:57:26 INFO - mozversion application_vendor: Mozilla 05:57:26 INFO - mozversion application_version: 58.0a1 05:57:26 INFO - mozversion platform_buildid: 20170929113110 05:57:26 INFO - mozversion platform_changeset: cd9c8c48e4b3ded47a776f757008f3dcf570c59c 05:57:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:57:26 INFO - mozversion platform_version: 58.0a1 05:57:26 INFO - using testdate: 1506689846 05:57:26 INFO - actual date: 1506689846 05:57:26 INFO - starting webserver on 'localhost:43675' 05:57:26 INFO - SUITE-START | Running 2 tests 05:57:26 INFO - TEST-START | dromaeo_css 05:57:26 INFO - Initialising browser for dromaeo_css test... 05:57:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43675/getInfo.html -profile /tmp/tmpAspkgB/profile 05:57:26 INFO - TEST-INFO | started process 7853 (/builds/slave/test/build/application/firefox/firefox http://localhost:43675/getInfo.html) 05:57:32 INFO - TEST-INFO | 7853: exit 0 05:57:32 INFO - Browser initialized. 05:57:32 INFO - Running cycle 1/1 for dromaeo_css test... 05:57:32 INFO - Using env: {'DISPLAY': ':0', 05:57:32 INFO - 'HOME': '/home/cltbld', 05:57:32 INFO - 'JSGC_DISABLE_POISONING': '1', 05:57:32 INFO - 'LANG': 'en_US.UTF-8', 05:57:32 INFO - 'LANGUAGE': 'en_US:en', 05:57:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:57:32 INFO - 'LOGNAME': 'cltbld', 05:57:32 INFO - 'MAIL': '/var/mail/cltbld', 05:57:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:57:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:57:32 INFO - 'MOZ_CRASHREPORTER': '1', 05:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:57:32 INFO - 'MOZ_NO_REMOTE': '1', 05:57:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:32 INFO - 'NO_EM_RESTART': '1', 05:57:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:32 INFO - 'PWD': '/builds/slave/test', 05:57:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:57:32 INFO - 'RUST_BACKTRACE': 'full', 05:57:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:57:32 INFO - 'SHELL': '/bin/bash', 05:57:32 INFO - 'SHLVL': '1', 05:57:32 INFO - 'STYLO_FORCE_DISABLED': '1', 05:57:32 INFO - 'TERM': 'linux', 05:57:32 INFO - 'TMOUT': '86400', 05:57:32 INFO - 'USER': 'cltbld', 05:57:32 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', 05:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:32 INFO - '_': '/tools/buildbot/bin/python'} 05:57:32 INFO - TEST-INFO | started process 8091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAspkgB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:33 INFO - PID 8091 | 05:57:33 INFO - PID 8091 | (/builds/slave/test/build/application/firefox/firefox:8141): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:57:33 INFO - PID 8091 | 05:57:43 INFO - PID 8091 | RSS: Main: 144990208 05:57:43 INFO - PID 8091 | 06:00:40 INFO - PID 8091 | Cycle 1(1): loaded http://localhost:43675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43675/tests/dromaeo/cssquery-ext.html) 06:00:41 INFO - PID 8091 | RSS: Main: 143286272 06:00:41 INFO - PID 8091 | 06:03:43 INFO - PID 8091 | Cycle 1(1): loaded http://localhost:43675/tests/dromaeo/cssquery-ext.html (next: http://localhost:43675/tests/dromaeo/cssquery-jquery.html) 06:03:43 INFO - PID 8091 | RSS: Main: 144142336 06:03:43 INFO - PID 8091 | 06:06:45 INFO - PID 8091 | Cycle 1(1): loaded http://localhost:43675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43675/tests/dromaeo/cssquery-mootools.html) 06:06:45 INFO - PID 8091 | RSS: Main: 144781312 06:06:45 INFO - PID 8091 | 06:09:47 INFO - PID 8091 | Cycle 1(1): loaded http://localhost:43675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43675/tests/dromaeo/cssquery-prototype.html) 06:09:48 INFO - PID 8091 | RSS: Main: 145309696 06:09:48 INFO - PID 8091 | 06:12:50 INFO - PID 8091 | Cycle 1(1): loaded http://localhost:43675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43675/tests/dromaeo/cssquery-yui.html) 06:12:51 INFO - PID 8091 | RSS: Main: 148262912 06:12:51 INFO - PID 8091 | 06:15:53 INFO - PID 8091 | Cycle 1(1): loaded http://localhost:43675/tests/dromaeo/cssquery-yui.html (next: http://localhost:43675/tests/dromaeo/cssquery-dojo.html) 06:15:53 INFO - PID 8091 | RSS: Main: 149204992 06:15:53 INFO - PID 8091 | 06:15:53 INFO - PID 8091 | __start_tp_report 06:15:53 INFO - PID 8091 | _x_x_mozilla_page_load 06:15:53 INFO - PID 8091 | _x_x_mozilla_page_load_details 06:15:53 INFO - PID 8091 | |i|pagename|runs| 06:15:53 INFO - PID 8091 | |0;dojo.html;3861.498005259316;3888.4167374893764;3901.5513215980172;3905.570387257403;3918.902027449314;6178.783742569011;6199.225096862892;6249;6268.874622507547;6330.588511746733;6223.937760622403;6251.749930002795;6256.906146407808;6259.374062593738;6273.623582585048;5541.889162216753;5676.148577713335;5690.118031705071;5690.715464226792;5713.17159011943;188.6828826310539;5686.630369026021;5708.971455142719;5766.826995190151;5772.595918285721;5605.103183490643;5607.186957891104;5610.18652295419;5687.516561092312;5712.400197979194;5596.2165296858475;5626.352969408529;5691;5694.572907031948;5698.230738850244;5594.720263986785;5608.383077861432;5685;5687.374388817227;5688.544916406678;6193.256809182927;6204.379562043805;6220.844478888019;6266.467350275232;6274.058891166316;6535.607863528156;6662.833429164261;6732.427743641796;6759.594424334507;6824.1128653275255;6815.284395138488;6835.940429233477;6863.862722745567;6868.381845633917;6875.862482750367;6314.336994615591;6335.714892829834;6376;6400.551961362707;6414.358564143595;6987.196472405637;7008.33420825031;7090.042844215965;7096.7516136934955;7103.041089452858;6535.836604084936;6637.336266373421;6640.335966403321;6659.800205993828;6660.666966651648;6803.7958861233255;6819.283975182633;6842.7605033823575;6903.378695917391;6919.619420931897;6772.593644381254;6782.253952065269;6865.862682746317;6874.106366172466;6880.415164711056;6768.661566921634;6789.93210067893;6800.897986530206;6889.655517224119;6891.862162756717;4980.7509624518625;5012.796928737077;5019.146745053276;5028;5065.569426598707;4403.4495688039;4491.842785502492;4491.910161796811;4499;4558.928651766832;6293;6299.811005669837;6362.745490180341;6372.490200783926;6377.7448902044325;6762.932370676231;6820.658967051628;6822.283660215705;6913.75801846933;6919.930800692029;6216.036514340284;6297.433231009231;6299.212598425197;6303.464205542488;6307.747690092437;5516.889662206733;5563.054280772279;5567.3040869891265;5569.832905012856;5581.832545023656;6968.721251149998;7060.435165186773;7123.964380178066;7146.785596432115;7159.67781449836;6705.765298214539;6788.9660551696925;6800.387965083166;6895.862082758417;6899.0341352210735;7008;7049;7093.82265443368;7107.60908150036;7116.537425067354;6705.4635629150525;6773.661316934232;6775.356341147583;6797.660116994031;6805.149356330458;6857.897131542931;6893.7931862044215;6917.066196063467;6938.063361446342;6945.305469453015;6608.43828274602;6632.104665870046;6701.966490167518;6703.698333574904;6704.899426508508;6500.804975850732;6525.673716314261;6575.539712220098;6588.407043365928;6675.59946403198;6505.707243173973;6510.056041873996;6521.804345869631;6531.738730450728;6553.639549824806;6672.399484046459;6728.562643428161;6735.0570920072205;6738.35985581369;6773.491988100814;6487.708053137526;6492.513061520311;6560.40956313934;6567.9671601643595;6579.309172536815 06:15:53 INFO - PID 8091 | |1;ext.html;920.958556864941;965.0638880286123;991.8512223166524;992.2062350119904;1013.1793247469554;44095.55904440954;45054.32418513725;45103.32345014827;45113.77443112784;45122.32316515255;43297;43415.348769768476;43509.56490435095;46480.535194648044;47495;8419.663213471455;8618.56907154643;8619.827603447928;8621.870671939925;8629.95685021574;8375;8442.366822488308;8527.530985795778;8537.701180458685;8538.573071346407;8549.572521373937;8564.186402291803;8567.871481927776;8575.699850505234;8602.18279263469;8436.662533498653;8498.830023399529;8536.658533658678;8551.358648101417;8553.572321383906;8392.832143357098;8431.241188293021;8447.831043379098;8465.873011904827;8496.617652205665;41454;41544.37683434751;41701.1659766806;41939;41982.160356793;3775.8300876460626;3791.3554695701796;3807.733458657895;3813.8855834325013;3815.465834783133;34267.143321416916;34279.657203427894;34380.14049648754;34415.483767743506;34516.82741586276;5248.422673505911;5373.919391209135;5400.513953744143;5450.236966824647;5459.12653975366;228137;228320;228360.99999999834;229053;229216;49371.25943110856;55848;56239;56505;56541;59948.70025649931;59990.400095998484;60035;60071.69964150151;60151.69924150351;14761.261936903113;14981.925090374696;14984.925075374553;15067.547973560811;15127;11771.941140294415;11773.17587768848;11818.172727908965;11822.054235661299;11836.88163118375;14772.926135369255;14860;14879.628009299637;14912.70174596502;15028;5290.444503327172;5389.487998640123;5399.271098401744;5507.504324610804;5527.668339899538;1078.396098185019;1088.5645741703381;1098.1489345756943;1118.457548089176;1119.9048080913215;26398.04725132671;26809;26817.195484135507;26937.461250775268;27004.32489187786;1199.346356235836;1215.5684731920219;1227.864934857165;1228.2078059651474;1230.8953738932112;13922.37349319283;14064.789028164585;14160.575182744535;14245.715085698228;14252.287385630678;298821;301696;302444;302819;303271;59286.70356648189;59392.70303648454;59420.7028964861;59549.70225148933;59585.404145958855;1471.6983018481185;1512.6218445388654;1519.1644595472446;1525.961850953735;1546.6520032992487;25191.24426267215;25443;25467.2359829198;25582.61626075573;25963.350916227246;40579.1884162321;40806;40817;40825.59174408218;40891;252123;252193;252372;252525;253371;38257.4261386085;38350.80824595859;40972.38541421822;41062.79468602638;41190.38214426726;52234.21648675197;53543.46456535385;53622.524209938965;53790.46209537855;53829.46170538245;37394;37760.62239377571;38258.426123608726;38312.80843595764;38422.80788596151;37605;37748;37919.241615168095;38132.80933595314;38222.80888595539;43402;44511.33233001572;44921.10157796891;45042.32436513389;45236.32145517754;36026.4596031065;36145.63854361528;36271;36603.450948235266;36864.44703329399;27064.32339191536;27215.319617009733;27231.59152612673;27322.45355092927;27449.725502745518 06:15:53 INFO - PID 8091 | |2;jquery.html;614.8195464707758;630.1870586942844;633.6989929783356;641.9390157934995;652.6247407740549;22705.77294227057;23104.65343019852;23475.530489390225;23610;23800.523989520243;25738.742612573868;26921.32696682584;26959.86520067402;26982.86508567459;26992.190234292953;6478.384553467413;6635.33646635335;6635.734570617169;6644.634545100018;6668.166479190101;6546.443552298037;6629.900551491732;6818.045473633695;6842.897356539655;6851.931480685204;6760.42536384408;6806.353396427331;6807.217170025436;6810.523263371566;6816.045753594501;6662.733490660392;6779.932200677979;6783.559068660521;6942.51402401827;6951.304869513059;6496.642684652342;6499.772507962246;6501.739930402779;6502.252240992299;6503.122078519386;30492;30554.84722576395;30767;30774.076777696482;30962.53556196659;2319.768023197667;2340.648902664597;2345.7067866516686;2348.3189874936247;2353.1175809071597;19980.800191998038;21333.35999920005;21508.46228844276;21524.56950860974;21543.353699389045;2534.6451496790464;2589.1714651311586;2603.0628973569687;2667.6265322854815;2669.879855406492;139712;145898;164041;171470.1426492872;172966.1351693246;16114.355425783071;16228.59428514273;16694;16878.071706056286;17072.402465913634;27187.45625087487;27320;27417;27423.725762742117;27450.862745686143;9996.350237234556;10155.64455244063;10185.08334249921;10416.739581510523;10549.789004219872;8941.418807777474;8998.30050984702;9030.63877444895;9031.36780425364;9199.908000920039;9924.305298629171;10180.134688551409;10223.28437009417;10296.948515257525;10301.639442619473;3069.769767267464;3072.293372524332;3073.1087984484247;3107.4717298059386;3172.2069482629345;1034.270839058462;1037.5071840875676;1043.7129789308;1045.2004216774174;1049.150188347441;21318.78681213199;21699.891500542395;21715.674264886038;21737.565248694937;22286.55426891453;1061.5223149582719;1082.8213344798178;1098.5331234225582;1103.45379037377;1107.501624269066;11686.415679216005;11759.941605255568;11780.057595392347;11803.291802491705;11905.821412678817;605336;613733;624040;627783;638584;135481.3225933864;135868;137731;137883;140258;1147.17976646698;1297.228149251213;1340.786588137737;1363.5500284905957;1364.774812156003;22710.65934010958;22953.770462295164;22979;23075.423114422272;23151.76848231496;66715;67023;67068.32931670621;67507.32492675207;67733.66133169303;84937;87759.12240877765;87772.5611371939;88358.55820720855;88708;21805.345839624835;22013.339599812032;22119.557608848056;22159.22442714497;22214.44463888351;24252;24639.38401539976;24841.130560430298;24851.62722559127;24879.50240995134;19786.901065495156;19911.701324479855;20040.699389508878;20398.490037749176;20468;17105.657886842444;17514.73727894057;17621.64756704833;17932.820671793637;18466.261349546407;19272.518187044876;19893.403197904085;19927.900360498104;20142.697859531825;20370.59258814845;21336.786632134103;21408.14367425348;21435;21542.784572154706;21566;19356.8064319355;19683.70474442856;19730.704039439133;19771.209151633775;19919.302824401075 06:15:53 INFO - PID 8091 | |3;mootools.html;1395.4627468424658;1505.104462844607;1511.0782422722145;1519.1948267418265;1528.2206074901796;16781.580460488494;17415;17418.129093545318;17434.738478922827;17452;17067.146642667878;17166;17204.655906881853;17231.396901108434;17261.30954761811;2812.5921741347493;2912.0972498525525;2934.8826046958097;2936.1485169300877;2939.76481881449;2844.132539575429;2869.5839103330004;2897.6088228089257;2897.797154199207;2902.666193387756;2787.2474431903374;2790.2326860113426;2837.4750671125803;2846.1888361816887;2847.103162503815;2671.8530480823547;2690.1391554702504;2712.389712314733;2721.4285000149894;2742.561190209577;2700.270921880037;2716.769074628659;2720.265528307366;2726.577380506025;2727.1818454463582;16885.15574221284;17301.567460813454;17307.480775576754;17316.653666926715;17325.480235592953;8512.276456501204;8787.428817126865;8790.912090879137;8792.42849214799;8800.295976321879;5509.338879334466;5730.512906402961;5732.627379220337;5824.621399609012;5864.882702345972;2068.9379318620468;2077.4079387374527;2092.4141240452695;2100.6953991671276;2175.9020844062056;27854.442911141865;28844.711552884623;30593.694063059305;31111.688883111106;31886.999999999767;7482.438817088631;7499.325060744559;7558.773236802905;7652.081750190013;7726.690932362642;20278.391648250577;20414.38756837297;20511;20515;20520.794792052187;8557.187067228604;8636.697715579925;8648.78378040554;8706.95646521776;8708.564571771512;7765.922340776633;7835.49069310493;7875.724349647735;7984.960075199587;7995.360371170293;5698.17376480408;5825.912611310834;5871.3541510433815;5935.347111817697;5935.52515798735;1694.74578813179;1716.9828301717073;1734.4883259438495;1739.5911960689227;1749.3964582219114;986.2455221755363;996.8056229035268;1003.0972125087479;1004.7387679203459;1025.6153942271649;8759;8776.912230877737;8783.736487905373;8807.559622019002;8951.373403861668;785.0500893918309;795.8448102620049;797.6211299632744;799.1010113622175;801.4389927051087;5797.565182611321;5990.700464976734;6029.728662210211;6061.181740465069;6131.50947924165;24184.75815241825;25721;25783.742162578135;25820.612690809652;25948.35129121787;24188.516229675308;24620.87689561541;25314;25627.103051393486;25726.742732572435;10715.785684286271;11445.25605835618;11642.88357116435;12530.68673283157;12839.550615728405;9572.138507534355;9799.167070799062;9834.950825245827;10242.795144096926;10301.021402967006;20943.266985655428;21473.570528589655;21521;21558.568828623025;21742;21856.562868742854;22066.33800985973;22092.558148837255;22260.554788904454;22333.888330558242;13369.598912032654;13508;13633.454661813814;13728.93135534316;13733.862661373258;14652.487162949246;14853.331600077807;14884;14912.62718432048;14962;12544.686382840502;12690.555830545887;12717.300548469922;12831.550895718605;12905.967522597983;11403.916627920335;11784.58753943608;11819.822702659296;11867.228630139014;12158;10666.466676665981;10709.678709638723;10763;10792.892071079188;10808.18938579594;7793.869888866196;7822.256885595859;7845.097813751263;7918.485298455582;7945.0863150738405;8383.413161078666;8446.366522510714;8472.957635211784;8500.149985001697;8551.57242137903 06:15:53 INFO - PID 8091 | |4;prototype.html;552.2930648769576;567.6565677764952;573.6615396915819;587.1779508687837;592.496378078633;6112.69436528174;6112.7860524881635;6166.722497487613;6181.412765787249;6242;6089.573729838913;6096.969515152429;6097.146399504073;6156.245470041039;6186.133941248228;5029.245613158019;5031.4465408805;5051.823186188484;5086.364204474441;5093.923591146136;4858.392700912386;4944.505549445063;5004.274380214867;5029.094762942669;5050.368703912011;4950.405951285851;4968.40379154502;4976.303317535548;4988.950110498885;5007.4491805901325;4924.571874156491;4936.925946110811;4937.456879743226;4961.90076198474;4984.576311013569;4444.28894875472;4535.365048893158;4539.387182730322;4544.250198717207;4554.203014472454;5946.375630558772;5994.940050599482;6017.969910150465;6037.849053773691;6072.666003369813;5834.687195381048;5844.970775146097;5848.093545500455;5857.648541087548;5884;6561.3438656134485;6616.139901812733;6619.768308109241;6635.13743213384;6664.333566643345;4918.458969513351;5062.316587260746;5109.948900511022;5115.130427827278;5129.84610461683;6656.334366563305;6715.865682686368;6722.731090756364;6814.352636499475;6861.931380686179;5241.816536421207;5259.763955470461;5265.447128051499;5270.710110943858;5289.233061206103;5300.390455097636;5321.255024296602;5322.308099947059;5351.705656188947;5370.2750128732905;5866.178734977107;5885.911711324334;5896.172186622161;5896.469317761422;5906.3207731110615;6521.217453905467;6544.476441884638;6550.901736473957;6554.442872355808;6600.141981542369;1809.4933418642802;1843.8156184381724;1850.1859181959894;1860.4604664647372;1864.14249445254;1273;1314.141741711773;1321.0950498908087;1346.0779366134034;1348.7369962857344;5863.853403664943;5946.167536544887;5968.1942937703725;5997;6145.20112385396;6512.934870651327;6520.934790652128;6595.571287866273;6596.637184954778;6689.531732778659;6083.6349819011;6145.293291271471;6163.476104531165;6186.536009799193;6218;3485.7734247273847;3496.283261931298;3502.141975216088;3517.771344862576;3558.466230065511;6775.559588626724;6840.48696347766;6882.380585747307;6940.9652951734915;6944.340287672663;6804.65976701163;6821.863562728718;6867.527690031585;6884.208316043619;6928.549644273106;6703.363180497748;6809.31906809325;6833.794986150423;6845.973104034335;6985.580865148006;6483.935160648333;6504.902426463702;6553.886903720885;6602.636854973022;6691.46468282546;6474.223093228843;6512.967435162794;6520.934790652223;6561.179852518435;6603.966980165068;6786.287439818748;6841.863162736817;6845;6888.518968421813;6914.471021480938;5196.220566914993;5200.323957885451;5254.632175747814;5259.868503287448;5261.158214685632;6684.565503242274;6768.627725475146;6803.4557235422035;6809.897851532132;6830.556013859084;6373.132090559359;6377.8724425512155;6555.967220163869;6577.276499585138;6597.967010164918;6355.396237357444;6357.300696923242;6397.296297407189;6434.549581529248;6474.5791523550815;6182.969085154546;6249.218847644044;6341.270753863365;6436.774712885027;6456.451201647913;6500.252470965899;6550.934490655223;6572.572782769296;6626.768063117768;6649.202095748541;6097.512199024156;6271.843203919939;6272.341404152498;6292.307846137013;6366.204224471941 06:15:53 INFO - PID 8091 | |5;yui.html;972.3096601412992;1001.8897921228665;1008.848672699095;1024.748936510555;1037.9464843184167;18470.90764546177;18699.71950420743;18843.905780471097;20810.89594552029;21461.463463413424;18301.084945752693;18315.54211144722;18318.450446486593;18375.173117209724;18471.630567388645;1076.0960792933934;1086.7283179205199;1088.755030118225;1089.319175515303;1092.049916572583;1068.2415485005656;1072.3458690198972;1073.7637719701654;1074.4466599701161;1083.5286650307103;1101.3557069114538;1139.1740987783833;1141.2182654881433;1142.857142857143;1142.959996400126;1125.5329038449033;1128.2722643894642;1134.9262297950606;1136.8806275341094;1138.5275110828995;829.4691397505601;829.7676650537859;834.9165083491663;836.3142223376833;836.6109758962051;19061.904690476596;20758.169673213055;20810.47973800652;20859.687104693443;20953.37139885806;23393.53212935749;23613.881930590236;24411.145609903746;24443.511129777304;24467.63298550523;18498.722519162224;18539.35112271064;18806.153723082494;18806.90596547022;18810.435686929413;3880.961190388088;3907.374820028782;3919.098607320332;3928.6464218220212;3934.213157368509;120431;120487;161489;165764;165907;18429.53926151857;18662;18700.438986830417;18745.7188142178;18989.810101898805;35359;35564.28871422557;36222.45666315007;36663.26673466516;37013.074673133386;10050.547725352377;10060.446675432922;10100.848487272697;10114.797704046025;10163.9491802542;4722.5513576210205;4776.259679749644;4813.229883218738;4871.732054736953;4878.463369029404;6012.669303188367;6133.907991380132;6140.017597184429;6140.17107690456;6156.322804491502;1189.4047506576057;1209.1113031921532;1227.459917636255;1228.2323547782637;1231.9815202771965;747.8167848876951;748.8839229919371;757.1293013034943;767.9040119985002;772.042667092812;12585.87414125847;12857.742845143232;12988;13842.584722458343;13862.584122476343;733.8385555177853;739.6893304811884;741.7700512841036;744.4639859301294;761.6458346868733;6180.289266734293;6200.782972595937;6256.405641464054;6280.434760871543;6283.120363149163;163990;164374;164688;167535.1623241876;170373;135531;139719;139975;142484;144979;119727;121347;122013;122517;124777;11632.127590430582;11859.110566707704;11882.049436045269;11943.293565616801;12032.157748957488;56022.43977560335;56416.15375769449;56533;57091.429085710275;57591.136132958876;71799.64100179466;72007.63996179985;73277.6336118316;74142.62928685322;74999;16643.50069497917;16746.748798767785;16789.32842686279;16803.579910502336;16930.83069169342;18409.723854141932;18494.63010739751;18704.53238669044;18719.06404679733;18765.437036888914;16681.666366672842;16748.078855663054;16783.160841957608;16837.073960932266;16968.66062678764;15945.920270398574;16040.679186415973;16209;16319.347226111298;16369.918150409172;16066.67866642684;16180.67638647244;16252.349906004101;16267.755983660018;16271.349146034026;12628.242305461701;12657.556985505464;12748.936255318664;12800.61598152057;12936.029797765394;12809.295488747835;12863.035272354424;12868.806967895676;12887.42006609686;12928.159669621444 06:15:53 INFO - PID 8091 | __end_tp_report 06:15:53 INFO - PID 8091 | __start_cc_report 06:15:53 INFO - PID 8091 | _x_x_mozilla_cycle_collect,276 06:15:53 INFO - PID 8091 | __end_cc_report 06:15:53 INFO - PID 8091 | __startTimestamp1506690953246__endTimestamp 06:15:53 INFO - PID 8091 | 06:15:53 INFO - PID 8091 | ------- Summary: start ------- 06:15:53 INFO - PID 8091 | Number of tests: 6 06:15:53 INFO - PID 8091 | 06:15:53 INFO - PID 8091 | [#0] dojo.html Cycles:165 Average:6249.84 Median:6531.74 stddev:882.70 (13.5%) stddev-sans-first:865.30 06:15:53 INFO - PID 8091 | Values: 3861.5 3888.4 3901.6 3905.6 3918.9 6178.8 6199.2 6249.0 6268.9 6330.6 6223.9 6251.7 6256.9 6259.4 6273.6 5541.9 5676.1 5690.1 5690.7 5713.2 188.7 5686.6 5709.0 5766.8 5772.6 5605.1 5607.2 5610.2 5687.5 5712.4 5596.2 5626.4 5691.0 5694.6 5698.2 5594.7 5608.4 5685.0 5687.4 5688.5 6193.3 6204.4 6220.8 6266.5 6274.1 6535.6 6662.8 6732.4 6759.6 6824.1 6815.3 6835.9 6863.9 6868.4 6875.9 6314.3 6335.7 6376.0 6400.6 6414.4 6987.2 7008.3 7090.0 7096.8 7103.0 6535.8 6637.3 6640.3 6659.8 6660.7 6803.8 6819.3 6842.8 6903.4 6919.6 6772.6 6782.3 6865.9 6874.1 6880.4 6768.7 6789.9 6800.9 6889.7 6891.9 4980.8 5012.8 5019.1 5028.0 5065.6 4403.4 4491.8 4491.9 4499.0 4558.9 6293.0 6299.8 6362.7 6372.5 6377.7 6762.9 6820.7 6822.3 6913.8 6919.9 6216.0 6297.4 6299.2 6303.5 6307.7 5516.9 5563.1 5567.3 5569.8 5581.8 6968.7 7060.4 7124.0 7146.8 7159.7 6705.8 6789.0 6800.4 6895.9 6899.0 7008.0 7049.0 7093.8 7107.6 7116.5 6705.5 6773.7 6775.4 6797.7 6805.1 6857.9 6893.8 6917.1 6938.1 6945.3 6608.4 6632.1 6702.0 6703.7 6704.9 6500.8 6525.7 6575.5 6588.4 6675.6 6505.7 6510.1 6521.8 6531.7 6553.6 6672.4 6728.6 6735.1 6738.4 6773.5 6487.7 6492.5 6560.4 6568.0 6579.3 06:15:53 INFO - PID 8091 | 06:15:53 INFO - PID 8091 | [#1] ext.html Cycles:180 Average:44769.21 Median:38331.81 stddev:68449.76 (178.6%) stddev-sans-first:68562.60 06:15:53 INFO - PID 8091 | Values: 921.0 965.1 991.9 992.2 1013.2 44095.6 45054.3 45103.3 45113.8 45122.3 43297.0 43415.3 43509.6 46480.5 47495.0 8419.7 8618.6 8619.8 8621.9 8630.0 8375.0 8442.4 8527.5 8537.7 8538.6 8549.6 8564.2 8567.9 8575.7 8602.2 8436.7 8498.8 8536.7 8551.4 8553.6 8392.8 8431.2 8447.8 8465.9 8496.6 41454.0 41544.4 41701.2 41939.0 41982.2 3775.8 3791.4 3807.7 3813.9 3815.5 34267.1 34279.7 34380.1 34415.5 34516.8 5248.4 5373.9 5400.5 5450.2 5459.1 228137.0 228320.0 228361.0 229053.0 229216.0 49371.3 55848.0 56239.0 56505.0 56541.0 59948.7 59990.4 60035.0 60071.7 60151.7 14761.3 14981.9 14984.9 15067.5 15127.0 11771.9 11773.2 11818.2 11822.1 11836.9 14772.9 14860.0 14879.6 14912.7 15028.0 5290.4 5389.5 5399.3 5507.5 5527.7 1078.4 1088.6 1098.1 1118.5 1119.9 26398.0 26809.0 26817.2 26937.5 27004.3 1199.3 1215.6 1227.9 1228.2 1230.9 13922.4 14064.8 14160.6 14245.7 14252.3 298821.0 301696.0 302444.0 302819.0 303271.0 59286.7 59392.7 59420.7 59549.7 59585.4 1471.7 1512.6 1519.2 1526.0 1546.7 25191.2 25443.0 25467.2 25582.6 25963.4 40579.2 40806.0 40817.0 40825.6 40891.0 252123.0 252193.0 252372.0 252525.0 253371.0 38257.4 38350.8 40972.4 41062.8 41190.4 52234.2 53543.5 53622.5 53790.5 53829.5 37394.0 37760.6 38258.4 38312.8 38422.8 37605.0 37748.0 37919.2 38132.8 38222.8 43402.0 44511.3 44921.1 45042.3 45236.3 36026.5 36145.6 36271.0 36603.5 36864.4 27064.3 27215.3 27231.6 27322.5 27449.7 06:15:53 INFO - PID 8091 | 06:15:53 INFO - PID 8091 | [#2] jquery.html Cycles:180 Average:41556.97 Median:2330.21 stddev:104321.30 (4476.9%) stddev-sans-first:104568.66 06:15:53 INFO - PID 8091 | Values: 614.8 630.2 633.7 641.9 652.6 22705.8 23104.7 23475.5 23610.0 23800.5 25738.7 26921.3 26959.9 26982.9 26992.2 6478.4 6635.3 6635.7 6644.6 6668.2 6546.4 6629.9 6818.0 6842.9 6851.9 6760.4 6806.4 6807.2 6810.5 6816.0 6662.7 6779.9 6783.6 6942.5 6951.3 6496.6 6499.8 6501.7 6502.3 6503.1 30492.0 30554.8 30767.0 30774.1 30962.5 2319.8 2340.6 2345.7 2348.3 2353.1 19980.8 21333.4 21508.5 21524.6 21543.4 2534.6 2589.2 2603.1 2667.6 2669.9 139712.0 145898.0 164041.0 171470.1 172966.1 16114.4 16228.6 16694.0 16878.1 17072.4 27187.5 27320.0 27417.0 27423.7 27450.9 9996.4 10155.6 10185.1 10416.7 10549.8 8941.4 8998.3 9030.6 9031.4 9199.9 9924.3 10180.1 10223.3 10296.9 10301.6 3069.8 3072.3 3073.1 3107.5 3172.2 1034.3 1037.5 1043.7 1045.2 1049.2 21318.8 21699.9 21715.7 21737.6 22286.6 1061.5 1082.8 1098.5 1103.5 1107.5 11686.4 11759.9 11780.1 11803.3 11905.8 605336.0 613733.0 624040.0 627783.0 638584.0 135481.3 135868.0 137731.0 137883.0 140258.0 1147.2 1297.2 1340.8 1363.6 1364.8 22710.7 22953.8 22979.0 23075.4 23151.8 66715.0 67023.0 67068.3 67507.3 67733.7 84937.0 87759.1 87772.6 88358.6 88708.0 21805.3 22013.3 22119.6 22159.2 22214.4 24252.0 24639.4 24841.1 24851.6 24879.5 19786.9 19911.7 20040.7 20398.5 20468.0 17105.7 17514.7 17621.6 17932.8 18466.3 19272.5 19893.4 19927.9 20142.7 20370.6 21336.8 21408.1 21435.0 21542.8 21566.0 19356.8 19683.7 19730.7 19771.2 19919.3 06:15:53 INFO - PID 8091 | 06:15:53 INFO - PID 8091 | [#3] mootools.html Cycles:180 Average:10518.42 Median:2681.00 stddev:7769.40 (289.8%) stddev-sans-first:7760.96 06:15:53 INFO - PID 8091 | Values: 1395.5 1505.1 1511.1 1519.2 1528.2 16781.6 17415.0 17418.1 17434.7 17452.0 17067.1 17166.0 17204.7 17231.4 17261.3 2812.6 2912.1 2934.9 2936.1 2939.8 2844.1 2869.6 2897.6 2897.8 2902.7 2787.2 2790.2 2837.5 2846.2 2847.1 2671.9 2690.1 2712.4 2721.4 2742.6 2700.3 2716.8 2720.3 2726.6 2727.2 16885.2 17301.6 17307.5 17316.7 17325.5 8512.3 8787.4 8790.9 8792.4 8800.3 5509.3 5730.5 5732.6 5824.6 5864.9 2068.9 2077.4 2092.4 2100.7 2175.9 27854.4 28844.7 30593.7 31111.7 31887.0 7482.4 7499.3 7558.8 7652.1 7726.7 20278.4 20414.4 20511.0 20515.0 20520.8 8557.2 8636.7 8648.8 8707.0 8708.6 7765.9 7835.5 7875.7 7985.0 7995.4 5698.2 5825.9 5871.4 5935.3 5935.5 1694.7 1717.0 1734.5 1739.6 1749.4 986.2 996.8 1003.1 1004.7 1025.6 8759.0 8776.9 8783.7 8807.6 8951.4 785.1 795.8 797.6 799.1 801.4 5797.6 5990.7 6029.7 6061.2 6131.5 24184.8 25721.0 25783.7 25820.6 25948.4 24188.5 24620.9 25314.0 25627.1 25726.7 10715.8 11445.3 11642.9 12530.7 12839.6 9572.1 9799.2 9835.0 10242.8 10301.0 20943.3 21473.6 21521.0 21558.6 21742.0 21856.6 22066.3 22092.6 22260.6 22333.9 13369.6 13508.0 13633.5 13728.9 13733.9 14652.5 14853.3 14884.0 14912.6 14962.0 12544.7 12690.6 12717.3 12831.6 12906.0 11403.9 11784.6 11819.8 11867.2 12158.0 10666.5 10709.7 10763.0 10792.9 10808.2 7793.9 7822.3 7845.1 7918.5 7945.1 8383.4 8446.4 8473.0 8500.1 8551.6 06:15:53 INFO - PID 8091 | 06:15:53 INFO - PID 8091 | [#4] prototype.html Cycles:180 Average:5575.69 Median:6128.99 stddev:1530.75 (25.0%) stddev-sans-first:1487.88 06:15:53 INFO - PID 8091 | Values: 552.3 567.7 573.7 587.2 592.5 6112.7 6112.8 6166.7 6181.4 6242.0 6089.6 6097.0 6097.1 6156.2 6186.1 5029.2 5031.4 5051.8 5086.4 5093.9 4858.4 4944.5 5004.3 5029.1 5050.4 4950.4 4968.4 4976.3 4989.0 5007.4 4924.6 4936.9 4937.5 4961.9 4984.6 4444.3 4535.4 4539.4 4544.3 4554.2 5946.4 5994.9 6018.0 6037.8 6072.7 5834.7 5845.0 5848.1 5857.6 5884.0 6561.3 6616.1 6619.8 6635.1 6664.3 4918.5 5062.3 5109.9 5115.1 5129.8 6656.3 6715.9 6722.7 6814.4 6861.9 5241.8 5259.8 5265.4 5270.7 5289.2 5300.4 5321.3 5322.3 5351.7 5370.3 5866.2 5885.9 5896.2 5896.5 5906.3 6521.2 6544.5 6550.9 6554.4 6600.1 1809.5 1843.8 1850.2 1860.5 1864.1 1273.0 1314.1 1321.1 1346.1 1348.7 5863.9 5946.2 5968.2 5997.0 6145.2 6512.9 6520.9 6595.6 6596.6 6689.5 6083.6 6145.3 6163.5 6186.5 6218.0 3485.8 3496.3 3502.1 3517.8 3558.5 6775.6 6840.5 6882.4 6941.0 6944.3 6804.7 6821.9 6867.5 6884.2 6928.5 6703.4 6809.3 6833.8 6846.0 6985.6 6483.9 6504.9 6553.9 6602.6 6691.5 6474.2 6513.0 6520.9 6561.2 6604.0 6786.3 6841.9 6845.0 6888.5 6914.5 5196.2 5200.3 5254.6 5259.9 5261.2 6684.6 6768.6 6803.5 6809.9 6830.6 6373.1 6377.9 6556.0 6577.3 6598.0 6355.4 6357.3 6397.3 6434.5 6474.6 6183.0 6249.2 6341.3 6436.8 6456.5 6500.3 6550.9 6572.6 6626.8 6649.2 6097.5 6271.8 6272.3 6292.3 6366.2 06:15:53 INFO - PID 8091 | 06:15:53 INFO - PID 8091 | [#5] yui.html Cycles:180 Average:28811.46 Median:16883.95 stddev:43918.27 (260.1%) stddev-sans-first:43991.73 06:15:53 INFO - PID 8091 | Values: 972.3 1001.9 1008.8 1024.7 1037.9 18470.9 18699.7 18843.9 20810.9 21461.5 18301.1 18315.5 18318.5 18375.2 18471.6 1076.1 1086.7 1088.8 1089.3 1092.0 1068.2 1072.3 1073.8 1074.4 1083.5 1101.4 1139.2 1141.2 1142.9 1143.0 1125.5 1128.3 1134.9 1136.9 1138.5 829.5 829.8 834.9 836.3 836.6 19061.9 20758.2 20810.5 20859.7 20953.4 23393.5 23613.9 24411.1 24443.5 24467.6 18498.7 18539.4 18806.2 18806.9 18810.4 3881.0 3907.4 3919.1 3928.6 3934.2 120431.0 120487.0 161489.0 165764.0 165907.0 18429.5 18662.0 18700.4 18745.7 18989.8 35359.0 35564.3 36222.5 36663.3 37013.1 10050.5 10060.4 10100.8 10114.8 10163.9 4722.6 4776.3 4813.2 4871.7 4878.5 6012.7 6133.9 6140.0 6140.2 6156.3 1189.4 1209.1 1227.5 1228.2 1232.0 747.8 748.9 757.1 767.9 772.0 12585.9 12857.7 12988.0 13842.6 13862.6 733.8 739.7 741.8 744.5 761.6 6180.3 6200.8 6256.4 6280.4 6283.1 163990.0 164374.0 164688.0 167535.2 170373.0 135531.0 139719.0 139975.0 142484.0 144979.0 119727.0 121347.0 122013.0 122517.0 124777.0 11632.1 11859.1 11882.0 11943.3 12032.2 56022.4 56416.2 56533.0 57091.4 57591.1 71799.6 72007.6 73277.6 74142.6 74999.0 16643.5 16746.7 16789.3 16803.6 16930.8 18409.7 18494.6 18704.5 18719.1 18765.4 16681.7 16748.1 16783.2 16837.1 16968.7 15945.9 16040.7 16209.0 16319.3 16369.9 16066.7 16180.7 16252.3 16267.8 16271.3 12628.2 12657.6 12748.9 12800.6 12936.0 12809.3 12863.0 12868.8 12887.4 12928.2 06:15:53 INFO - PID 8091 | -------- Summary: end -------- 06:15:53 INFO - PID 8091 | 06:15:53 INFO - TEST-INFO | 8091: exit 0 06:15:53 INFO - TEST-OK | dromaeo_css | took 1107276ms 06:15:53 INFO - TEST-START | kraken 06:15:53 INFO - Initialising browser for kraken test... 06:15:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43675/getInfo.html -profile /tmp/tmpv7jqKJ/profile 06:15:53 INFO - TEST-INFO | started process 8451 (/builds/slave/test/build/application/firefox/firefox http://localhost:43675/getInfo.html) 06:15:59 INFO - TEST-INFO | 8451: exit 0 06:15:59 INFO - Browser initialized. 06:15:59 INFO - Running cycle 1/1 for kraken test... 06:15:59 INFO - Using env: {'DISPLAY': ':0', 06:15:59 INFO - 'HOME': '/home/cltbld', 06:15:59 INFO - 'JSGC_DISABLE_POISONING': '1', 06:15:59 INFO - 'LANG': 'en_US.UTF-8', 06:15:59 INFO - 'LANGUAGE': 'en_US:en', 06:15:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:15:59 INFO - 'LOGNAME': 'cltbld', 06:15:59 INFO - 'MAIL': '/var/mail/cltbld', 06:15:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:15:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:15:59 INFO - 'MOZ_CRASHREPORTER': '1', 06:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:15:59 INFO - 'MOZ_NO_REMOTE': '1', 06:15:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:59 INFO - 'NO_EM_RESTART': '1', 06:15:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:59 INFO - 'PWD': '/builds/slave/test', 06:15:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:15:59 INFO - 'RUST_BACKTRACE': 'full', 06:15:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:15:59 INFO - 'SHELL': '/bin/bash', 06:15:59 INFO - 'SHLVL': '1', 06:15:59 INFO - 'STYLO_FORCE_DISABLED': '1', 06:15:59 INFO - 'TERM': 'linux', 06:15:59 INFO - 'TMOUT': '86400', 06:15:59 INFO - 'USER': 'cltbld', 06:15:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234', 06:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:59 INFO - '_': '/tools/buildbot/bin/python'} 06:15:59 INFO - TEST-INFO | started process 8690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv7jqKJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:00 INFO - PID 8690 | 06:16:00 INFO - PID 8690 | (/builds/slave/test/build/application/firefox/firefox:8740): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:16:00 INFO - PID 8690 | 06:16:10 INFO - PID 8690 | RSS: Main: 144826368 06:16:10 INFO - PID 8690 | 06:16:12 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43675/tests/kraken/driver.html?testName=audio-beat-detection) 06:16:13 INFO - PID 8690 | RSS: Main: 150900736 06:16:13 INFO - PID 8690 | 06:16:16 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43675/tests/kraken/driver.html?testName=audio-dft) 06:16:16 INFO - PID 8690 | RSS: Main: 151216128 06:16:16 INFO - PID 8690 | 06:16:19 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43675/tests/kraken/driver.html?testName=audio-fft) 06:16:20 INFO - PID 8690 | RSS: Main: 147697664 06:16:20 INFO - PID 8690 | 06:16:22 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43675/tests/kraken/driver.html?testName=audio-oscillator) 06:16:23 INFO - PID 8690 | RSS: Main: 148889600 06:16:23 INFO - PID 8690 | 06:16:25 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:16:25 INFO - PID 8690 | RSS: Main: 148807680 06:16:25 INFO - PID 8690 | 06:16:28 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43675/tests/kraken/driver.html?testName=imaging-darkroom) 06:16:29 INFO - PID 8690 | RSS: Main: 148684800 06:16:29 INFO - PID 8690 | 06:16:33 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43675/tests/kraken/driver.html?testName=imaging-desaturate) 06:16:33 INFO - PID 8690 | RSS: Main: 150544384 06:16:33 INFO - PID 8690 | 06:16:36 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43675/tests/kraken/driver.html?testName=json-parse-financial) 06:16:37 INFO - PID 8690 | RSS: Main: 151433216 06:16:37 INFO - PID 8690 | 06:16:38 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:16:39 INFO - PID 8690 | RSS: Main: 151617536 06:16:39 INFO - PID 8690 | 06:16:40 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:16:41 INFO - PID 8690 | RSS: Main: 152002560 06:16:41 INFO - PID 8690 | 06:16:43 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:16:44 INFO - PID 8690 | RSS: Main: 149135360 06:16:44 INFO - PID 8690 | 06:16:46 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:16:47 INFO - PID 8690 | RSS: Main: 149331968 06:16:47 INFO - PID 8690 | 06:16:49 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:16:50 INFO - PID 8690 | RSS: Main: 149520384 06:16:50 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43675/tests/kraken/driver.html?testName=ai-astar) 06:16:52 INFO - PID 8690 | RSS: Main: 151023616 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | __start_tp_report 06:16:52 INFO - PID 8690 | _x_x_mozilla_page_load 06:16:52 INFO - PID 8690 | _x_x_mozilla_page_load_details 06:16:52 INFO - PID 8690 | |i|pagename|runs| 06:16:52 INFO - PID 8690 | |0;ai-astar;106;105;105;107;105;107;108;107;105;104 06:16:52 INFO - PID 8690 | |1;audio-beat-detection;115;111;113;113;111;111;111;113;112;116 06:16:52 INFO - PID 8690 | |2;audio-dft;163;163;163;164;164;164;164;162;163;174 06:16:52 INFO - PID 8690 | |3;audio-fft;74;73;74;76;73;75;73;74;73;74 06:16:52 INFO - PID 8690 | |4;audio-oscillator;78;80;79;77;79;78;78;82;79;79 06:16:52 INFO - PID 8690 | |5;imaging-gaussian-blur;113;112;111;111;112;113;118;113;118;112 06:16:52 INFO - PID 8690 | |6;imaging-darkroom;149;149;150;152;149;149;153;152;150;151 06:16:52 INFO - PID 8690 | |7;imaging-desaturate;95;95;94;99;94;94;94;95;95;94 06:16:52 INFO - PID 8690 | |8;json-parse-financial;44;49;46;44;47;45;45;43;44;44 06:16:52 INFO - PID 8690 | |9;json-stringify-tinderbox;36;37;36;37;37;37;37;36;36;36 06:16:52 INFO - PID 8690 | |10;stanford-crypto-aes;71;70;73;75;73;71;73;78;73;73 06:16:52 INFO - PID 8690 | |11;stanford-crypto-ccm;105;106;112;109;104;105;110;103;102;103 06:16:52 INFO - PID 8690 | |12;stanford-crypto-pbkdf2;152;146;151;148;149;145;148;153;149;151 06:16:52 INFO - PID 8690 | |13;stanford-crypto-sha256-iterative;59;57;59;61;62;61;60;61;57;64 06:16:52 INFO - PID 8690 | __end_tp_report 06:16:52 INFO - PID 8690 | __start_cc_report 06:16:52 INFO - PID 8690 | _x_x_mozilla_cycle_collect,739 06:16:52 INFO - PID 8690 | __end_cc_report 06:16:52 INFO - PID 8690 | __startTimestamp1506691012279__endTimestamp 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | ------- Summary: start ------- 06:16:52 INFO - PID 8690 | Number of tests: 14 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#0] ai-astar Cycles:10 Average:105.90 Median:106.50 stddev:1.29 (1.2%) stddev-sans-first:1.36 06:16:52 INFO - PID 8690 | Values: 106.0 105.0 105.0 107.0 105.0 107.0 108.0 107.0 105.0 104.0 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#1] audio-beat-detection Cycles:10 Average:112.60 Median:113.00 stddev:1.78 (1.6%) stddev-sans-first:1.66 06:16:52 INFO - PID 8690 | Values: 115.0 111.0 113.0 113.0 111.0 111.0 111.0 113.0 112.0 116.0 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.44 (2.1%) stddev-sans-first:3.61 06:16:52 INFO - PID 8690 | Values: 163.0 163.0 163.0 164.0 164.0 164.0 164.0 162.0 163.0 174.0 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#3] audio-fft Cycles:10 Average:73.90 Median:74.00 stddev:0.99 (1.3%) stddev-sans-first:1.05 06:16:52 INFO - PID 8690 | Values: 74.0 73.0 74.0 76.0 73.0 75.0 73.0 74.0 73.0 74.0 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:79.00 stddev:1.37 (1.7%) stddev-sans-first:1.41 06:16:52 INFO - PID 8690 | Values: 78.0 80.0 79.0 77.0 79.0 78.0 78.0 82.0 79.0 79.0 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:2.58 (2.3%) stddev-sans-first:2.74 06:16:52 INFO - PID 8690 | Values: 113.0 112.0 111.0 111.0 112.0 113.0 118.0 113.0 118.0 112.0 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:1.51 (1.0%) stddev-sans-first:1.51 06:16:52 INFO - PID 8690 | Values: 149.0 149.0 150.0 152.0 149.0 149.0 153.0 152.0 150.0 151.0 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:1.52 (1.6%) stddev-sans-first:1.62 06:16:52 INFO - PID 8690 | Values: 95.0 95.0 94.0 99.0 94.0 94.0 94.0 95.0 95.0 94.0 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#8] json-parse-financial Cycles:10 Average:45.10 Median:45.00 stddev:1.79 (4.0%) stddev-sans-first:1.86 06:16:52 INFO - PID 8690 | Values: 44.0 49.0 46.0 44.0 47.0 45.0 45.0 43.0 44.0 44.0 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#9] json-stringify-tinderbox Cycles:10 Average:36.50 Median:37.00 stddev:0.53 (1.4%) stddev-sans-first:0.53 06:16:52 INFO - PID 8690 | Values: 36.0 37.0 36.0 37.0 37.0 37.0 37.0 36.0 36.0 36.0 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.00 stddev:2.26 (3.1%) stddev-sans-first:2.28 06:16:52 INFO - PID 8690 | Values: 71.0 70.0 73.0 75.0 73.0 71.0 73.0 78.0 73.0 73.0 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#11] stanford-crypto-ccm Cycles:10 Average:105.90 Median:105.50 stddev:3.35 (3.2%) stddev-sans-first:3.54 06:16:52 INFO - PID 8690 | Values: 105.0 106.0 112.0 109.0 104.0 105.0 110.0 103.0 102.0 103.0 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:150.00 stddev:2.57 (1.7%) stddev-sans-first:2.52 06:16:52 INFO - PID 8690 | Values: 152.0 146.0 151.0 148.0 149.0 145.0 148.0 153.0 149.0 151.0 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:61.00 stddev:2.18 (3.6%) stddev-sans-first:2.28 06:16:52 INFO - PID 8690 | Values: 59.0 57.0 59.0 61.0 62.0 61.0 60.0 61.0 57.0 64.0 06:16:52 INFO - PID 8690 | -------- Summary: end -------- 06:16:52 INFO - PID 8690 | 06:16:52 INFO - PID 8690 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:16:52 INFO - TEST-INFO | 8690: exit 0 06:16:52 INFO - TEST-OK | kraken | took 59172ms 06:16:52 INFO - SUITE-END | took 1166s 06:16:53 INFO - Completed test suite (00:19:26) 06:16:53 INFO - javascript benchmark 06:16:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9170.396369067654, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3861.498005259316, 3888.4167374893764, 3901.5513215980172, 3905.570387257403, 3918.902027449314, 6178.783742569011, 6199.225096862892, 6249.0, 6268.874622507547, 6330.588511746733, 6223.937760622403, 6251.749930002795, 6256.906146407808, 6259.374062593738, 6273.623582585048, 5541.889162216753, 5676.148577713335, 5690.118031705071, 5690.715464226792, 5713.17159011943, 188.6828826310539, 5686.630369026021, 5708.971455142719, 5766.826995190151, 5772.595918285721, 5605.103183490643, 5607.186957891104, 5610.18652295419, 5687.516561092312, 5712.400197979194, 5596.2165296858475, 5626.352969408529, 5691.0, 5694.572907031948, 5698.230738850244, 5594.720263986785, 5608.383077861432, 5685.0, 5687.374388817227, 5688.544916406678, 6193.256809182927, 6204.379562043805, 6220.844478888019, 6266.467350275232, 6274.058891166316, 6535.607863528156, 6662.833429164261, 6732.427743641796, 6759.594424334507, 6824.1128653275255, 6815.284395138488, 6835.940429233477, 6863.862722745567, 6868.381845633917, 6875.862482750367, 6314.336994615591, 6335.714892829834, 6376.0, 6400.551961362707, 6414.358564143595, 6987.196472405637, 7008.33420825031, 7090.042844215965, 7096.7516136934955, 7103.041089452858, 6535.836604084936, 6637.336266373421, 6640.335966403321, 6659.800205993828, 6660.666966651648, 6803.7958861233255, 6819.283975182633, 6842.7605033823575, 6903.378695917391, 6919.619420931897, 6772.593644381254, 6782.253952065269, 6865.862682746317, 6874.106366172466, 6880.415164711056, 6768.661566921634, 6789.93210067893, 6800.897986530206, 6889.655517224119, 6891.862162756717, 4980.7509624518625, 5012.796928737077, 5019.146745053276, 5028.0, 5065.569426598707, 4403.4495688039, 4491.842785502492, 4491.910161796811, 4499.0, 4558.928651766832, 6293.0, 6299.811005669837, 6362.745490180341, 6372.490200783926, 6377.7448902044325, 6762.932370676231, 6820.658967051628, 6822.283660215705, 6913.75801846933, 6919.930800692029, 6216.036514340284, 6297.433231009231, 6299.212598425197, 6303.464205542488, 6307.747690092437, 5516.889662206733, 5563.054280772279, 5567.3040869891265, 5569.832905012856, 5581.832545023656, 6968.721251149998, 7060.435165186773, 7123.964380178066, 7146.785596432115, 7159.67781449836, 6705.765298214539, 6788.9660551696925, 6800.387965083166, 6895.862082758417, 6899.0341352210735, 7008.0, 7049.0, 7093.82265443368, 7107.60908150036, 7116.537425067354, 6705.4635629150525, 6773.661316934232, 6775.356341147583, 6797.660116994031, 6805.149356330458, 6857.897131542931, 6893.7931862044215, 6917.066196063467, 6938.063361446342, 6945.305469453015, 6608.43828274602, 6632.104665870046, 6701.966490167518, 6703.698333574904, 6704.899426508508, 6500.804975850732, 6525.673716314261, 6575.539712220098, 6588.407043365928, 6675.59946403198, 6505.707243173973, 6510.056041873996, 6521.804345869631, 6531.738730450728, 6553.639549824806, 6672.399484046459, 6728.562643428161, 6735.0570920072205, 6738.35985581369, 6773.491988100814, 6487.708053137526, 6492.513061520311, 6560.40956313934, 6567.9671601643595, 6579.309172536815], "value": 6192.337728827351, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [920.958556864941, 965.0638880286123, 991.8512223166524, 992.2062350119904, 1013.1793247469554, 44095.55904440954, 45054.32418513725, 45103.32345014827, 45113.77443112784, 45122.32316515255, 43297.0, 43415.348769768476, 43509.56490435095, 46480.535194648044, 47495.0, 8419.663213471455, 8618.56907154643, 8619.827603447928, 8621.870671939925, 8629.95685021574, 8375.0, 8442.366822488308, 8527.530985795778, 8537.701180458685, 8538.573071346407, 8549.572521373937, 8564.186402291803, 8567.871481927776, 8575.699850505234, 8602.18279263469, 8436.662533498653, 8498.830023399529, 8536.658533658678, 8551.358648101417, 8553.572321383906, 8392.832143357098, 8431.241188293021, 8447.831043379098, 8465.873011904827, 8496.617652205665, 41454.0, 41544.37683434751, 41701.1659766806, 41939.0, 41982.160356793, 3775.8300876460626, 3791.3554695701796, 3807.733458657895, 3813.8855834325013, 3815.465834783133, 34267.143321416916, 34279.657203427894, 34380.14049648754, 34415.483767743506, 34516.82741586276, 5248.422673505911, 5373.919391209135, 5400.513953744143, 5450.236966824647, 5459.12653975366, 228137.0, 228320.0, 228360.99999999834, 229053.0, 229216.0, 49371.25943110856, 55848.0, 56239.0, 56505.0, 56541.0, 59948.70025649931, 59990.400095998484, 60035.0, 60071.69964150151, 60151.69924150351, 14761.261936903113, 14981.925090374696, 14984.925075374553, 15067.547973560811, 15127.0, 11771.941140294415, 11773.17587768848, 11818.172727908965, 11822.054235661299, 11836.88163118375, 14772.926135369255, 14860.0, 14879.628009299637, 14912.70174596502, 15028.0, 5290.444503327172, 5389.487998640123, 5399.271098401744, 5507.504324610804, 5527.668339899538, 1078.396098185019, 1088.5645741703381, 1098.1489345756943, 1118.457548089176, 1119.9048080913215, 26398.04725132671, 26809.0, 26817.195484135507, 26937.461250775268, 27004.32489187786, 1199.346356235836, 1215.5684731920219, 1227.864934857165, 1228.2078059651474, 1230.8953738932112, 13922.37349319283, 14064.789028164585, 14160.575182744535, 14245.715085698228, 14252.287385630678, 298821.0, 301696.0, 302444.0, 302819.0, 303271.0, 59286.70356648189, 59392.70303648454, 59420.7028964861, 59549.70225148933, 59585.404145958855, 1471.6983018481185, 1512.6218445388654, 1519.1644595472446, 1525.961850953735, 1546.6520032992487, 25191.24426267215, 25443.0, 25467.2359829198, 25582.61626075573, 25963.350916227246, 40579.1884162321, 40806.0, 40817.0, 40825.59174408218, 40891.0, 252123.0, 252193.0, 252372.0, 252525.0, 253371.0, 38257.4261386085, 38350.80824595859, 40972.38541421822, 41062.79468602638, 41190.38214426726, 52234.21648675197, 53543.46456535385, 53622.524209938965, 53790.46209537855, 53829.46170538245, 37394.0, 37760.62239377571, 38258.426123608726, 38312.80843595764, 38422.80788596151, 37605.0, 37748.0, 37919.241615168095, 38132.80933595314, 38222.80888595539, 43402.0, 44511.33233001572, 44921.10157796891, 45042.32436513389, 45236.32145517754, 36026.4596031065, 36145.63854361528, 36271.0, 36603.450948235266, 36864.44703329399, 27064.32339191536, 27215.319617009733, 27231.59152612673, 27322.45355092927, 27449.725502745518], "value": 19130.019933149928, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.8195464707758, 630.1870586942844, 633.6989929783356, 641.9390157934995, 652.6247407740549, 22705.77294227057, 23104.65343019852, 23475.530489390225, 23610.0, 23800.523989520243, 25738.742612573868, 26921.32696682584, 26959.86520067402, 26982.86508567459, 26992.190234292953, 6478.384553467413, 6635.33646635335, 6635.734570617169, 6644.634545100018, 6668.166479190101, 6546.443552298037, 6629.900551491732, 6818.045473633695, 6842.897356539655, 6851.931480685204, 6760.42536384408, 6806.353396427331, 6807.217170025436, 6810.523263371566, 6816.045753594501, 6662.733490660392, 6779.932200677979, 6783.559068660521, 6942.51402401827, 6951.304869513059, 6496.642684652342, 6499.772507962246, 6501.739930402779, 6502.252240992299, 6503.122078519386, 30492.0, 30554.84722576395, 30767.0, 30774.076777696482, 30962.53556196659, 2319.768023197667, 2340.648902664597, 2345.7067866516686, 2348.3189874936247, 2353.1175809071597, 19980.800191998038, 21333.35999920005, 21508.46228844276, 21524.56950860974, 21543.353699389045, 2534.6451496790464, 2589.1714651311586, 2603.0628973569687, 2667.6265322854815, 2669.879855406492, 139712.0, 145898.0, 164041.0, 171470.1426492872, 172966.1351693246, 16114.355425783071, 16228.59428514273, 16694.0, 16878.071706056286, 17072.402465913634, 27187.45625087487, 27320.0, 27417.0, 27423.725762742117, 27450.862745686143, 9996.350237234556, 10155.64455244063, 10185.08334249921, 10416.739581510523, 10549.789004219872, 8941.418807777474, 8998.30050984702, 9030.63877444895, 9031.36780425364, 9199.908000920039, 9924.305298629171, 10180.134688551409, 10223.28437009417, 10296.948515257525, 10301.639442619473, 3069.769767267464, 3072.293372524332, 3073.1087984484247, 3107.4717298059386, 3172.2069482629345, 1034.270839058462, 1037.5071840875676, 1043.7129789308, 1045.2004216774174, 1049.150188347441, 21318.78681213199, 21699.891500542395, 21715.674264886038, 21737.565248694937, 22286.55426891453, 1061.5223149582719, 1082.8213344798178, 1098.5331234225582, 1103.45379037377, 1107.501624269066, 11686.415679216005, 11759.941605255568, 11780.057595392347, 11803.291802491705, 11905.821412678817, 605336.0, 613733.0, 624040.0, 627783.0, 638584.0, 135481.3225933864, 135868.0, 137731.0, 137883.0, 140258.0, 1147.17976646698, 1297.228149251213, 1340.786588137737, 1363.5500284905957, 1364.774812156003, 22710.65934010958, 22953.770462295164, 22979.0, 23075.423114422272, 23151.76848231496, 66715.0, 67023.0, 67068.32931670621, 67507.32492675207, 67733.66133169303, 84937.0, 87759.12240877765, 87772.5611371939, 88358.55820720855, 88708.0, 21805.345839624835, 22013.339599812032, 22119.557608848056, 22159.22442714497, 22214.44463888351, 24252.0, 24639.38401539976, 24841.130560430298, 24851.62722559127, 24879.50240995134, 19786.901065495156, 19911.701324479855, 20040.699389508878, 20398.490037749176, 20468.0, 17105.657886842444, 17514.73727894057, 17621.64756704833, 17932.820671793637, 18466.261349546407, 19272.518187044876, 19893.403197904085, 19927.900360498104, 20142.697859531825, 20370.59258814845, 21336.786632134103, 21408.14367425348, 21435.0, 21542.784572154706, 21566.0, 19356.8064319355, 19683.70474442856, 19730.704039439133, 19771.209151633775, 19919.302824401075], "value": 13341.890281877653, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.4627468424658, 1505.104462844607, 1511.0782422722145, 1519.1948267418265, 1528.2206074901796, 16781.580460488494, 17415.0, 17418.129093545318, 17434.738478922827, 17452.0, 17067.146642667878, 17166.0, 17204.655906881853, 17231.396901108434, 17261.30954761811, 2812.5921741347493, 2912.0972498525525, 2934.8826046958097, 2936.1485169300877, 2939.76481881449, 2844.132539575429, 2869.5839103330004, 2897.6088228089257, 2897.797154199207, 2902.666193387756, 2787.2474431903374, 2790.2326860113426, 2837.4750671125803, 2846.1888361816887, 2847.103162503815, 2671.8530480823547, 2690.1391554702504, 2712.389712314733, 2721.4285000149894, 2742.561190209577, 2700.270921880037, 2716.769074628659, 2720.265528307366, 2726.577380506025, 2727.1818454463582, 16885.15574221284, 17301.567460813454, 17307.480775576754, 17316.653666926715, 17325.480235592953, 8512.276456501204, 8787.428817126865, 8790.912090879137, 8792.42849214799, 8800.295976321879, 5509.338879334466, 5730.512906402961, 5732.627379220337, 5824.621399609012, 5864.882702345972, 2068.9379318620468, 2077.4079387374527, 2092.4141240452695, 2100.6953991671276, 2175.9020844062056, 27854.442911141865, 28844.711552884623, 30593.694063059305, 31111.688883111106, 31886.999999999767, 7482.438817088631, 7499.325060744559, 7558.773236802905, 7652.081750190013, 7726.690932362642, 20278.391648250577, 20414.38756837297, 20511.0, 20515.0, 20520.794792052187, 8557.187067228604, 8636.697715579925, 8648.78378040554, 8706.95646521776, 8708.564571771512, 7765.922340776633, 7835.49069310493, 7875.724349647735, 7984.960075199587, 7995.360371170293, 5698.17376480408, 5825.912611310834, 5871.3541510433815, 5935.347111817697, 5935.52515798735, 1694.74578813179, 1716.9828301717073, 1734.4883259438495, 1739.5911960689227, 1749.3964582219114, 986.2455221755363, 996.8056229035268, 1003.0972125087479, 1004.7387679203459, 1025.6153942271649, 8759.0, 8776.912230877737, 8783.736487905373, 8807.559622019002, 8951.373403861668, 785.0500893918309, 795.8448102620049, 797.6211299632744, 799.1010113622175, 801.4389927051087, 5797.565182611321, 5990.700464976734, 6029.728662210211, 6061.181740465069, 6131.50947924165, 24184.75815241825, 25721.0, 25783.742162578135, 25820.612690809652, 25948.35129121787, 24188.516229675308, 24620.87689561541, 25314.0, 25627.103051393486, 25726.742732572435, 10715.785684286271, 11445.25605835618, 11642.88357116435, 12530.68673283157, 12839.550615728405, 9572.138507534355, 9799.167070799062, 9834.950825245827, 10242.795144096926, 10301.021402967006, 20943.266985655428, 21473.570528589655, 21521.0, 21558.568828623025, 21742.0, 21856.562868742854, 22066.33800985973, 22092.558148837255, 22260.554788904454, 22333.888330558242, 13369.598912032654, 13508.0, 13633.454661813814, 13728.93135534316, 13733.862661373258, 14652.487162949246, 14853.331600077807, 14884.0, 14912.62718432048, 14962.0, 12544.686382840502, 12690.555830545887, 12717.300548469922, 12831.550895718605, 12905.967522597983, 11403.916627920335, 11784.58753943608, 11819.822702659296, 11867.228630139014, 12158.0, 10666.466676665981, 10709.678709638723, 10763.0, 10792.892071079188, 10808.18938579594, 7793.869888866196, 7822.256885595859, 7845.097813751263, 7918.485298455582, 7945.0863150738405, 8383.413161078666, 8446.366522510714, 8472.957635211784, 8500.149985001697, 8551.57242137903], "value": 7343.028240580538, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.2930648769576, 567.6565677764952, 573.6615396915819, 587.1779508687837, 592.496378078633, 6112.69436528174, 6112.7860524881635, 6166.722497487613, 6181.412765787249, 6242.0, 6089.573729838913, 6096.969515152429, 6097.146399504073, 6156.245470041039, 6186.133941248228, 5029.245613158019, 5031.4465408805, 5051.823186188484, 5086.364204474441, 5093.923591146136, 4858.392700912386, 4944.505549445063, 5004.274380214867, 5029.094762942669, 5050.368703912011, 4950.405951285851, 4968.40379154502, 4976.303317535548, 4988.950110498885, 5007.4491805901325, 4924.571874156491, 4936.925946110811, 4937.456879743226, 4961.90076198474, 4984.576311013569, 4444.28894875472, 4535.365048893158, 4539.387182730322, 4544.250198717207, 4554.203014472454, 5946.375630558772, 5994.940050599482, 6017.969910150465, 6037.849053773691, 6072.666003369813, 5834.687195381048, 5844.970775146097, 5848.093545500455, 5857.648541087548, 5884.0, 6561.3438656134485, 6616.139901812733, 6619.768308109241, 6635.13743213384, 6664.333566643345, 4918.458969513351, 5062.316587260746, 5109.948900511022, 5115.130427827278, 5129.84610461683, 6656.334366563305, 6715.865682686368, 6722.731090756364, 6814.352636499475, 6861.931380686179, 5241.816536421207, 5259.763955470461, 5265.447128051499, 5270.710110943858, 5289.233061206103, 5300.390455097636, 5321.255024296602, 5322.308099947059, 5351.705656188947, 5370.2750128732905, 5866.178734977107, 5885.911711324334, 5896.172186622161, 5896.469317761422, 5906.3207731110615, 6521.217453905467, 6544.476441884638, 6550.901736473957, 6554.442872355808, 6600.141981542369, 1809.4933418642802, 1843.8156184381724, 1850.1859181959894, 1860.4604664647372, 1864.14249445254, 1273.0, 1314.141741711773, 1321.0950498908087, 1346.0779366134034, 1348.7369962857344, 5863.853403664943, 5946.167536544887, 5968.1942937703725, 5997.0, 6145.20112385396, 6512.934870651327, 6520.934790652128, 6595.571287866273, 6596.637184954778, 6689.531732778659, 6083.6349819011, 6145.293291271471, 6163.476104531165, 6186.536009799193, 6218.0, 3485.7734247273847, 3496.283261931298, 3502.141975216088, 3517.771344862576, 3558.466230065511, 6775.559588626724, 6840.48696347766, 6882.380585747307, 6940.9652951734915, 6944.340287672663, 6804.65976701163, 6821.863562728718, 6867.527690031585, 6884.208316043619, 6928.549644273106, 6703.363180497748, 6809.31906809325, 6833.794986150423, 6845.973104034335, 6985.580865148006, 6483.935160648333, 6504.902426463702, 6553.886903720885, 6602.636854973022, 6691.46468282546, 6474.223093228843, 6512.967435162794, 6520.934790652223, 6561.179852518435, 6603.966980165068, 6786.287439818748, 6841.863162736817, 6845.0, 6888.518968421813, 6914.471021480938, 5196.220566914993, 5200.323957885451, 5254.632175747814, 5259.868503287448, 5261.158214685632, 6684.565503242274, 6768.627725475146, 6803.4557235422035, 6809.897851532132, 6830.556013859084, 6373.132090559359, 6377.8724425512155, 6555.967220163869, 6577.276499585138, 6597.967010164918, 6355.396237357444, 6357.300696923242, 6397.296297407189, 6434.549581529248, 6474.5791523550815, 6182.969085154546, 6249.218847644044, 6341.270753863365, 6436.774712885027, 6456.451201647913, 6500.252470965899, 6550.934490655223, 6572.572782769296, 6626.768063117768, 6649.202095748541, 6097.512199024156, 6271.843203919939, 6272.341404152498, 6292.307846137013, 6366.204224471941], "value": 5142.496559207999, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [972.3096601412992, 1001.8897921228665, 1008.848672699095, 1024.748936510555, 1037.9464843184167, 18470.90764546177, 18699.71950420743, 18843.905780471097, 20810.89594552029, 21461.463463413424, 18301.084945752693, 18315.54211144722, 18318.450446486593, 18375.173117209724, 18471.630567388645, 1076.0960792933934, 1086.7283179205199, 1088.755030118225, 1089.319175515303, 1092.049916572583, 1068.2415485005656, 1072.3458690198972, 1073.7637719701654, 1074.4466599701161, 1083.5286650307103, 1101.3557069114538, 1139.1740987783833, 1141.2182654881433, 1142.857142857143, 1142.959996400126, 1125.5329038449033, 1128.2722643894642, 1134.9262297950606, 1136.8806275341094, 1138.5275110828995, 829.4691397505601, 829.7676650537859, 834.9165083491663, 836.3142223376833, 836.6109758962051, 19061.904690476596, 20758.169673213055, 20810.47973800652, 20859.687104693443, 20953.37139885806, 23393.53212935749, 23613.881930590236, 24411.145609903746, 24443.511129777304, 24467.63298550523, 18498.722519162224, 18539.35112271064, 18806.153723082494, 18806.90596547022, 18810.435686929413, 3880.961190388088, 3907.374820028782, 3919.098607320332, 3928.6464218220212, 3934.213157368509, 120431.0, 120487.0, 161489.0, 165764.0, 165907.0, 18429.53926151857, 18662.0, 18700.438986830417, 18745.7188142178, 18989.810101898805, 35359.0, 35564.28871422557, 36222.45666315007, 36663.26673466516, 37013.074673133386, 10050.547725352377, 10060.446675432922, 10100.848487272697, 10114.797704046025, 10163.9491802542, 4722.5513576210205, 4776.259679749644, 4813.229883218738, 4871.732054736953, 4878.463369029404, 6012.669303188367, 6133.907991380132, 6140.017597184429, 6140.17107690456, 6156.322804491502, 1189.4047506576057, 1209.1113031921532, 1227.459917636255, 1228.2323547782637, 1231.9815202771965, 747.8167848876951, 748.8839229919371, 757.1293013034943, 767.9040119985002, 772.042667092812, 12585.87414125847, 12857.742845143232, 12988.0, 13842.584722458343, 13862.584122476343, 733.8385555177853, 739.6893304811884, 741.7700512841036, 744.4639859301294, 761.6458346868733, 6180.289266734293, 6200.782972595937, 6256.405641464054, 6280.434760871543, 6283.120363149163, 163990.0, 164374.0, 164688.0, 167535.1623241876, 170373.0, 135531.0, 139719.0, 139975.0, 142484.0, 144979.0, 119727.0, 121347.0, 122013.0, 122517.0, 124777.0, 11632.127590430582, 11859.110566707704, 11882.049436045269, 11943.293565616801, 12032.157748957488, 56022.43977560335, 56416.15375769449, 56533.0, 57091.429085710275, 57591.136132958876, 71799.64100179466, 72007.63996179985, 73277.6336118316, 74142.62928685322, 74999.0, 16643.50069497917, 16746.748798767785, 16789.32842686279, 16803.579910502336, 16930.83069169342, 18409.723854141932, 18494.63010739751, 18704.53238669044, 18719.06404679733, 18765.437036888914, 16681.666366672842, 16748.078855663054, 16783.160841957608, 16837.073960932266, 16968.66062678764, 15945.920270398574, 16040.679186415973, 16209.0, 16319.347226111298, 16369.918150409172, 16066.67866642684, 16180.67638647244, 16252.349906004101, 16267.755983660018, 16271.349146034026, 12628.242305461701, 12657.556985505464, 12748.936255318664, 12800.61598152057, 12936.029797765394, 12809.295488747835, 12863.035272354424, 12868.806967895676, 12887.42006609686, 12928.159669621444], "value": 9964.685671906342, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1364.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 105.0, 107.0, 105.0, 107.0, 108.0, 107.0, 105.0, 104.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 113.0, 113.0, 111.0, 111.0, 111.0, 113.0, 112.0, 116.0], "value": 112.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 164.0, 164.0, 164.0, 164.0, 162.0, 163.0, 174.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 76.0, 73.0, 75.0, 73.0, 74.0, 73.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 79.0, 77.0, 79.0, 78.0, 78.0, 82.0, 79.0, 79.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 111.0, 111.0, 112.0, 113.0, 118.0, 113.0, 118.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 152.0, 149.0, 149.0, 153.0, 152.0, 150.0, 151.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 99.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 49.0, 46.0, 44.0, 47.0, 45.0, 45.0, 43.0, 44.0, 44.0], "value": 45.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 37.0, 36.0, 37.0, 37.0, 37.0, 37.0, 36.0, 36.0, 36.0], "value": 36.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 73.0, 75.0, 73.0, 71.0, 73.0, 78.0, 73.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 106.0, 112.0, 109.0, 104.0, 105.0, 110.0, 103.0, 102.0, 103.0], "value": 105.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 146.0, 151.0, 148.0, 149.0, 145.0, 148.0, 153.0, 149.0, 151.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 59.0, 61.0, 62.0, 61.0, 60.0, 61.0, 57.0, 64.0], "value": 60.1, "unit": "score"}]}]} 06:16:53 INFO - Return code: 0 06:16:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:16:53 INFO - # TBPL SUCCESS # 06:16:53 INFO - Running post-action listener: _package_coverage_data 06:16:53 INFO - Running post-action listener: _resource_record_post_action 06:16:53 INFO - [mozharness: 2017-09-29 13:16:53.570302Z] Finished run-tests step (success) 06:16:53 INFO - Running post-run listener: _resource_record_post_run 06:16:53 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319918080; Read time: 12; Write time: 341168 06:16:53 INFO - TinderboxPrint: CPU usage
13.1% 06:16:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:16:53 INFO - TinderboxPrint: I/O write bytes / time
319,918,080 / 341,168 06:16:53 INFO - TinderboxPrint: CPU idle
8,211.9 (86.9%) 06:16:53 INFO - TinderboxPrint: CPU user
1,186.0 (12.6%) 06:16:53 INFO - TinderboxPrint: Swap in / out
0 / 0 06:16:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12529664; Read time: 0; Write time: 2372 06:16:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:16:53 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 4096; Write bytes: 306266112; Read time: 12; Write time: 338780 06:16:54 INFO - Running post-run listener: _upload_blobber_files 06:16:54 INFO - Blob upload gear active. 06:16:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:16:54 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 06:16:54 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'] 06:16:54 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 06:16:54 INFO - (blobuploader) - INFO - Open directory for files ... 06:16:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:16:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:16:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:17:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:01 INFO - (blobuploader) - INFO - Done attempting. 06:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 06:17:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 06:17:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:03 INFO - (blobuploader) - INFO - Done attempting. 06:17:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:17:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:17:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:04 INFO - (blobuploader) - INFO - Done attempting. 06:17:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 06:17:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 06:17:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:05 INFO - (blobuploader) - INFO - Done attempting. 06:17:05 INFO - (blobuploader) - INFO - Iteration through files over. 06:17:05 INFO - Return code: 0 06:17:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:17:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:17:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/748ad13b037acf596eca9f2e268fcdb60d140b642666113b1e75bbefd1ce6a890c1c7932362d8565a0094b5a494d9ecd303fb875ab615c20681f6b89b909dbca", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e1cfbda3d8e4165742183cfc92beede907ee680e99add8a2c393c9fbb27480becee5dc04d9ea8f0960d801ec96279811d63ecee2ef98631ae2ddabed3988c9f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ae587a297fca2f00b849d1c9a3d1cbe60177c68552de8cee1caa6f10932432efc810bac77bb9070a9e2de6b5e0db2ff0cc8e03ff022408379d6e25fb4423b7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbde84a1435b6d62c518f0d1e92e31f71854c94d0a672dc4459f4aba5f58aa89924320f98e8754d053c1d73e57ceec663cfdbd79b64b6c7b09aa9effabbdd265"} 06:17:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:17:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:17:05 INFO - Contents: 06:17:05 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/748ad13b037acf596eca9f2e268fcdb60d140b642666113b1e75bbefd1ce6a890c1c7932362d8565a0094b5a494d9ecd303fb875ab615c20681f6b89b909dbca", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e1cfbda3d8e4165742183cfc92beede907ee680e99add8a2c393c9fbb27480becee5dc04d9ea8f0960d801ec96279811d63ecee2ef98631ae2ddabed3988c9f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ae587a297fca2f00b849d1c9a3d1cbe60177c68552de8cee1caa6f10932432efc810bac77bb9070a9e2de6b5e0db2ff0cc8e03ff022408379d6e25fb4423b7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbde84a1435b6d62c518f0d1e92e31f71854c94d0a672dc4459f4aba5f58aa89924320f98e8754d053c1d73e57ceec663cfdbd79b64b6c7b09aa9effabbdd265"} 06:17:05 INFO - Running post-run listener: copy_logs_to_upload_dir 06:17:05 INFO - Copying logs to upload dir... 06:17:05 INFO - mkdir: /builds/slave/test/build/upload/logs 06:17:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.868991 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-29 06:17:05.263196) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 06:17:05.267138) ========= 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=fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234 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/748ad13b037acf596eca9f2e268fcdb60d140b642666113b1e75bbefd1ce6a890c1c7932362d8565a0094b5a494d9ecd303fb875ab615c20681f6b89b909dbca", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e1cfbda3d8e4165742183cfc92beede907ee680e99add8a2c393c9fbb27480becee5dc04d9ea8f0960d801ec96279811d63ecee2ef98631ae2ddabed3988c9f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ae587a297fca2f00b849d1c9a3d1cbe60177c68552de8cee1caa6f10932432efc810bac77bb9070a9e2de6b5e0db2ff0cc8e03ff022408379d6e25fb4423b7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbde84a1435b6d62c518f0d1e92e31f71854c94d0a672dc4459f4aba5f58aa89924320f98e8754d053c1d73e57ceec663cfdbd79b64b6c7b09aa9effabbdd265"} build_url:https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011496 build_url: 'https://queue.taskcluster.net/v1/task/HJIuBy1HRP21tCyn9W2sCA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/748ad13b037acf596eca9f2e268fcdb60d140b642666113b1e75bbefd1ce6a890c1c7932362d8565a0094b5a494d9ecd303fb875ab615c20681f6b89b909dbca", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e1cfbda3d8e4165742183cfc92beede907ee680e99add8a2c393c9fbb27480becee5dc04d9ea8f0960d801ec96279811d63ecee2ef98631ae2ddabed3988c9f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ae587a297fca2f00b849d1c9a3d1cbe60177c68552de8cee1caa6f10932432efc810bac77bb9070a9e2de6b5e0db2ff0cc8e03ff022408379d6e25fb4423b7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbde84a1435b6d62c518f0d1e92e31f71854c94d0a672dc4459f4aba5f58aa89924320f98e8754d053c1d73e57ceec663cfdbd79b64b6c7b09aa9effabbdd265"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 06:17:05.297687) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 06:17:05.298076) ========= 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=fa44defc139c4ba8574fe040000001db-1506689160.815097-377490234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 06:17:05.381571) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 06:17:05.383893) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 06:17:05.384232) ========= ========= Total master_lag: 0.30 =========