builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-073 starttime: 1506294685.73 results: success (0) revision: d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:25.727506) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:25.727997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:25.728338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:26.036948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:26.037331) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-24 16:11: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% 225M=0s 2017-09-24 16:11:26 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106145 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:26.188507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:26.191836) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020485 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:26.241102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:26.241406) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4 --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 d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4 --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=9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-24 16:11:26,182 truncating revision to first 12 chars 2017-09-24 16:11:26,182 Setting DEBUG logging. 2017-09-24 16:11:26,182 attempt 1/10 2017-09-24 16:11:26,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d9cfaad3b11e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-24 16:11:26,435 unpacking tar archive at: mozilla-central-d9cfaad3b11e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:26.819016) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:26.819322) ========= script_repo_revision: d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:26.819701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:26.820012) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 16:11:26.832978) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-24 16:11:26.833323) ========= /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=9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:11:26 INFO - MultiFileLogger online at 20170924 16:11:26 in /builds/slave/test 16:11: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 16:11:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:11:26 INFO - {'append_to_log': False, 16:11:26 INFO - 'base_work_dir': '/builds/slave/test', 16:11:26 INFO - 'blob_upload_branch': 'Firefox', 16:11:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:11:26 INFO - 'branch': 'Firefox', 16:11:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:11:26 INFO - 'code_coverage': False, 16:11:26 INFO - 'config_files': ('talos/linux_config.py',), 16:11:26 INFO - 'default_actions': ('clobber', 16:11:26 INFO - 'read-buildbot-config', 16:11:26 INFO - 'download-and-extract', 16:11:26 INFO - 'populate-webroot', 16:11:26 INFO - 'create-virtualenv', 16:11:26 INFO - 'install', 16:11:26 INFO - 'setup-mitmproxy', 16:11:26 INFO - 'run-tests'), 16:11:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:11:26 INFO - 'disable_ccov_upload': False, 16:11:26 INFO - 'disable_stylo': False, 16:11:26 INFO - 'download_minidump_stackwalk': True, 16:11:26 INFO - 'download_symbols': 'ondemand', 16:11:26 INFO - 'enable_stylo': False, 16:11:26 INFO - 'enable_webrender': False, 16:11:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:11:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:11:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:11:26 INFO - 'gecko_profile': False, 16:11:26 INFO - 'gecko_profile_interval': 0, 16:11:26 INFO - 'installer_path': 'installer.exe', 16:11:26 INFO - 'log_level': 'info', 16:11:26 INFO - 'log_name': 'talos', 16:11:26 INFO - 'log_to_console': True, 16:11:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:11:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:11:26 INFO - 'opt_config_files': (), 16:11:26 INFO - 'pip_index': False, 16:11:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 16:11:26 INFO - 'system_bits': '32', 16:11:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:11:26 INFO - 'title': 'talos-linux64-ix-073', 16:11:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:11:26 INFO - 'use_talos_json': True, 16:11:26 INFO - 'verify': 'False', 16:11:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:11:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:11:26 INFO - 'work_dir': 'build'} 16:11:26 INFO - [mozharness: 2017-09-24 23:11:26.910839Z] Running clobber step. 16:11:26 INFO - Running pre-action listener: _resource_record_pre_action 16:11:26 INFO - Running main action method: clobber 16:11:26 INFO - rmtree: /builds/slave/test/build 16:11:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:11:27 INFO - Running post-action listener: _resource_record_post_action 16:11:27 INFO - [mozharness: 2017-09-24 23:11:27.906224Z] Finished clobber step (success) 16:11:27 INFO - [mozharness: 2017-09-24 23:11:27.906322Z] Running read-buildbot-config step. 16:11:27 INFO - Running pre-action listener: _resource_record_pre_action 16:11:27 INFO - Running main action method: read_buildbot_config 16:11:27 INFO - Using buildbot properties: 16:11:27 INFO - { 16:11:27 INFO - "project": "", 16:11:27 INFO - "product": "firefox", 16:11:27 INFO - "who": "archaeopteryx@coole-files.de", 16:11:27 INFO - "installer_path": "public/build/target.tar.bz2", 16:11:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 16:11:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:11:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 16:11:27 INFO - "stage_platform": "linux64-pgo", 16:11:27 INFO - "basedir": "/builds/slave/test", 16:11:27 INFO - "buildnumber": 55, 16:11:27 INFO - "platform": "ubuntu64_hw", 16:11:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:11:27 INFO - "slavebuilddir": "test", 16:11:27 INFO - "taskId": "WIVtu07TSx-Ps1CJWgCATA", 16:11:27 INFO - "branch": "mozilla-central", 16:11:27 INFO - "script_repo_revision": "production", 16:11:27 INFO - "revision": "d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4", 16:11:27 INFO - "slavename": "talos-linux64-ix-073", 16:11:27 INFO - "repo_path": "mozilla-central" 16:11:27 INFO - } 16:11:27 INFO - Finding installer, test and symbols from parent task. 16:11:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WIVtu07TSx-Ps1CJWgCATA'}, attempt #1 16:11:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WIVtu07TSx-Ps1CJWgCATA'}, attempt #1 16:11:28 INFO - Task dependencies: ce0ldRR8TaGxVM0-hHQ4zg 16:11:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg'}, attempt #1 16:11:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.tar.bz2 16:11:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.test_packages.json 16:11:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.crashreporter-symbols.zip 16:11:29 INFO - Running post-action listener: _resource_record_post_action 16:11:29 INFO - [mozharness: 2017-09-24 23:11:29.237554Z] Finished read-buildbot-config step (success) 16:11:29 INFO - [mozharness: 2017-09-24 23:11:29.237774Z] Running download-and-extract step. 16:11:29 INFO - Running pre-action listener: _resource_record_pre_action 16:11:29 INFO - Running main action method: download_and_extract 16:11:29 INFO - mkdir: /builds/slave/test/build/tests 16:11: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')]} 16:11:29 INFO - trying https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.test_packages.json 16:11:29 INFO - Downloading https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:11:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:11:29 INFO - Downloaded 989 bytes. 16:11:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:11:29 INFO - Using the following test package requirements: 16:11:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:11:29 INFO - u'common': [u'target.common.tests.zip'], 16:11:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:11:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:11:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:11:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:11:29 INFO - u'mozbase': [u'target.common.tests.zip'], 16:11:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:11:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:11:29 INFO - u'web-platform': [u'target.common.tests.zip', 16:11:29 INFO - u'target.web-platform.tests.tar.gz'], 16:11:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:11:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:11:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.common.tests.zip 16:11:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:11:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.common.tests.zip into memory 16:11:32 INFO - Content-Length response header: 55346500 16:11:32 INFO - Bytes received: 55346500 16:11:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.talos.tests.zip 16:11:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:11:43 INFO - Fetch https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.talos.tests.zip into memory 16:11:44 INFO - Content-Length response header: 14513823 16:11:44 INFO - Bytes received: 14513823 16:11:44 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')]} 16:11:44 INFO - trying https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.tar.bz2 16:11:44 INFO - Downloading https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:11:48 INFO - Downloaded 62421213 bytes. 16:11:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.tar.bz2 16:11:48 INFO - mkdir: /builds/slave/test/properties 16:11:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:11:48 INFO - Writing to file /builds/slave/test/properties/build_url 16:11:48 INFO - Contents: 16:11:48 INFO - build_url:https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.tar.bz2 16:11:48 INFO - Running post-action listener: _resource_record_post_action 16:11:48 INFO - Running post-action listener: find_tests_for_verification 16:11:48 INFO - Running post-action listener: set_extra_try_arguments 16:11:48 INFO - [mozharness: 2017-09-24 23:11:48.498482Z] Finished download-and-extract step (success) 16:11:48 INFO - [mozharness: 2017-09-24 23:11:48.498712Z] Running populate-webroot step. 16:11:48 INFO - Running pre-action listener: _resource_record_pre_action 16:11:48 INFO - Running main action method: populate_webroot 16:11:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:11:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:11:48 INFO - 'tests': ['tresize', 16:11:48 INFO - 'tcanvasmark']}, 16:11:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:11:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:11:48 INFO - 'tests': ['dromaeo_css', 16:11:48 INFO - 'kraken']}, 16:11:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:11:48 INFO - 'talos_options': ['--disable-stylo'], 16:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:11:48 INFO - 'tests': ['damp', 'tps']}, 16:11:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:11:48 INFO - 'talos_options': ['--disable-stylo'], 16:11:48 INFO - 'tests': ['damp', 'tps']}, 16:11:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:11:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:11:48 INFO - 'tests': ['dromaeo_dom']}, 16:11:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:11:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:11:48 INFO - 'tests': ['basic_compositor_video', 16:11:48 INFO - 'glvideo']}, 16:11:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:11:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:11:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:11:48 INFO - 'talos_options': ['--disable-stylo'], 16:11:48 INFO - 'tests': ['ts_paint_webext', 16:11:48 INFO - 'tp5o_webext']}, 16:11:48 INFO - 'other-e10s': {'tests': ['a11yr', 16:11:48 INFO - 'ts_paint', 16:11:48 INFO - 'tpaint', 16:11:48 INFO - 'sessionrestore', 16:11:48 INFO - 'sessionrestore_many_windows', 16:11:48 INFO - 'sessionrestore_no_auto_restore', 16:11:48 INFO - 'tabpaint']}, 16:11:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:11:48 INFO - 'tests': ['a11yr', 16:11:48 INFO - 'ts_paint', 16:11:48 INFO - 'tpaint', 16:11:48 INFO - 'sessionrestore', 16:11:48 INFO - 'sessionrestore_many_windows', 16:11:48 INFO - 'sessionrestore_no_auto_restore', 16:11:48 INFO - 'tabpaint']}, 16:11:48 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 16:11:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:11:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:11:48 INFO - 'tests': ['perf_reftest_singletons']}, 16:11:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:11:48 INFO - 'tests': ['perf_reftest']}, 16:11:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:11:48 INFO - 'tsvgr_opacity', 16:11:48 INFO - 'tart', 16:11:48 INFO - 'tscrollx', 16:11:48 INFO - 'tsvg_static']}, 16:11:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:11:48 INFO - 'tests': ['tsvgx', 16:11:48 INFO - 'tsvgr_opacity', 16:11:48 INFO - 'tart', 16:11:48 INFO - 'tscrollx', 16:11:48 INFO - 'tsvg_static']}, 16:11:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:11:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:11:48 INFO - 'talos_options': ['--disable-stylo'], 16:11:48 INFO - 'tests': ['tp5o']}, 16:11:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:11:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:11:48 INFO - 'talos_options': ['--mitmproxy', 16:11:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:11:48 INFO - '--firstNonBlankPaint'], 16:11:48 INFO - 'tests': ['tp6_google', 16:11:48 INFO - 'tp6_youtube', 16:11:48 INFO - 'tp6_amazon', 16:11:48 INFO - 'tp6_facebook']}, 16:11:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:11:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:11:48 INFO - 'talos_options': ['--disable-stylo', 16:11:48 INFO - '--mitmproxy', 16:11:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:11:48 INFO - '--firstNonBlankPaint'], 16:11:48 INFO - 'tests': ['tp6_google', 16:11:48 INFO - 'tp6_youtube', 16:11:48 INFO - 'tp6_amazon', 16:11:48 INFO - 'tp6_facebook']}, 16:11:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:11:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:11:48 INFO - 'talos_options': ['--stylo-threads=1', 16:11:48 INFO - '--mitmproxy', 16:11:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:11:48 INFO - '--firstNonBlankPaint'], 16:11:48 INFO - 'tests': ['tp6_google', 16:11:48 INFO - 'tp6_youtube', 16:11:48 INFO - 'tp6_amazon', 16:11:48 INFO - 'tp6_facebook']}, 16:11:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:11:48 INFO - 'talos_options': ['--xperf_path', 16:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:48 INFO - 'tests': ['tp5n']}, 16:11:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:11:48 INFO - 'talos_options': ['--disable-stylo', 16:11:48 INFO - '--xperf_path', 16:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:48 INFO - 'tests': ['tp5n']}}} 16:11:48 INFO - Running post-action listener: _resource_record_post_action 16:11:48 INFO - [mozharness: 2017-09-24 23:11:48.519538Z] Finished populate-webroot step (success) 16:11:48 INFO - [mozharness: 2017-09-24 23:11:48.519645Z] Running create-virtualenv step. 16:11:48 INFO - Running pre-action listener: _resource_record_pre_action 16:11:48 INFO - Running main action method: create_virtualenv 16:11:48 INFO - Creating virtualenv /builds/slave/test/build/venv 16:11:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:11:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:11:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:11:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:11:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:11:49 INFO - Installing distribute.............................................................................................................................................................................................done. 16:11:49 INFO - Installing pip...............done. 16:11:49 INFO - Return code: 0 16:11:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:11:49 INFO - Reading from file tmpfile_stdout 16:11:49 INFO - Output received: 16:11:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:11:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11: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')]} 16:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235bd60>, '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 0x235ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235cef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', '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 16:11: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', 'pip>=1.5'] in /builds/slave/test/build 16:11: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 pip>=1.5 16:11:49 INFO - Using env: {'DISPLAY': ':0', 16:11:49 INFO - 'HOME': '/home/cltbld', 16:11:49 INFO - 'LANG': 'en_US.UTF-8', 16:11:49 INFO - 'LANGUAGE': 'en_US:en', 16:11:49 INFO - 'LOGNAME': 'cltbld', 16:11:49 INFO - 'MAIL': '/var/mail/cltbld', 16:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:49 INFO - 'MOZ_NO_REMOTE': '1', 16:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:49 INFO - 'NO_EM_RESTART': '1', 16:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:49 INFO - 'PWD': '/builds/slave/test', 16:11:49 INFO - 'SHELL': '/bin/bash', 16:11:49 INFO - 'SHLVL': '1', 16:11:49 INFO - 'TERM': 'linux', 16:11:49 INFO - 'TMOUT': '86400', 16:11:49 INFO - 'USER': 'cltbld', 16:11:49 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', 16:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:49 INFO - '_': '/tools/buildbot/bin/python'} 16:11:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:11:50 INFO - Downloading/unpacking pip>=1.5 16:11:50 INFO - Running setup.py egg_info for package pip 16:11:50 INFO - warning: no files found matching 'pip/cacert.pem' 16:11:50 INFO - warning: no files found matching '*.html' under directory 'docs' 16:11:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:11:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:11:50 INFO - Installing collected packages: pip 16:11:50 INFO - Found existing installation: pip 1.1 16:11:50 INFO - Uninstalling pip: 16:11:50 INFO - Successfully uninstalled pip 16:11:50 INFO - Running setup.py install for pip 16:11:50 INFO - warning: no files found matching 'pip/cacert.pem' 16:11:50 INFO - warning: no files found matching '*.html' under directory 'docs' 16:11:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:11:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:11:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:11:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:11:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:11:50 INFO - Successfully installed pip 16:11:50 INFO - Cleaning up... 16:11:50 INFO - Return code: 0 16:11:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ff11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235bd60>, '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 0x235ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235cef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', '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 16:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:11:50 INFO - Using env: {'DISPLAY': ':0', 16:11:50 INFO - 'HOME': '/home/cltbld', 16:11:50 INFO - 'LANG': 'en_US.UTF-8', 16:11:50 INFO - 'LANGUAGE': 'en_US:en', 16:11:50 INFO - 'LOGNAME': 'cltbld', 16:11:50 INFO - 'MAIL': '/var/mail/cltbld', 16:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:50 INFO - 'MOZ_NO_REMOTE': '1', 16:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:50 INFO - 'NO_EM_RESTART': '1', 16:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:50 INFO - 'PWD': '/builds/slave/test', 16:11:50 INFO - 'SHELL': '/bin/bash', 16:11:50 INFO - 'SHLVL': '1', 16:11:50 INFO - 'TERM': 'linux', 16:11:50 INFO - 'TMOUT': '86400', 16:11:50 INFO - 'USER': 'cltbld', 16:11:50 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', 16:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:50 INFO - '_': '/tools/buildbot/bin/python'} 16:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:50 INFO - Downloading/unpacking psutil>=3.1.1 16:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:52 INFO - Installing collected packages: psutil 16:11:52 INFO - Running setup.py install for psutil 16:11:52 INFO - building 'psutil._psutil_linux' extension 16:11:52 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 16:11:52 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 16:11:52 INFO - building 'psutil._psutil_posix' extension 16:11:52 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 16:11:52 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 16:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:52 INFO - Successfully installed psutil 16:11:52 INFO - Cleaning up... 16:11:52 INFO - Return code: 0 16:11:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235bd60>, '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 0x235ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235cef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', '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 16:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:11:52 INFO - Using env: {'DISPLAY': ':0', 16:11:52 INFO - 'HOME': '/home/cltbld', 16:11:52 INFO - 'LANG': 'en_US.UTF-8', 16:11:52 INFO - 'LANGUAGE': 'en_US:en', 16:11:52 INFO - 'LOGNAME': 'cltbld', 16:11:52 INFO - 'MAIL': '/var/mail/cltbld', 16:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:52 INFO - 'MOZ_NO_REMOTE': '1', 16:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:52 INFO - 'NO_EM_RESTART': '1', 16:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:52 INFO - 'PWD': '/builds/slave/test', 16:11:52 INFO - 'SHELL': '/bin/bash', 16:11:52 INFO - 'SHLVL': '1', 16:11:52 INFO - 'TERM': 'linux', 16:11:52 INFO - 'TMOUT': '86400', 16:11:52 INFO - 'USER': 'cltbld', 16:11:52 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', 16:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:52 INFO - '_': '/tools/buildbot/bin/python'} 16:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:11:54 INFO - Installing collected packages: mozsystemmonitor 16:11:54 INFO - Running setup.py install for mozsystemmonitor 16:11:54 INFO - Successfully installed mozsystemmonitor 16:11:54 INFO - Cleaning up... 16:11:55 INFO - Return code: 0 16:11:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11: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')]} 16:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11: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', '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 0x1ff11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235bd60>, '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 0x235ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235cef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', '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 16:11: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:11: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 jsonschema==2.5.1 16:11:55 INFO - Using env: {'DISPLAY': ':0', 16:11:55 INFO - 'HOME': '/home/cltbld', 16:11:55 INFO - 'LANG': 'en_US.UTF-8', 16:11:55 INFO - 'LANGUAGE': 'en_US:en', 16:11:55 INFO - 'LOGNAME': 'cltbld', 16:11:55 INFO - 'MAIL': '/var/mail/cltbld', 16:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:55 INFO - 'MOZ_NO_REMOTE': '1', 16:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:55 INFO - 'NO_EM_RESTART': '1', 16:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:55 INFO - 'PWD': '/builds/slave/test', 16:11:55 INFO - 'SHELL': '/bin/bash', 16:11:55 INFO - 'SHLVL': '1', 16:11:55 INFO - 'TERM': 'linux', 16:11:55 INFO - 'TMOUT': '86400', 16:11:55 INFO - 'USER': 'cltbld', 16:11:55 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', 16:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:55 INFO - '_': '/tools/buildbot/bin/python'} 16:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:55 INFO - Downloading/unpacking jsonschema==2.5.1 16:11: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 16:11: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 16:11: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 16:11: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 16:11:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:11:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:11: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 16:11: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 16:11: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 16:11: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 16:11:56 INFO - Downloading functools32-3.2.3-2.tar.gz 16:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:11:56 INFO - warning: no files found matching '*.txt' 16:11:56 INFO - no previously-included directories found matching 'build' 16:11:56 INFO - no previously-included directories found matching 'dist' 16:11:56 INFO - no previously-included directories found matching '.git*' 16:11:56 INFO - Installing collected packages: jsonschema, functools32 16:11:56 INFO - Running setup.py install for functools32 16:11:56 INFO - warning: no files found matching '*.txt' 16:11:56 INFO - no previously-included directories found matching 'build' 16:11:56 INFO - no previously-included directories found matching 'dist' 16:11:56 INFO - no previously-included directories found matching '.git*' 16:11:56 INFO - Successfully installed jsonschema functools32 16:11:56 INFO - Cleaning up... 16:11:56 INFO - Return code: 0 16:11:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11: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')]} 16:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11: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', '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 0x1ff11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235bd60>, '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 0x235ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235cef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', '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 16:11: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:11: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 functools32==3.2.3-2 16:11:56 INFO - Using env: {'DISPLAY': ':0', 16:11:56 INFO - 'HOME': '/home/cltbld', 16:11:56 INFO - 'LANG': 'en_US.UTF-8', 16:11:56 INFO - 'LANGUAGE': 'en_US:en', 16:11:56 INFO - 'LOGNAME': 'cltbld', 16:11:56 INFO - 'MAIL': '/var/mail/cltbld', 16:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:56 INFO - 'MOZ_NO_REMOTE': '1', 16:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:56 INFO - 'NO_EM_RESTART': '1', 16:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:56 INFO - 'PWD': '/builds/slave/test', 16:11:56 INFO - 'SHELL': '/bin/bash', 16:11:56 INFO - 'SHLVL': '1', 16:11:56 INFO - 'TERM': 'linux', 16:11:56 INFO - 'TMOUT': '86400', 16:11:56 INFO - 'USER': 'cltbld', 16:11:56 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', 16:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:56 INFO - '_': '/tools/buildbot/bin/python'} 16:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:11:57 INFO - Cleaning up... 16:11:57 INFO - Return code: 0 16:11:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ff11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235bd60>, '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 0x235ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235cef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', '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 16:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:11:57 INFO - Using env: {'DISPLAY': ':0', 16:11:57 INFO - 'HOME': '/home/cltbld', 16:11:57 INFO - 'LANG': 'en_US.UTF-8', 16:11:57 INFO - 'LANGUAGE': 'en_US:en', 16:11:57 INFO - 'LOGNAME': 'cltbld', 16:11:57 INFO - 'MAIL': '/var/mail/cltbld', 16:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:57 INFO - 'MOZ_NO_REMOTE': '1', 16:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:57 INFO - 'NO_EM_RESTART': '1', 16:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:57 INFO - 'PWD': '/builds/slave/test', 16:11:57 INFO - 'SHELL': '/bin/bash', 16:11:57 INFO - 'SHLVL': '1', 16:11:57 INFO - 'TERM': 'linux', 16:11:57 INFO - 'TMOUT': '86400', 16:11:57 INFO - 'USER': 'cltbld', 16:11:57 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', 16:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:57 INFO - '_': '/tools/buildbot/bin/python'} 16:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:57 INFO - Downloading/unpacking blobuploader==1.2.4 16:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:58 INFO - Downloading blobuploader-1.2.4.tar.gz 16:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:11:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:11: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 16:11: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 16:11: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 16:11: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 16:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:11:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:11: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 16:11: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 16:11: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 16:11: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 16:11:58 INFO - Downloading docopt-0.6.1.tar.gz 16:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:11:59 INFO - Installing collected packages: blobuploader, requests, docopt 16:11:59 INFO - Running setup.py install for blobuploader 16:11:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:11:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:11:59 INFO - Running setup.py install for requests 16:11:59 INFO - Running setup.py install for docopt 16:11:59 INFO - Successfully installed blobuploader requests docopt 16:11:59 INFO - Cleaning up... 16:11:59 INFO - Return code: 0 16:11:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11: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')]} 16:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11: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 0x1ff11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235bd60>, '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 0x235ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235cef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', '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 16:11: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 16:11: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 16:11:59 INFO - Using env: {'DISPLAY': ':0', 16:11:59 INFO - 'HOME': '/home/cltbld', 16:11:59 INFO - 'LANG': 'en_US.UTF-8', 16:11:59 INFO - 'LANGUAGE': 'en_US:en', 16:11:59 INFO - 'LOGNAME': 'cltbld', 16:11:59 INFO - 'MAIL': '/var/mail/cltbld', 16:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:59 INFO - 'MOZ_NO_REMOTE': '1', 16:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:59 INFO - 'NO_EM_RESTART': '1', 16:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:59 INFO - 'PWD': '/builds/slave/test', 16:11:59 INFO - 'SHELL': '/bin/bash', 16:11:59 INFO - 'SHLVL': '1', 16:11:59 INFO - 'TERM': 'linux', 16:11:59 INFO - 'TMOUT': '86400', 16:11:59 INFO - 'USER': 'cltbld', 16:11:59 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', 16:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:59 INFO - '_': '/tools/buildbot/bin/python'} 16:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:59 INFO - Running setup.py (path:/tmp/pip-MPi2ER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:59 INFO - Running setup.py (path:/tmp/pip-FPr3Q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:59 INFO - Running setup.py (path:/tmp/pip-WrnoWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:00 INFO - Running setup.py (path:/tmp/pip-Vz2ich-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:00 INFO - Running setup.py (path:/tmp/pip-efk2fF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:00 INFO - Running setup.py (path:/tmp/pip-gMEU9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:00 INFO - Running setup.py (path:/tmp/pip-oBkEk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:00 INFO - Running setup.py (path:/tmp/pip-hFN3uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:00 INFO - Running setup.py (path:/tmp/pip-laKs3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:00 INFO - Running setup.py (path:/tmp/pip-NfOOwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:00 INFO - Running setup.py (path:/tmp/pip-ffIVsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:00 INFO - Running setup.py (path:/tmp/pip-dHclKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:00 INFO - Running setup.py (path:/tmp/pip-08jCMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:00 INFO - Running setup.py (path:/tmp/pip-lhsURM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:00 INFO - Running setup.py (path:/tmp/pip-PH06wG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:00 INFO - Running setup.py (path:/tmp/pip-H1HFbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:00 INFO - Running setup.py (path:/tmp/pip-cU4uBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:12:01 INFO - Running setup.py install for manifestparser 16:12:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:12:01 INFO - Running setup.py install for mozcrash 16:12:01 INFO - Running setup.py install for mozdebug 16:12:01 INFO - Running setup.py install for mozdevice 16:12:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:12:01 INFO - Running setup.py install for mozfile 16:12:01 INFO - Running setup.py install for mozhttpd 16:12:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:12:01 INFO - Running setup.py install for mozinfo 16:12:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:12:01 INFO - Running setup.py install for mozInstall 16:12:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:12:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:12:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:12:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:12:01 INFO - Running setup.py install for mozleak 16:12:01 INFO - Running setup.py install for mozlog 16:12:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:12:02 INFO - Running setup.py install for moznetwork 16:12:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:12:02 INFO - Running setup.py install for mozprocess 16:12:02 INFO - Running setup.py install for mozprofile 16:12:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:12:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:12:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:12:02 INFO - Running setup.py install for mozrunner 16:12:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:12:02 INFO - Running setup.py install for mozscreenshot 16:12:02 INFO - Running setup.py install for moztest 16:12:02 INFO - Running setup.py install for mozversion 16:12:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:12:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:12:02 INFO - Cleaning up... 16:12:02 INFO - Return code: 0 16:12:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12: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')]} 16:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12: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 0x1ff11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235bd60>, '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 0x235ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235cef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', '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 16:12: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 16:12: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 16:12:02 INFO - Using env: {'DISPLAY': ':0', 16:12:02 INFO - 'HOME': '/home/cltbld', 16:12:02 INFO - 'LANG': 'en_US.UTF-8', 16:12:02 INFO - 'LANGUAGE': 'en_US:en', 16:12:02 INFO - 'LOGNAME': 'cltbld', 16:12:02 INFO - 'MAIL': '/var/mail/cltbld', 16:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:02 INFO - 'MOZ_NO_REMOTE': '1', 16:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:02 INFO - 'NO_EM_RESTART': '1', 16:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:02 INFO - 'PWD': '/builds/slave/test', 16:12:02 INFO - 'SHELL': '/bin/bash', 16:12:02 INFO - 'SHLVL': '1', 16:12:02 INFO - 'TERM': 'linux', 16:12:02 INFO - 'TMOUT': '86400', 16:12:02 INFO - 'USER': 'cltbld', 16:12:02 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', 16:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:02 INFO - '_': '/tools/buildbot/bin/python'} 16:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:03 INFO - Running setup.py (path:/tmp/pip-w9Dw1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:03 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)) 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:03 INFO - Running setup.py (path:/tmp/pip-pZD8UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:03 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)) 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:03 INFO - Running setup.py (path:/tmp/pip-009m_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:03 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)) 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:03 INFO - Running setup.py (path:/tmp/pip-M0HunG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:03 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)) 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:03 INFO - Running setup.py (path:/tmp/pip-xHBfia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:03 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)) 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:03 INFO - Running setup.py (path:/tmp/pip-Or5vCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12: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)) 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:03 INFO - Running setup.py (path:/tmp/pip-BQ6eAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12: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)) 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:03 INFO - Running setup.py (path:/tmp/pip-xkgnc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12: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)) 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:03 INFO - Running setup.py (path:/tmp/pip-kdtZct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12: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)) 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:03 INFO - Running setup.py (path:/tmp/pip-kgaPW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12: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)) 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:03 INFO - Running setup.py (path:/tmp/pip-oAmQ_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12: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)) 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:03 INFO - Running setup.py (path:/tmp/pip-zwSeUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12: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)) 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:03 INFO - Running setup.py (path:/tmp/pip-uecJIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12: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)) 16:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:03 INFO - Running setup.py (path:/tmp/pip-z5X5N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:04 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)) 16:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:04 INFO - Running setup.py (path:/tmp/pip-2N0hs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:04 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)) 16:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:04 INFO - Running setup.py (path:/tmp/pip-Kyjfib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:04 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)) 16:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:04 INFO - Running setup.py (path:/tmp/pip-oNsLPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:04 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)) 16:12:04 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)) 16:12:04 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)) 16:12:04 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)) 16:12:04 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)) 16:12:04 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)) 16:12:04 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)) 16:12:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:05 INFO - Downloading blessings-1.6.tar.gz 16:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:12:05 INFO - Installing collected packages: blessings 16:12:05 INFO - Running setup.py install for blessings 16:12:05 INFO - Successfully installed blessings 16:12:05 INFO - Cleaning up... 16:12:05 INFO - Return code: 0 16:12:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:12:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:05 INFO - Reading from file tmpfile_stdout 16:12:05 INFO - Current package versions: 16:12:05 INFO - argparse == 1.2.1 16:12:05 INFO - blessings == 1.6 16:12:05 INFO - blobuploader == 1.2.4 16:12:05 INFO - docopt == 0.6.1 16:12:05 INFO - functools32 == 3.2.3-2 16:12:05 INFO - jsonschema == 2.5.1 16:12:05 INFO - manifestparser == 1.1 16:12:05 INFO - mozInstall == 1.13 16:12:05 INFO - mozcrash == 1.0 16:12:05 INFO - mozdebug == 0.1 16:12:05 INFO - mozdevice == 0.51 16:12:05 INFO - mozfile == 1.2 16:12:05 INFO - mozhttpd == 0.7 16:12:05 INFO - mozinfo == 0.10 16:12:05 INFO - mozleak == 0.1 16:12:05 INFO - mozlog == 3.5 16:12:05 INFO - moznetwork == 0.27 16:12:05 INFO - mozprocess == 0.25 16:12:05 INFO - mozprofile == 0.28 16:12:05 INFO - mozrunner == 6.13 16:12:05 INFO - mozscreenshot == 0.1 16:12:05 INFO - mozsystemmonitor == 0.3 16:12:05 INFO - moztest == 0.8 16:12:05 INFO - mozversion == 1.4 16:12:05 INFO - psutil == 3.1.1 16:12:05 INFO - requests == 1.2.3 16:12:05 INFO - wsgiref == 0.1.2 16:12:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12: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')]} 16:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12: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 0x1ff11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235bd60>, '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 0x235ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235cef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', '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 16:12: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 16:12: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 16:12:05 INFO - Using env: {'DISPLAY': ':0', 16:12:05 INFO - 'HOME': '/home/cltbld', 16:12:05 INFO - 'LANG': 'en_US.UTF-8', 16:12:05 INFO - 'LANGUAGE': 'en_US:en', 16:12:05 INFO - 'LOGNAME': 'cltbld', 16:12:05 INFO - 'MAIL': '/var/mail/cltbld', 16:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:05 INFO - 'MOZ_NO_REMOTE': '1', 16:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:05 INFO - 'NO_EM_RESTART': '1', 16:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:05 INFO - 'PWD': '/builds/slave/test', 16:12:05 INFO - 'SHELL': '/bin/bash', 16:12:05 INFO - 'SHLVL': '1', 16:12:05 INFO - 'TERM': 'linux', 16:12:05 INFO - 'TMOUT': '86400', 16:12:05 INFO - 'USER': 'cltbld', 16:12:05 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', 16:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:05 INFO - '_': '/tools/buildbot/bin/python'} 16:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:06 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)) 16:12:06 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)) 16:12:06 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)) 16:12:06 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)) 16:12:06 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)) 16:12:06 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)) 16:12:06 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)) 16:12:06 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)) 16:12:06 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)) 16:12:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:12:07 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)) 16:12:07 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)) 16:12:07 INFO - Installing collected packages: simplejson 16:12:07 INFO - Running setup.py install for simplejson 16:12:07 INFO - building 'simplejson._speedups' extension 16:12:07 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 16:12:08 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 16:12:08 INFO - Successfully installed simplejson 16:12:08 INFO - Cleaning up... 16:12:08 INFO - Return code: 0 16:12:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:08 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 0x1ff11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235bd60>, '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 0x235ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235cef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', '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 16:12:08 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 16:12:08 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 16:12:08 INFO - Using env: {'DISPLAY': ':0', 16:12:08 INFO - 'HOME': '/home/cltbld', 16:12:08 INFO - 'LANG': 'en_US.UTF-8', 16:12:08 INFO - 'LANGUAGE': 'en_US:en', 16:12:08 INFO - 'LOGNAME': 'cltbld', 16:12:08 INFO - 'MAIL': '/var/mail/cltbld', 16:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:08 INFO - 'MOZ_NO_REMOTE': '1', 16:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:08 INFO - 'NO_EM_RESTART': '1', 16:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:08 INFO - 'PWD': '/builds/slave/test', 16:12:08 INFO - 'SHELL': '/bin/bash', 16:12:08 INFO - 'SHLVL': '1', 16:12:08 INFO - 'TERM': 'linux', 16:12:08 INFO - 'TMOUT': '86400', 16:12:08 INFO - 'USER': 'cltbld', 16:12:08 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', 16:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:08 INFO - '_': '/tools/buildbot/bin/python'} 16:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:12:08 INFO - Cleaning up... 16:12:08 INFO - Return code: 0 16:12:08 INFO - Running post-action listener: _resource_record_post_action 16:12:08 INFO - Running post-action listener: _start_resource_monitoring 16:12:08 INFO - Starting resource monitoring. 16:12:08 INFO - [mozharness: 2017-09-24 23:12:08.511601Z] Finished create-virtualenv step (success) 16:12:08 INFO - [mozharness: 2017-09-24 23:12:08.512126Z] Running install step. 16:12:08 INFO - Running pre-action listener: _resource_record_pre_action 16:12:08 INFO - Running main action method: install 16:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:08 INFO - Reading from file tmpfile_stdout 16:12:08 INFO - Detecting whether we're running mozinstall >=1.0... 16:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:12:08 INFO - Reading from file tmpfile_stdout 16:12:08 INFO - Output received: 16:12:08 INFO - Usage: mozinstall [options] installer 16:12:08 INFO - Options: 16:12:08 INFO - -h, --help show this help message and exit 16:12:08 INFO - -d DEST, --destination=DEST 16:12:08 INFO - Directory to install application into. [default: 16:12:08 INFO - "/builds/slave/test"] 16:12:08 INFO - --app=APP Application being installed. [default: firefox] 16:12:08 INFO - mkdir: /builds/slave/test/build/application 16:12: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'] 16:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:12:26 INFO - Reading from file tmpfile_stdout 16:12:26 INFO - Output received: 16:12:26 INFO - /builds/slave/test/build/application/firefox/firefox 16:12:26 INFO - Running post-action listener: _resource_record_post_action 16:12:26 INFO - [mozharness: 2017-09-24 23:12:26.613436Z] Finished install step (success) 16:12:26 INFO - [mozharness: 2017-09-24 23:12:26.613583Z] Running setup-mitmproxy step. 16:12:26 INFO - Running pre-action listener: _resource_record_pre_action 16:12:26 INFO - Running main action method: setup_mitmproxy 16:12:26 INFO - Skipping: mitmproxy is not required 16:12:26 INFO - Running post-action listener: _resource_record_post_action 16:12:26 INFO - [mozharness: 2017-09-24 23:12:26.614376Z] Finished setup-mitmproxy step (success) 16:12:26 INFO - [mozharness: 2017-09-24 23:12:26.614597Z] Running run-tests step. 16:12:26 INFO - Running pre-action listener: _resource_record_pre_action 16:12:26 INFO - Running pre-action listener: _set_gcov_prefix 16:12:26 INFO - Running main action method: run_tests 16:12:26 WARNING - Try message not found. 16:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:12:26 INFO - Python 2.7.3 16:12:26 INFO - Return code: 0 16:12:26 INFO - grabbing minidump binary from tooltool 16:12: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')]} 16:12: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 0x235bd60>, '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 0x235ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235cef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:12: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 16:12: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 16:12: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 16:12:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:12:26 INFO - Return code: 0 16:12:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:12:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:12:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:12:26 INFO - ENV: RUST_BACKTRACE is now full 16:12:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:12:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:12: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/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--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 16:12: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/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-073 --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 16:12:26 INFO - Using env: {'DISPLAY': ':0', 16:12:26 INFO - 'HOME': '/home/cltbld', 16:12:26 INFO - 'LANG': 'en_US.UTF-8', 16:12:26 INFO - 'LANGUAGE': 'en_US:en', 16:12:26 INFO - 'LOGNAME': 'cltbld', 16:12:26 INFO - 'MAIL': '/var/mail/cltbld', 16:12:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:12:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:26 INFO - 'MOZ_NO_REMOTE': '1', 16:12:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:26 INFO - 'NO_EM_RESTART': '1', 16:12:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:26 INFO - 'PWD': '/builds/slave/test', 16:12:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:12:26 INFO - 'RUST_BACKTRACE': 'full', 16:12:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:12:26 INFO - 'SHELL': '/bin/bash', 16:12:26 INFO - 'SHLVL': '1', 16:12:26 INFO - 'TERM': 'linux', 16:12:26 INFO - 'TMOUT': '86400', 16:12:26 INFO - 'USER': 'cltbld', 16:12:26 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', 16:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:26 INFO - '_': '/tools/buildbot/bin/python'} 16:12: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/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--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 16:12:26 INFO - mozversion application_buildid: 20170924215115 16:12:26 INFO - mozversion application_changeset: d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4 16:12:26 INFO - mozversion application_display_name: Nightly 16:12:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:12:26 INFO - mozversion application_name: Firefox 16:12:26 INFO - mozversion application_remotingname: firefox 16:12:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:12:26 INFO - mozversion application_vendor: Mozilla 16:12:26 INFO - mozversion application_version: 58.0a1 16:12:26 INFO - mozversion platform_buildid: 20170924215115 16:12:26 INFO - mozversion platform_changeset: d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4 16:12:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:12:26 INFO - mozversion platform_version: 58.0a1 16:12:26 INFO - using testdate: 1506294746 16:12:26 INFO - actual date: 1506294746 16:12:26 INFO - starting webserver on 'localhost:44297' 16:12:26 INFO - SUITE-START | Running 2 tests 16:12:26 INFO - TEST-START | dromaeo_css 16:12:26 INFO - Initialising browser for dromaeo_css test... 16:12:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44297/getInfo.html -profile /tmp/tmpLHcsKO/profile 16:12:26 INFO - TEST-INFO | started process 5131 (/builds/slave/test/build/application/firefox/firefox http://localhost:44297/getInfo.html) 16:12:31 INFO - TEST-INFO | 5131: exit 0 16:12:32 INFO - Browser initialized. 16:12:32 INFO - Running cycle 1/1 for dromaeo_css test... 16:12:32 INFO - Using env: {'DISPLAY': ':0', 16:12:32 INFO - 'HOME': '/home/cltbld', 16:12:32 INFO - 'JSGC_DISABLE_POISONING': '1', 16:12:32 INFO - 'LANG': 'en_US.UTF-8', 16:12:32 INFO - 'LANGUAGE': 'en_US:en', 16:12:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:12:32 INFO - 'LOGNAME': 'cltbld', 16:12:32 INFO - 'MAIL': '/var/mail/cltbld', 16:12:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:12:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:12:32 INFO - 'MOZ_CRASHREPORTER': '1', 16:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:12:32 INFO - 'MOZ_NO_REMOTE': '1', 16:12:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:32 INFO - 'NO_EM_RESTART': '1', 16:12:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:32 INFO - 'PWD': '/builds/slave/test', 16:12:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:12:32 INFO - 'RUST_BACKTRACE': 'full', 16:12:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:12:32 INFO - 'SHELL': '/bin/bash', 16:12:32 INFO - 'SHLVL': '1', 16:12:32 INFO - 'STYLO_FORCE_DISABLED': '1', 16:12:32 INFO - 'TERM': 'linux', 16:12:32 INFO - 'TMOUT': '86400', 16:12:32 INFO - 'USER': 'cltbld', 16:12:32 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', 16:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:32 INFO - '_': '/tools/buildbot/bin/python'} 16:12:32 INFO - TEST-INFO | started process 5364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLHcsKO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:32 INFO - PID 5364 | 16:12:32 INFO - PID 5364 | (/builds/slave/test/build/application/firefox/firefox:5413): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:12:32 INFO - PID 5364 | 16:12:43 INFO - PID 5364 | RSS: Main: 146628608 16:12:43 INFO - PID 5364 | 16:15:40 INFO - PID 5364 | Cycle 1(1): loaded http://localhost:44297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44297/tests/dromaeo/cssquery-ext.html) 16:15:41 INFO - PID 5364 | RSS: Main: 147562496 16:15:41 INFO - PID 5364 | 16:18:43 INFO - PID 5364 | Cycle 1(1): loaded http://localhost:44297/tests/dromaeo/cssquery-ext.html (next: http://localhost:44297/tests/dromaeo/cssquery-jquery.html) 16:18:44 INFO - PID 5364 | RSS: Main: 146706432 16:18:44 INFO - PID 5364 | 16:21:45 INFO - PID 5364 | Cycle 1(1): loaded http://localhost:44297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44297/tests/dromaeo/cssquery-mootools.html) 16:21:46 INFO - PID 5364 | RSS: Main: 149454848 16:21:46 INFO - PID 5364 | 16:24:47 INFO - PID 5364 | Cycle 1(1): loaded http://localhost:44297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44297/tests/dromaeo/cssquery-prototype.html) 16:24:48 INFO - PID 5364 | RSS: Main: 147644416 16:24:48 INFO - PID 5364 | 16:27:51 INFO - PID 5364 | Cycle 1(1): loaded http://localhost:44297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44297/tests/dromaeo/cssquery-yui.html) 16:27:52 INFO - PID 5364 | RSS: Main: 149389312 16:27:52 INFO - PID 5364 | 16:30:53 INFO - PID 5364 | Cycle 1(1): loaded http://localhost:44297/tests/dromaeo/cssquery-yui.html (next: http://localhost:44297/tests/dromaeo/cssquery-dojo.html) 16:30:53 INFO - PID 5364 | RSS: Main: 149315584 16:30:53 INFO - PID 5364 | 16:30:53 INFO - PID 5364 | __start_tp_report 16:30:53 INFO - PID 5364 | _x_x_mozilla_page_load 16:30:53 INFO - PID 5364 | _x_x_mozilla_page_load_details 16:30:53 INFO - PID 5364 | |i|pagename|runs| 16:30:53 INFO - PID 5364 | |0;dojo.html;3841.442990766339;3847.3651847445162;3863.3625451800453;3866.3040652682525;3882.475865758122;6227.564070515065;6294.559380843343;6298.590591611548;6356.777512787054;6453.35466453355;6270.372962703727;6289.245290565127;6395.328490508487;6397.904031439521;6463.709133089011;5657.179708942201;5662.8301150965535;5690.60165788395;5720.685362305061;5733.569982251327;1000.4890330599163;5542.334919809628;5580.441955804407;5743.4543718346695;5762.855928601797;5541.445855414447;5638.943610563882;5730.656160630355;5743.684097374643;5770.816982518573;5695;5705.4294570543025;5759.942400575983;5762.394948530427;5771.422857714195;5648.181013752983;5671.262735844314;5672.914906276409;5700.971495142498;5703;6250.312465628777;6290.119383286344;6294.150289710876;6336.398042185985;6379.808605741835;6695.296993815677;6811.761588344434;6844.21291551468;6852.794416167523;6969.7909062728195;6913.75801846938;6946.583205007716;6971.3028697130385;6992.091028166356;6996.650167491605;6378.968105159491;6455.644939528371;6457.515686323544;6513.934860651428;6532.934670653281;7090.751823686146;7104.467164962649;7149.785506434815;7215.025971493781;7227.241139680363;6829.6243706596615;6886;6891.414229790424;6919.100516932766;6924.376806087476;6755.392014718601;6900.758473453405;6919.619420931897;6943.861122777516;6994.300569943067;6834.1457317835275;6871.175458944858;6912.55068420551;6921.792346229621;6927.896081558781;6754.527183097136;6911.03245545624;6928.7228510859;6931.549449285882;6936.7572134975035;5006.4492905780335;5013.248012798036;5081.034603425412;5082.847514574569;5085.364329458817;4505.07645932583;4570.794314255866;4599.195140850338;4601.6548758842555;4607.516210797818;6040.365761595057;6198.907016394758;6251.12484252205;6252.437280644764;6267.6866156691985;6852.383285504229;6916.3429474199875;6923.169219693669;6951.478639102088;6982.26686197952;6238.282597501346;6287.245530536365;6323.241211054703;6337.873242535124;6407.295197528269;5422.728863556807;5526.115821468627;5584.134459158837;5604.299462567179;5639;7092.822679433056;7148.964255178691;7155.391791697764;7171.282871712787;7191.712331506681;6848.623325717133;6851.657417129223;6871.175458944958;6932.064171337007;6957.826054348682;6865.828354291183;7007.439404847498;7092.5389849659605;7106.289371062852;7212.603306818175;6793.694283757144;6893.310668933066;6894.689738961859;6898.758543450955;6901.413379862768;6868.896966545406;6888.793336199922;6924.134483189601;6952.965235173791;6955.061066755923;6535;6632.436242919213;6662.100616416722;6666.366695163952;6667.866462701256;6511.674416279072;6518.57629254097;6530.151080359713;6530.346965303432;6548.148740663683;6446.645434501147;6483.513736469689;6510.544261901621;6563;6582.407583317525;6696.564723293165;6714.52998290115;6805.353491418307;6820.761273355409;6831.248562658203;6385.393387628168;6464.0627109069865;6474.0612611172055;6528.934710652833;6567.802965911031 16:30:53 INFO - PID 5364 | |1;ext.html;930.1860871737232;932.2635118256582;961.8076384723055;980.436249156735;984.9113579777819;44212.11575768483;45157.54842451574;45265;45345.093098138015;45497.54502454974;47334.52665473344;47786.761066194704;47801.760991195;47823.521764782345;47843.28235076468;8476.533790641528;8638.17937295956;8648;8651.524166170859;8660.480371177719;8369.246767790897;8495.575221238943;8513.574321283942;8539.74380768578;8540.444871083391;8469.407141500098;8532.70135545256;8606.956965215166;8608.56957152143;8610.182032706914;8525.531095789729;8546.786330341729;8561.95719021404;8563.400561960696;8570;8347.916520834775;8393.992720873533;8452.915470845335;8474.872876906851;8475.406721529496;40842.59157408447;41390;41411;41420.58579414227;41421.1715765683;3660.249648821985;3674.6692797648075;3694.519712437366;3698.815059247027;3701.0747313171705;33772;33885;34038.82980585106;34198.14504637379;34305;5407.324084489439;5480.972595137038;5485.259489968843;5540.418256083134;5546.084895992157;214635;215070;215148;215976;216446;51812.48187518077;52263;56144.438555613924;56955.43044569584;57129;60236;60312.396876031555;60392.094118588255;60413.39586604077;60476.697616511636;16841.41055063067;16940.40708575194;17149.314027439013;17171.570710732332;17230.138493075297;13566;13573.59279221625;13617;13691.589252322447;13692.246926419142;16181.514554563382;16226.918865405834;16228.918855405647;16300.021998680117;16322.673546529002;6276.905846412307;6349.396807303298;6373;6422.935770642327;6462.159919210472;1103.1175059952006;1104.6023431564631;1114.9331040137617;1116.0736588631416;1119.921605487608;25832.48335033289;25962.09132680347;26090.086846960647;26206.73793262081;26283.868580656974;1204.27141579345;1218.1351240619083;1227.3249712658003;1234.9320787356783;1239.2007155384727;13558.525451609146;13690.726185476235;13745.587632371045;13987;13993.860061399459;266006;268207;268241;268265;268353;63650.36349636537;65052;65130;65504.672476637315;65557;1487.1671863756114;1512.3421311729433;1528.709545186411;1533.811296245441;1538.7461068923503;31035;31105;31609.051728448183;32269.51595726113;32291.677083228868;43400.13199735925;43831.34252986272;43980.78009609931;44058.55941440545;44075.11849763051;252884;253130;255987;256341;256837;36333.0916727084;37113;37941.81029094837;38130.809345953094;38174.61825381822;47578;48343;48903.510964889894;48990.265146022124;49135.262971056174;35294;35446.64553354433;35457;35545.644543554234;35884.28231435409;34832.65167348395;34971.30057398888;35030;35461.82269088638;35521;40241;41663.16673666449;41741.58258417377;41791.164176716906;41907.7904610475;33631.15922101967;34178.65821341755;34337.48493772546;34499;34699.4795078069;25620.61569076428;25957.846744520786;26057.218283451526;26520.602190966765;26664.733352666226 16:30:53 INFO - PID 5364 | |2;jquery.html;622.785139127001;626.4299487466407;628.1174949196379;628.1394489549318;648.7340190521887;23158;24053.278401647935;24097.879510602444;24109.879450602722;24841.25476235716;26326.210213693572;27323.45353092942;27331.180064598044;27336;27354.179374618743;6796.422304104145;6923.584584924895;6928.2725313842075;6928.861422771542;6935.063766391523;6593.571417857824;6839.692213850364;6858.862822743542;6869.519133660646;6896.275891031445;6800.149981252343;6807.217170025436;6817.795466135999;6822.215445223788;6828.48786341024;6795.252522222551;6797.252302246774;6802.38778509934;6826.658667066677;6831.180258368978;6312.968435157841;6315.778947736853;6360.491160707133;6378.585391949555;6384.297727249998;30538.389232215453;30850.382992340026;31571;31671.683283167335;31858.840705796556;2241.181968581472;2280.441291883483;2282.395165281202;2284.7486776454575;2285.108807565051;20737.170513179455;21079.789202107935;21110.788892111188;21207.363779086652;21363.67954480684;2462.963055554168;2539.212844018342;2579.1488808693084;2581.838172822219;2582.173704414588;143747.28126359405;150504;156739;161102.19448902798;161653;16488.505344839676;16696;16715.749263761052;17010.914945425193;17365.565860853327;27084.458310833674;27115.1865444037;27253.318667033087;27265.591016134775;27279.727202727718;10921.399323037309;10945.616903408343;11027.786943436216;11099.778004439866;11245.887541124648;9960.605515227873;9968.80062398748;10024.19806415485;10030.799384012278;10215.744606384751;9897.950510247403;9941.850872236922;10029;10111.7472063199;10130.81351839484;2941.382309714941;2995.176326510227;2996.580478732979;3015.472292348874;3061.6019917410595;1039.8492218628407;1043.2592859069994;1056.8309070548676;1059.3220338983058;1076.4025965589017;21959.780402195775;21962.560748784934;22046.228382006873;22157.66763498549;22671.546569068858;1109.628274528042;1112.7996960547018;1114.3481063577735;1114.8550688410617;1130.4912789244872;11946.820797688042;12275.263484190977;12384.256944583354;12402.75194496123;12537.561185358469;572793;589844;595364;595819;598447;129976;131840;132610.33694831465;132958;133807.33096334455;1243.4715246020405;1243.9253644781343;1271.6693659648558;1273.4333221716247;1277.8402699662543;19626.803731963068;19716.90141549283;19975.20099196016;19984.300549480697;20068.197272109537;63111.6844415775;63311.6834415825;63322.36677633165;64949.35050649433;65451.34548654643;79740;79814;80205;81066.5946670263;83566.58216709121;16253.268602912662;16483;16589.336426542803;16630.085345306125;16661.333546658;22699.773002270427;22801.429964251027;23336.18323358742;23343.41641458909;23378.532429350977;20555.58888822245;20799.480012999797;20914.47713807167;20930.37208883736;21199.576008480053;16791.832081679026;17481.300747969937;17540.82459175392;17911.820881791016;17936.82063179404;18027.729584056513;18082.367117150836;18165.545861353043;18250.36123735663;20675.68986465174;14534.05528640635;14540.200288984208;14543.200123993282;14579.562613121623;14656.633584160054;18943.526411839815;19197.232110715417;19284.517887052934;20618.278360257318;20834.374968750963 16:30:53 INFO - PID 5364 | |3;mootools.html;1419.5102689572097;1458.7228426598952;1470.088545102037;1480.252472501387;1480.9851901480981;16537.421190258345;17405.56486087847;17415.73876391855;17416.564585885328;17421.128943552834;16888.83111168888;17067.91466042668;17075.060871652055;17080.23138958747;17098.914505427485;2622.816402851806;2718.537848565739;2718.565029595265;2728.672559292888;2733.9726602734017;2702.9324266893386;2730.8361498310064;2741.561350183971;2745.1627253687616;2756.531389663762;2757.6139340492346;2858.042555743818;2859.642544681915;2860.027590619189;2860.6710228323695;2798.776097912162;2804.901828436005;2817.197098826835;2828.4484525517532;2829.2078218098964;2682.9597556036674;2871.253474096729;2876.022152468171;2876.1659118855505;2878.409925965193;16964.3214271429;17137.742933856003;17193.82806171935;17207.913960430244;17220.311187552485;8091.150429204908;8332.708355207538;8364.330853531703;8398.83202335956;8411.116832732536;5657.2928383952;5659.717014149276;5829.125631155318;5871.236739223874;5886.381929897342;2082.2087606709506;2140.7217061782026;2146.2809958663865;2173.6848157017303;2202.548477562112;30607.387852243053;30648.38703225923;30732.53901191484;30789.38421231563;30790.846045769627;7323.926760732431;7768.689252429839;7824.21757824213;8073.394495412867;8160.877586836202;19514.414567562995;19549.511262218275;19554.608907821763;19560.902195489216;19646.901765491082;8390.077091519928;8546.78633034179;8562.871556926651;8581.313494920392;8581.485110893242;7767.417443691746;7808.609569521501;7830.765077047698;7880.211978802074;7948.403869709795;5718.714064296769;5825.883482330414;5825.922204392201;5890.4979230296;5939.109133629903;1702.285040283084;1710.606560491069;1737.3224442467447;1740.817214192517;1758.5779412940801;960.5101398286924;964.1274646444979;983.4689267795453;996.7707427291764;1000.5547531348626;8396.118407567239;8469.703560375357;8474.1949514796;8534.53060081689;8540.060593334729;780.1106738318322;806.9435139540176;811.111832543364;820.6143112737004;824.8803923431069;5034.874128146753;5252.290940722954;5626.324841019104;5972.9328107390975;6196.597221180699;23605.645915311285;24836.130735424173;24895.128670496444;24971.375715606893;24983;23121.190758323377;24109.51780964371;24269.271921842374;24296.392590185387;24818.627720584205;12771.808422873664;12815.423305951255;12816.871831281755;12949.093563450657;13007.934960325327;9038.502882341272;9198.67804626835;9234.769130771785;9280.396774209656;9304.860427093734;20970.790292096885;21048.579028419652;21448.785512144677;21619.459513512287;21968.45078873041;21634.89182554077;21973.890130549244;21981.450463738536;22123.225687100876;22177.66733499031;12136.453859576517;12345.691357716129;12371.628851134481;12379.257244565355;12395.814062788884;15209.239538023276;15456.459023934558;15620.218989050729;15627.374905003673;15664;12547.686307842378;12921.741565168455;13013.414396352377;13182.934085329513;13290.006499024837;12418.254904705747;12443.626691199279;12492.37538123072;12829.294388808705;13032.804507932198;10119.848202276824;10173.389596624227;10180.949095254477;10280.794384112127;10303.484825758833;8269.95865020671;8369.539675317916;8379.329653627574;8437.831243375222;8524.318054555744;8171.673133074848;8275.54484503358;8303.377246706401;8308.792280193044;8364.749057528285 16:30:53 INFO - PID 5364 | |4;prototype.html;547.9479449452303;562.4797062716987;572.6420986883198;587.7531436796546;591.8402031451506;5816.360200377961;6126.142340072393;6187.412195841399;6192.78325258616;6338.271098823637;6048.004158627653;6080.939190608093;6092.66490343031;6116.510679145669;6135.8772824543485;4943.728094954776;4979.356812251966;4998.2752500887345;5023.246513023039;5034.910512137477;4880.755962201893;4953.628477864175;4973.278874563204;4985.750712464363;5037.395512538501;4949.133901567229;4957.876053098666;4971.875703107415;4993.925091123636;5030.6981581105065;4915.3364295819965;4918.680285781431;4951.331570238008;4979.47715489872;4981.12830254704;4421.668374871898;4464.419625448703;4504.909901801979;4548.704334218265;4571.8570357410645;6158.907616385758;6187.257529096492;6188;6204.410580994799;6210.223722034746;5727.1695604137585;5781.508571771405;5799.768009279624;5832.445917637818;5844.386339434383;6530.183727034121;6532.5753826001155;6566.277709451956;6580.703868325889;6600.86798264032;4863.78112984913;4974.253861920741;5030.144875371196;5037.899242015176;5048.924266136011;6524.93475065248;6707.899381509281;6813;6839.829004274933;6882.380585747307;5135.512126347991;5138.150265904272;5146.871328216825;5159.535641792257;5176.197689358156;5175.767090480937;5202.92195617066;5223.9439927642;5242.239875218148;5247.527722504993;5769.971150144306;5810.099434587646;5831.2184009112125;5841.88316233673;5849.590528663038;6591.703373348115;6608.966955165193;6626.801195964129;6629.3370662934285;6659.9001014984815;1773.6364045370667;1775.849052830524;1785.366195000782;1798.2447372103748;1803.4589623113013;1236.5902870727377;1288.368699337318;1293.1077556485996;1297.3642914971597;1306.1248963194682;6010;6086.147939288503;6143.941779503827;6149.96925015381;6189.96905015472;6543.280239173687;6617.834554136185;6622.503312251601;6642.568233064835;6807.65961701913;6140.631562106288;6227.470664993436;6233.438990490787;6240.188775459162;6242.968785156045;3448.8448019839166;3487.145649315934;3509.8069606171393;3514.683678468899;3530.223350862806;6803.149606299213;6805.591664500146;6983.580985140908;7005.719771209095;7033.402160816286;6750;6800.183977922681;6839.897401538981;6854.903215485598;6877.2091209510545;6693.698783554752;6822.9317706823285;6829.282925292872;6902.685821361649;6956.965215173993;6728.899066513908;6736;6747.224069232101;6756.898646520208;6767.89848152288;6674.632895190617;6683.699233534599;6722.394984451423;6749.628770417674;6750.32496750321;7035.47233957445;7037.437005039482;7038.260982596754;7054.400375967895;7086.574805511686;5190.143626301769;5207.29701490294;5207.76565054581;5215;5225.5558277545315;6429.357064293533;6542.378474044958;6614.8346291343105;6785.575029243717;6840.726370945106;6264.21697287839;6387.137736405712;6395.936040639534;6469.5794773339585;6502.414782669583;6355.586886852339;6395.136656551306;6432.742690292336;6463.741450341934;6523.18460192476;6246.718897649525;6284.591501552384;6290.8676438241555;6340.936590634219;6408.935910640834;6482.666240153447;6517.4460170886005;6535.673216339069;6555.2133743951035;6578.703958321791;6256.405641464054;6320.399562041599;6378.553501254868;6391.201099862517;6453.290138084901 16:30:53 INFO - PID 5364 | |5;yui.html;957.5164541906337;979.8285300072488;994.7264502261877;997.2620261006848;1006.2252065909248;20892.477688057807;21094;21098.789012109875;21175.258865939697;21182.99999999998;17963.371282005133;18081.81918180818;18084.638307233847;19431;19640.705389419134;1046.1787496815002;1079.9784004319908;1080.8324709670014;1082.5940272397852;1083.2471432354516;1066.4401189375562;1066.7599790047216;1069.6523629820301;1070.7751372211806;1070.9303895246824;1002.3584905660347;1128.582424502935;1130.4065365683;1131.6322195286523;1140.1278022312938;1131.660501849446;1135.5117299561186;1136.5794655977259;1137.1357768096223;1137.5051852444171;786.3276898252027;806.7741032510907;814.8940637717059;821.6795449774593;821.9589020549008;18203.817961820343;18247.817521824745;18289.725654115067;18314.26742930281;18348.724769128472;21888.671669924963;21938;22366.32901012956;22633.77366226333;22861.54276914469;18750.0624968751;18752.81247187538;18823.247070117315;19097.522561935923;19269.22923083075;3993.520777506689;4005.959940400588;4022.416749571296;4023.3361495353233;4023.758574485511;130696;162232;164883;166439;170290;18521.518278537686;18793.34223302178;19112.139953702117;19124;19406.70889936652;33559.32881342409;34307.48538771921;34611.4808277876;34858;35185.824070879484;10217.489125543692;10265.794684106277;10283.485825708685;10293.53679084443;10301;4677.134730074947;4678.391809064799;4697.976510117427;4764.190087685102;4774.594159496482;5983.790567330123;6035.094735789667;6067.787627433018;6075.149479072933;6092.39076092396;1214.4474264209764;1263.564070395712;1268.2200446725199;1282.0256604980282;1283.8716128387273;727.8871774874902;741.2032065529577;746.7834328044914;750.5421692767408;761.2767870523026;12534.937325313498;12685.302308372944;13394.598162055154;14177.5037873676;14287.714245715235;683.2552517755571;696.8153439338579;704.6089420371641;711.494838664554;713.7537549545399;5783.739731712083;5828.6502809831545;5919.644821310735;6003.789867354709;6018.2176317079375;149617;151171;151309;151843;153346.9330613404;126767.36616317045;127973.36013319874;129247;133674;138440;113422;114187;114818;118377;118655.99999999827;13498.52755153565;13584.592462226148;13879.167249965034;14023.298835058002;14572.271386430848;51441.228381575056;52899.73550132225;53154;54107.72946135244;54235;69042.96435553572;70872;93026.53486732523;95167;95945;20904.58190836205;21389.35831925045;21448.46378840479;21609.783902160776;21677.783222168207;20712.585748284648;21088.156473741492;21305.36083917485;23437.76562234356;23588.410289742893;20058.498537536678;20163.193472261533;20167.697484538035;20472.692909606667;20930.47673808167;19106.713399298744;19472.805271947098;19537.21851125939;20777.584448311252;21612.243571474923;19355.516112096746;19433.611327773648;19687.114079866726;21697.783022169577;22279.99740011671;13632.65918352049;13907.58277251684;14005.719885602028;14258.572242832732;14393.136411815325;15502.689946201239;15797.36810527566;16362.100084495467;16417;16638.3344666212 16:30:53 INFO - PID 5364 | __end_tp_report 16:30:53 INFO - PID 5364 | __start_cc_report 16:30:53 INFO - PID 5364 | _x_x_mozilla_cycle_collect,274 16:30:53 INFO - PID 5364 | __end_cc_report 16:30:53 INFO - PID 5364 | __startTimestamp1506295853797__endTimestamp 16:30:53 INFO - PID 5364 | 16:30:53 INFO - PID 5364 | ------- Summary: start ------- 16:30:53 INFO - PID 5364 | Number of tests: 6 16:30:53 INFO - PID 5364 | 16:30:53 INFO - PID 5364 | [#0] dojo.html Cycles:165 Average:6298.42 Median:6528.93 stddev:867.38 (13.3%) stddev-sans-first:848.35 16:30:53 INFO - PID 5364 | Values: 3841.4 3847.4 3863.4 3866.3 3882.5 6227.6 6294.6 6298.6 6356.8 6453.4 6270.4 6289.2 6395.3 6397.9 6463.7 5657.2 5662.8 5690.6 5720.7 5733.6 1000.5 5542.3 5580.4 5743.5 5762.9 5541.4 5638.9 5730.7 5743.7 5770.8 5695.0 5705.4 5759.9 5762.4 5771.4 5648.2 5671.3 5672.9 5701.0 5703.0 6250.3 6290.1 6294.2 6336.4 6379.8 6695.3 6811.8 6844.2 6852.8 6969.8 6913.8 6946.6 6971.3 6992.1 6996.7 6379.0 6455.6 6457.5 6513.9 6532.9 7090.8 7104.5 7149.8 7215.0 7227.2 6829.6 6886.0 6891.4 6919.1 6924.4 6755.4 6900.8 6919.6 6943.9 6994.3 6834.1 6871.2 6912.6 6921.8 6927.9 6754.5 6911.0 6928.7 6931.5 6936.8 5006.4 5013.2 5081.0 5082.8 5085.4 4505.1 4570.8 4599.2 4601.7 4607.5 6040.4 6198.9 6251.1 6252.4 6267.7 6852.4 6916.3 6923.2 6951.5 6982.3 6238.3 6287.2 6323.2 6337.9 6407.3 5422.7 5526.1 5584.1 5604.3 5639.0 7092.8 7149.0 7155.4 7171.3 7191.7 6848.6 6851.7 6871.2 6932.1 6957.8 6865.8 7007.4 7092.5 7106.3 7212.6 6793.7 6893.3 6894.7 6898.8 6901.4 6868.9 6888.8 6924.1 6953.0 6955.1 6535.0 6632.4 6662.1 6666.4 6667.9 6511.7 6518.6 6530.2 6530.3 6548.1 6446.6 6483.5 6510.5 6563.0 6582.4 6696.6 6714.5 6805.4 6820.8 6831.2 6385.4 6464.1 6474.1 6528.9 6567.8 16:30:53 INFO - PID 5364 | 16:30:53 INFO - PID 5364 | [#1] ext.html Cycles:180 Average:43632.04 Median:20407.04 stddev:64200.41 (314.6%) stddev-sans-first:64300.44 16:30:53 INFO - PID 5364 | Values: 930.2 932.3 961.8 980.4 984.9 44212.1 45157.5 45265.0 45345.1 45497.5 47334.5 47786.8 47801.8 47823.5 47843.3 8476.5 8638.2 8648.0 8651.5 8660.5 8369.2 8495.6 8513.6 8539.7 8540.4 8469.4 8532.7 8607.0 8608.6 8610.2 8525.5 8546.8 8562.0 8563.4 8570.0 8347.9 8394.0 8452.9 8474.9 8475.4 40842.6 41390.0 41411.0 41420.6 41421.2 3660.2 3674.7 3694.5 3698.8 3701.1 33772.0 33885.0 34038.8 34198.1 34305.0 5407.3 5481.0 5485.3 5540.4 5546.1 214635.0 215070.0 215148.0 215976.0 216446.0 51812.5 52263.0 56144.4 56955.4 57129.0 60236.0 60312.4 60392.1 60413.4 60476.7 16841.4 16940.4 17149.3 17171.6 17230.1 13566.0 13573.6 13617.0 13691.6 13692.2 16181.5 16226.9 16228.9 16300.0 16322.7 6276.9 6349.4 6373.0 6422.9 6462.2 1103.1 1104.6 1114.9 1116.1 1119.9 25832.5 25962.1 26090.1 26206.7 26283.9 1204.3 1218.1 1227.3 1234.9 1239.2 13558.5 13690.7 13745.6 13987.0 13993.9 266006.0 268207.0 268241.0 268265.0 268353.0 63650.4 65052.0 65130.0 65504.7 65557.0 1487.2 1512.3 1528.7 1533.8 1538.7 31035.0 31105.0 31609.1 32269.5 32291.7 43400.1 43831.3 43980.8 44058.6 44075.1 252884.0 253130.0 255987.0 256341.0 256837.0 36333.1 37113.0 37941.8 38130.8 38174.6 47578.0 48343.0 48903.5 48990.3 49135.3 35294.0 35446.6 35457.0 35545.6 35884.3 34832.7 34971.3 35030.0 35461.8 35521.0 40241.0 41663.2 41741.6 41791.2 41907.8 33631.2 34178.7 34337.5 34499.0 34699.5 25620.6 25957.8 26057.2 26520.6 26664.7 16:30:53 INFO - PID 5364 | 16:30:53 INFO - PID 5364 | [#2] jquery.html Cycles:180 Average:39779.34 Median:12456.36 stddev:99124.94 (795.8%) stddev-sans-first:99359.41 16:30:53 INFO - PID 5364 | Values: 622.8 626.4 628.1 628.1 648.7 23158.0 24053.3 24097.9 24109.9 24841.3 26326.2 27323.5 27331.2 27336.0 27354.2 6796.4 6923.6 6928.3 6928.9 6935.1 6593.6 6839.7 6858.9 6869.5 6896.3 6800.1 6807.2 6817.8 6822.2 6828.5 6795.3 6797.3 6802.4 6826.7 6831.2 6313.0 6315.8 6360.5 6378.6 6384.3 30538.4 30850.4 31571.0 31671.7 31858.8 2241.2 2280.4 2282.4 2284.7 2285.1 20737.2 21079.8 21110.8 21207.4 21363.7 2463.0 2539.2 2579.1 2581.8 2582.2 143747.3 150504.0 156739.0 161102.2 161653.0 16488.5 16696.0 16715.7 17010.9 17365.6 27084.5 27115.2 27253.3 27265.6 27279.7 10921.4 10945.6 11027.8 11099.8 11245.9 9960.6 9968.8 10024.2 10030.8 10215.7 9898.0 9941.9 10029.0 10111.7 10130.8 2941.4 2995.2 2996.6 3015.5 3061.6 1039.8 1043.3 1056.8 1059.3 1076.4 21959.8 21962.6 22046.2 22157.7 22671.5 1109.6 1112.8 1114.3 1114.9 1130.5 11946.8 12275.3 12384.3 12402.8 12537.6 572793.0 589844.0 595364.0 595819.0 598447.0 129976.0 131840.0 132610.3 132958.0 133807.3 1243.5 1243.9 1271.7 1273.4 1277.8 19626.8 19716.9 19975.2 19984.3 20068.2 63111.7 63311.7 63322.4 64949.4 65451.3 79740.0 79814.0 80205.0 81066.6 83566.6 16253.3 16483.0 16589.3 16630.1 16661.3 22699.8 22801.4 23336.2 23343.4 23378.5 20555.6 20799.5 20914.5 20930.4 21199.6 16791.8 17481.3 17540.8 17911.8 17936.8 18027.7 18082.4 18165.5 18250.4 20675.7 14534.1 14540.2 14543.2 14579.6 14656.6 18943.5 19197.2 19284.5 20618.3 20834.4 16:30:53 INFO - PID 5364 | 16:30:53 INFO - PID 5364 | [#3] mootools.html Cycles:180 Average:10434.45 Median:2723.62 stddev:7699.56 (282.7%) stddev-sans-first:7691.36 16:30:53 INFO - PID 5364 | Values: 1419.5 1458.7 1470.1 1480.3 1481.0 16537.4 17405.6 17415.7 17416.6 17421.1 16888.8 17067.9 17075.1 17080.2 17098.9 2622.8 2718.5 2718.6 2728.7 2734.0 2702.9 2730.8 2741.6 2745.2 2756.5 2757.6 2858.0 2859.6 2860.0 2860.7 2798.8 2804.9 2817.2 2828.4 2829.2 2683.0 2871.3 2876.0 2876.2 2878.4 16964.3 17137.7 17193.8 17207.9 17220.3 8091.2 8332.7 8364.3 8398.8 8411.1 5657.3 5659.7 5829.1 5871.2 5886.4 2082.2 2140.7 2146.3 2173.7 2202.5 30607.4 30648.4 30732.5 30789.4 30790.8 7323.9 7768.7 7824.2 8073.4 8160.9 19514.4 19549.5 19554.6 19560.9 19646.9 8390.1 8546.8 8562.9 8581.3 8581.5 7767.4 7808.6 7830.8 7880.2 7948.4 5718.7 5825.9 5825.9 5890.5 5939.1 1702.3 1710.6 1737.3 1740.8 1758.6 960.5 964.1 983.5 996.8 1000.6 8396.1 8469.7 8474.2 8534.5 8540.1 780.1 806.9 811.1 820.6 824.9 5034.9 5252.3 5626.3 5972.9 6196.6 23605.6 24836.1 24895.1 24971.4 24983.0 23121.2 24109.5 24269.3 24296.4 24818.6 12771.8 12815.4 12816.9 12949.1 13007.9 9038.5 9198.7 9234.8 9280.4 9304.9 20970.8 21048.6 21448.8 21619.5 21968.5 21634.9 21973.9 21981.5 22123.2 22177.7 12136.5 12345.7 12371.6 12379.3 12395.8 15209.2 15456.5 15620.2 15627.4 15664.0 12547.7 12921.7 13013.4 13182.9 13290.0 12418.3 12443.6 12492.4 12829.3 13032.8 10119.8 10173.4 10180.9 10280.8 10303.5 8270.0 8369.5 8379.3 8437.8 8524.3 8171.7 8275.5 8303.4 8308.8 8364.7 16:30:53 INFO - PID 5364 | 16:30:53 INFO - PID 5364 | [#4] prototype.html Cycles:180 Average:5579.28 Median:6188.98 stddev:1554.38 (25.1%) stddev-sans-first:1512.17 16:30:53 INFO - PID 5364 | Values: 547.9 562.5 572.6 587.8 591.8 5816.4 6126.1 6187.4 6192.8 6338.3 6048.0 6080.9 6092.7 6116.5 6135.9 4943.7 4979.4 4998.3 5023.2 5034.9 4880.8 4953.6 4973.3 4985.8 5037.4 4949.1 4957.9 4971.9 4993.9 5030.7 4915.3 4918.7 4951.3 4979.5 4981.1 4421.7 4464.4 4504.9 4548.7 4571.9 6158.9 6187.3 6188.0 6204.4 6210.2 5727.2 5781.5 5799.8 5832.4 5844.4 6530.2 6532.6 6566.3 6580.7 6600.9 4863.8 4974.3 5030.1 5037.9 5048.9 6524.9 6707.9 6813.0 6839.8 6882.4 5135.5 5138.2 5146.9 5159.5 5176.2 5175.8 5202.9 5223.9 5242.2 5247.5 5770.0 5810.1 5831.2 5841.9 5849.6 6591.7 6609.0 6626.8 6629.3 6659.9 1773.6 1775.8 1785.4 1798.2 1803.5 1236.6 1288.4 1293.1 1297.4 1306.1 6010.0 6086.1 6143.9 6150.0 6190.0 6543.3 6617.8 6622.5 6642.6 6807.7 6140.6 6227.5 6233.4 6240.2 6243.0 3448.8 3487.1 3509.8 3514.7 3530.2 6803.1 6805.6 6983.6 7005.7 7033.4 6750.0 6800.2 6839.9 6854.9 6877.2 6693.7 6822.9 6829.3 6902.7 6957.0 6728.9 6736.0 6747.2 6756.9 6767.9 6674.6 6683.7 6722.4 6749.6 6750.3 7035.5 7037.4 7038.3 7054.4 7086.6 5190.1 5207.3 5207.8 5215.0 5225.6 6429.4 6542.4 6614.8 6785.6 6840.7 6264.2 6387.1 6395.9 6469.6 6502.4 6355.6 6395.1 6432.7 6463.7 6523.2 6246.7 6284.6 6290.9 6340.9 6408.9 6482.7 6517.4 6535.7 6555.2 6578.7 6256.4 6320.4 6378.6 6391.2 6453.3 16:30:53 INFO - PID 5364 | 16:30:53 INFO - PID 5364 | [#5] yui.html Cycles:180 Average:29166.42 Median:19418.85 stddev:42739.58 (220.1%) stddev-sans-first:42806.99 16:30:53 INFO - PID 5364 | Values: 957.5 979.8 994.7 997.3 1006.2 20892.5 21094.0 21098.8 21175.3 21183.0 17963.4 18081.8 18084.6 19431.0 19640.7 1046.2 1080.0 1080.8 1082.6 1083.2 1066.4 1066.8 1069.7 1070.8 1070.9 1002.4 1128.6 1130.4 1131.6 1140.1 1131.7 1135.5 1136.6 1137.1 1137.5 786.3 806.8 814.9 821.7 822.0 18203.8 18247.8 18289.7 18314.3 18348.7 21888.7 21938.0 22366.3 22633.8 22861.5 18750.1 18752.8 18823.2 19097.5 19269.2 3993.5 4006.0 4022.4 4023.3 4023.8 130696.0 162232.0 164883.0 166439.0 170290.0 18521.5 18793.3 19112.1 19124.0 19406.7 33559.3 34307.5 34611.5 34858.0 35185.8 10217.5 10265.8 10283.5 10293.5 10301.0 4677.1 4678.4 4698.0 4764.2 4774.6 5983.8 6035.1 6067.8 6075.1 6092.4 1214.4 1263.6 1268.2 1282.0 1283.9 727.9 741.2 746.8 750.5 761.3 12534.9 12685.3 13394.6 14177.5 14287.7 683.3 696.8 704.6 711.5 713.8 5783.7 5828.7 5919.6 6003.8 6018.2 149617.0 151171.0 151309.0 151843.0 153346.9 126767.4 127973.4 129247.0 133674.0 138440.0 113422.0 114187.0 114818.0 118377.0 118656.0 13498.5 13584.6 13879.2 14023.3 14572.3 51441.2 52899.7 53154.0 54107.7 54235.0 69043.0 70872.0 93026.5 95167.0 95945.0 20904.6 21389.4 21448.5 21609.8 21677.8 20712.6 21088.2 21305.4 23437.8 23588.4 20058.5 20163.2 20167.7 20472.7 20930.5 19106.7 19472.8 19537.2 20777.6 21612.2 19355.5 19433.6 19687.1 21697.8 22280.0 13632.7 13907.6 14005.7 14258.6 14393.1 15502.7 15797.4 16362.1 16417.0 16638.3 16:30:53 INFO - PID 5364 | -------- Summary: end -------- 16:30:53 INFO - PID 5364 | 16:30:54 INFO - TEST-INFO | 5364: exit 0 16:30:54 INFO - TEST-OK | dromaeo_css | took 1107426ms 16:30:54 INFO - TEST-START | kraken 16:30:54 INFO - Initialising browser for kraken test... 16:30:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44297/getInfo.html -profile /tmp/tmpsR57aL/profile 16:30:54 INFO - TEST-INFO | started process 5735 (/builds/slave/test/build/application/firefox/firefox http://localhost:44297/getInfo.html) 16:30:59 INFO - TEST-INFO | 5735: exit 0 16:30:59 INFO - Browser initialized. 16:30:59 INFO - Running cycle 1/1 for kraken test... 16:30:59 INFO - Using env: {'DISPLAY': ':0', 16:30:59 INFO - 'HOME': '/home/cltbld', 16:30:59 INFO - 'JSGC_DISABLE_POISONING': '1', 16:30:59 INFO - 'LANG': 'en_US.UTF-8', 16:30:59 INFO - 'LANGUAGE': 'en_US:en', 16:30:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:30:59 INFO - 'LOGNAME': 'cltbld', 16:30:59 INFO - 'MAIL': '/var/mail/cltbld', 16:30:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:30:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:30:59 INFO - 'MOZ_CRASHREPORTER': '1', 16:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:30:59 INFO - 'MOZ_NO_REMOTE': '1', 16:30:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:59 INFO - 'NO_EM_RESTART': '1', 16:30:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:59 INFO - 'PWD': '/builds/slave/test', 16:30:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:30:59 INFO - 'RUST_BACKTRACE': 'full', 16:30:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:30:59 INFO - 'SHELL': '/bin/bash', 16:30:59 INFO - 'SHLVL': '1', 16:30:59 INFO - 'STYLO_FORCE_DISABLED': '1', 16:30:59 INFO - 'TERM': 'linux', 16:30:59 INFO - 'TMOUT': '86400', 16:30:59 INFO - 'USER': 'cltbld', 16:30:59 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798', 16:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:59 INFO - '_': '/tools/buildbot/bin/python'} 16:30:59 INFO - TEST-INFO | started process 5974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsR57aL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:00 INFO - PID 5974 | 16:31:00 INFO - PID 5974 | (/builds/slave/test/build/application/firefox/firefox:6024): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:31:00 INFO - PID 5974 | 16:31:10 INFO - PID 5974 | RSS: Main: 144723968 16:31:10 INFO - PID 5974 | 16:31:13 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44297/tests/kraken/driver.html?testName=audio-beat-detection) 16:31:13 INFO - PID 5974 | RSS: Main: 150749184 16:31:13 INFO - PID 5974 | 16:31:16 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44297/tests/kraken/driver.html?testName=audio-dft) 16:31:17 INFO - PID 5974 | RSS: Main: 151011328 16:31:17 INFO - PID 5974 | 16:31:19 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44297/tests/kraken/driver.html?testName=audio-fft) 16:31:20 INFO - PID 5974 | RSS: Main: 147877888 16:31:20 INFO - PID 5974 | 16:31:22 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44297/tests/kraken/driver.html?testName=audio-oscillator) 16:31:23 INFO - PID 5974 | RSS: Main: 148889600 16:31:23 INFO - PID 5974 | 16:31:25 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:31:25 INFO - PID 5974 | RSS: Main: 148054016 16:31:25 INFO - PID 5974 | 16:31:28 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44297/tests/kraken/driver.html?testName=imaging-darkroom) 16:31:29 INFO - PID 5974 | RSS: Main: 148451328 16:31:29 INFO - PID 5974 | 16:31:33 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44297/tests/kraken/driver.html?testName=imaging-desaturate) 16:31:33 INFO - PID 5974 | RSS: Main: 150351872 16:31:33 INFO - PID 5974 | 16:31:36 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44297/tests/kraken/driver.html?testName=json-parse-financial) 16:31:37 INFO - PID 5974 | RSS: Main: 151400448 16:31:37 INFO - PID 5974 | 16:31:38 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:31:39 INFO - PID 5974 | RSS: Main: 150958080 16:31:39 INFO - PID 5974 | 16:31:40 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44297/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:31:41 INFO - PID 5974 | RSS: Main: 150933504 16:31:41 INFO - PID 5974 | 16:31:43 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:31:44 INFO - PID 5974 | RSS: Main: 147849216 16:31:44 INFO - PID 5974 | 16:31:46 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:31:47 INFO - PID 5974 | RSS: Main: 148353024 16:31:47 INFO - PID 5974 | 16:31:49 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:31:50 INFO - PID 5974 | RSS: Main: 148938752 16:31:50 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | Cycle 1(1): loaded http://localhost:44297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44297/tests/kraken/driver.html?testName=ai-astar) 16:31:52 INFO - PID 5974 | RSS: Main: 150609920 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | __start_tp_report 16:31:52 INFO - PID 5974 | _x_x_mozilla_page_load 16:31:52 INFO - PID 5974 | _x_x_mozilla_page_load_details 16:31:52 INFO - PID 5974 | |i|pagename|runs| 16:31:52 INFO - PID 5974 | |0;ai-astar;107;106;106;106;107;108;107;105;105;105 16:31:52 INFO - PID 5974 | |1;audio-beat-detection;113;110;111;115;112;112;114;115;121;113 16:31:52 INFO - PID 5974 | |2;audio-dft;164;163;165;163;165;164;166;162;166;167 16:31:52 INFO - PID 5974 | |3;audio-fft;79;73;74;73;73;72;72;74;75;74 16:31:52 INFO - PID 5974 | |4;audio-oscillator;78;78;78;78;77;82;79;79;79;79 16:31:52 INFO - PID 5974 | |5;imaging-gaussian-blur;114;114;114;113;114;115;111;114;114;114 16:31:52 INFO - PID 5974 | |6;imaging-darkroom;150;150;149;152;150;150;150;149;150;149 16:31:52 INFO - PID 5974 | |7;imaging-desaturate;100;94;94;94;94;94;95;94;94;96 16:31:52 INFO - PID 5974 | |8;json-parse-financial;45;47;45;44;47;45;43;46;44;44 16:31:52 INFO - PID 5974 | |9;json-stringify-tinderbox;37;38;38;38;38;38;42;37;38;37 16:31:52 INFO - PID 5974 | |10;stanford-crypto-aes;71;76;71;72;71;71;71;70;79;75 16:31:52 INFO - PID 5974 | |11;stanford-crypto-ccm;112;108;108;111;116;107;107;111;101;107 16:31:52 INFO - PID 5974 | |12;stanford-crypto-pbkdf2;160;153;156;155;153;154;167;157;154;152 16:31:52 INFO - PID 5974 | |13;stanford-crypto-sha256-iterative;61;60;58;58;60;63;64;59;61;59 16:31:52 INFO - PID 5974 | __end_tp_report 16:31:52 INFO - PID 5974 | __start_cc_report 16:31:52 INFO - PID 5974 | _x_x_mozilla_cycle_collect,711 16:31:52 INFO - PID 5974 | __end_cc_report 16:31:52 INFO - PID 5974 | __startTimestamp1506295912533__endTimestamp 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | ------- Summary: start ------- 16:31:52 INFO - PID 5974 | Number of tests: 14 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#0] ai-astar Cycles:10 Average:106.20 Median:106.50 stddev:1.03 (1.0%) stddev-sans-first:1.05 16:31:52 INFO - PID 5974 | Values: 107.0 106.0 106.0 106.0 107.0 108.0 107.0 105.0 105.0 105.0 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#1] audio-beat-detection Cycles:10 Average:113.60 Median:113.50 stddev:3.06 (2.7%) stddev-sans-first:3.24 16:31:52 INFO - PID 5974 | Values: 113.0 110.0 111.0 115.0 112.0 112.0 114.0 115.0 121.0 113.0 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#2] audio-dft Cycles:10 Average:164.50 Median:165.00 stddev:1.58 (1.0%) stddev-sans-first:1.67 16:31:52 INFO - PID 5974 | Values: 164.0 163.0 165.0 163.0 165.0 164.0 166.0 162.0 166.0 167.0 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#3] audio-fft Cycles:10 Average:73.90 Median:74.00 stddev:2.02 (2.7%) stddev-sans-first:1.00 16:31:52 INFO - PID 5974 | Values: 79.0 73.0 74.0 73.0 73.0 72.0 72.0 74.0 75.0 74.0 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:79.00 stddev:1.34 (1.7%) stddev-sans-first:1.39 16:31:52 INFO - PID 5974 | Values: 78.0 78.0 78.0 78.0 77.0 82.0 79.0 79.0 79.0 79.0 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.06 (0.9%) stddev-sans-first:1.12 16:31:52 INFO - PID 5974 | Values: 114.0 114.0 114.0 113.0 114.0 115.0 111.0 114.0 114.0 114.0 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 16:31:52 INFO - PID 5974 | Values: 150.0 150.0 149.0 152.0 150.0 150.0 150.0 149.0 150.0 149.0 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:1.91 (2.0%) stddev-sans-first:0.71 16:31:52 INFO - PID 5974 | Values: 100.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 96.0 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#8] json-parse-financial Cycles:10 Average:45.00 Median:45.00 stddev:1.33 (3.0%) stddev-sans-first:1.41 16:31:52 INFO - PID 5974 | Values: 45.0 47.0 45.0 44.0 47.0 45.0 43.0 46.0 44.0 44.0 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:1.45 (3.8%) stddev-sans-first:1.48 16:31:52 INFO - PID 5974 | Values: 37.0 38.0 38.0 38.0 38.0 38.0 42.0 37.0 38.0 37.0 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:71.50 stddev:2.95 (4.1%) stddev-sans-first:3.06 16:31:52 INFO - PID 5974 | Values: 71.0 76.0 71.0 72.0 71.0 71.0 71.0 70.0 79.0 75.0 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#11] stanford-crypto-ccm Cycles:10 Average:108.80 Median:109.50 stddev:3.99 (3.6%) stddev-sans-first:4.07 16:31:52 INFO - PID 5974 | Values: 112.0 108.0 108.0 111.0 116.0 107.0 107.0 111.0 101.0 107.0 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:155.50 stddev:4.48 (2.9%) stddev-sans-first:4.53 16:31:52 INFO - PID 5974 | Values: 160.0 153.0 156.0 155.0 153.0 154.0 167.0 157.0 154.0 152.0 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.30 Median:60.50 stddev:2.00 (3.3%) stddev-sans-first:2.11 16:31:52 INFO - PID 5974 | Values: 61.0 60.0 58.0 58.0 60.0 63.0 64.0 59.0 61.0 59.0 16:31:52 INFO - PID 5974 | -------- Summary: end -------- 16:31:52 INFO - PID 5974 | 16:31:52 INFO - PID 5974 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:31:53 INFO - TEST-INFO | 5974: exit 0 16:31:53 INFO - TEST-OK | kraken | took 58763ms 16:31:53 INFO - SUITE-END | took 1166s 16:31:53 INFO - Completed test suite (00:19:26) 16:31:53 INFO - javascript benchmark 16:31:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9191.20838146166, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3841.442990766339, 3847.3651847445162, 3863.3625451800453, 3866.3040652682525, 3882.475865758122, 6227.564070515065, 6294.559380843343, 6298.590591611548, 6356.777512787054, 6453.35466453355, 6270.372962703727, 6289.245290565127, 6395.328490508487, 6397.904031439521, 6463.709133089011, 5657.179708942201, 5662.8301150965535, 5690.60165788395, 5720.685362305061, 5733.569982251327, 1000.4890330599163, 5542.334919809628, 5580.441955804407, 5743.4543718346695, 5762.855928601797, 5541.445855414447, 5638.943610563882, 5730.656160630355, 5743.684097374643, 5770.816982518573, 5695.0, 5705.4294570543025, 5759.942400575983, 5762.394948530427, 5771.422857714195, 5648.181013752983, 5671.262735844314, 5672.914906276409, 5700.971495142498, 5703.0, 6250.312465628777, 6290.119383286344, 6294.150289710876, 6336.398042185985, 6379.808605741835, 6695.296993815677, 6811.761588344434, 6844.21291551468, 6852.794416167523, 6969.7909062728195, 6913.75801846938, 6946.583205007716, 6971.3028697130385, 6992.091028166356, 6996.650167491605, 6378.968105159491, 6455.644939528371, 6457.515686323544, 6513.934860651428, 6532.934670653281, 7090.751823686146, 7104.467164962649, 7149.785506434815, 7215.025971493781, 7227.241139680363, 6829.6243706596615, 6886.0, 6891.414229790424, 6919.100516932766, 6924.376806087476, 6755.392014718601, 6900.758473453405, 6919.619420931897, 6943.861122777516, 6994.300569943067, 6834.1457317835275, 6871.175458944858, 6912.55068420551, 6921.792346229621, 6927.896081558781, 6754.527183097136, 6911.03245545624, 6928.7228510859, 6931.549449285882, 6936.7572134975035, 5006.4492905780335, 5013.248012798036, 5081.034603425412, 5082.847514574569, 5085.364329458817, 4505.07645932583, 4570.794314255866, 4599.195140850338, 4601.6548758842555, 4607.516210797818, 6040.365761595057, 6198.907016394758, 6251.12484252205, 6252.437280644764, 6267.6866156691985, 6852.383285504229, 6916.3429474199875, 6923.169219693669, 6951.478639102088, 6982.26686197952, 6238.282597501346, 6287.245530536365, 6323.241211054703, 6337.873242535124, 6407.295197528269, 5422.728863556807, 5526.115821468627, 5584.134459158837, 5604.299462567179, 5639.0, 7092.822679433056, 7148.964255178691, 7155.391791697764, 7171.282871712787, 7191.712331506681, 6848.623325717133, 6851.657417129223, 6871.175458944958, 6932.064171337007, 6957.826054348682, 6865.828354291183, 7007.439404847498, 7092.5389849659605, 7106.289371062852, 7212.603306818175, 6793.694283757144, 6893.310668933066, 6894.689738961859, 6898.758543450955, 6901.413379862768, 6868.896966545406, 6888.793336199922, 6924.134483189601, 6952.965235173791, 6955.061066755923, 6535.0, 6632.436242919213, 6662.100616416722, 6666.366695163952, 6667.866462701256, 6511.674416279072, 6518.57629254097, 6530.151080359713, 6530.346965303432, 6548.148740663683, 6446.645434501147, 6483.513736469689, 6510.544261901621, 6563.0, 6582.407583317525, 6696.564723293165, 6714.52998290115, 6805.353491418307, 6820.761273355409, 6831.248562658203, 6385.393387628168, 6464.0627109069865, 6474.0612611172055, 6528.934710652833, 6567.802965911031], "value": 6239.863482611363, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [930.1860871737232, 932.2635118256582, 961.8076384723055, 980.436249156735, 984.9113579777819, 44212.11575768483, 45157.54842451574, 45265.0, 45345.093098138015, 45497.54502454974, 47334.52665473344, 47786.761066194704, 47801.760991195, 47823.521764782345, 47843.28235076468, 8476.533790641528, 8638.17937295956, 8648.0, 8651.524166170859, 8660.480371177719, 8369.246767790897, 8495.575221238943, 8513.574321283942, 8539.74380768578, 8540.444871083391, 8469.407141500098, 8532.70135545256, 8606.956965215166, 8608.56957152143, 8610.182032706914, 8525.531095789729, 8546.786330341729, 8561.95719021404, 8563.400561960696, 8570.0, 8347.916520834775, 8393.992720873533, 8452.915470845335, 8474.872876906851, 8475.406721529496, 40842.59157408447, 41390.0, 41411.0, 41420.58579414227, 41421.1715765683, 3660.249648821985, 3674.6692797648075, 3694.519712437366, 3698.815059247027, 3701.0747313171705, 33772.0, 33885.0, 34038.82980585106, 34198.14504637379, 34305.0, 5407.324084489439, 5480.972595137038, 5485.259489968843, 5540.418256083134, 5546.084895992157, 214635.0, 215070.0, 215148.0, 215976.0, 216446.0, 51812.48187518077, 52263.0, 56144.438555613924, 56955.43044569584, 57129.0, 60236.0, 60312.396876031555, 60392.094118588255, 60413.39586604077, 60476.697616511636, 16841.41055063067, 16940.40708575194, 17149.314027439013, 17171.570710732332, 17230.138493075297, 13566.0, 13573.59279221625, 13617.0, 13691.589252322447, 13692.246926419142, 16181.514554563382, 16226.918865405834, 16228.918855405647, 16300.021998680117, 16322.673546529002, 6276.905846412307, 6349.396807303298, 6373.0, 6422.935770642327, 6462.159919210472, 1103.1175059952006, 1104.6023431564631, 1114.9331040137617, 1116.0736588631416, 1119.921605487608, 25832.48335033289, 25962.09132680347, 26090.086846960647, 26206.73793262081, 26283.868580656974, 1204.27141579345, 1218.1351240619083, 1227.3249712658003, 1234.9320787356783, 1239.2007155384727, 13558.525451609146, 13690.726185476235, 13745.587632371045, 13987.0, 13993.860061399459, 266006.0, 268207.0, 268241.0, 268265.0, 268353.0, 63650.36349636537, 65052.0, 65130.0, 65504.672476637315, 65557.0, 1487.1671863756114, 1512.3421311729433, 1528.709545186411, 1533.811296245441, 1538.7461068923503, 31035.0, 31105.0, 31609.051728448183, 32269.51595726113, 32291.677083228868, 43400.13199735925, 43831.34252986272, 43980.78009609931, 44058.55941440545, 44075.11849763051, 252884.0, 253130.0, 255987.0, 256341.0, 256837.0, 36333.0916727084, 37113.0, 37941.81029094837, 38130.809345953094, 38174.61825381822, 47578.0, 48343.0, 48903.510964889894, 48990.265146022124, 49135.262971056174, 35294.0, 35446.64553354433, 35457.0, 35545.644543554234, 35884.28231435409, 34832.65167348395, 34971.30057398888, 35030.0, 35461.82269088638, 35521.0, 40241.0, 41663.16673666449, 41741.58258417377, 41791.164176716906, 41907.7904610475, 33631.15922101967, 34178.65821341755, 34337.48493772546, 34499.0, 34699.4795078069, 25620.61569076428, 25957.846744520786, 26057.218283451526, 26520.602190966765, 26664.733352666226], "value": 19262.983867739138, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.785139127001, 626.4299487466407, 628.1174949196379, 628.1394489549318, 648.7340190521887, 23158.0, 24053.278401647935, 24097.879510602444, 24109.879450602722, 24841.25476235716, 26326.210213693572, 27323.45353092942, 27331.180064598044, 27336.0, 27354.179374618743, 6796.422304104145, 6923.584584924895, 6928.2725313842075, 6928.861422771542, 6935.063766391523, 6593.571417857824, 6839.692213850364, 6858.862822743542, 6869.519133660646, 6896.275891031445, 6800.149981252343, 6807.217170025436, 6817.795466135999, 6822.215445223788, 6828.48786341024, 6795.252522222551, 6797.252302246774, 6802.38778509934, 6826.658667066677, 6831.180258368978, 6312.968435157841, 6315.778947736853, 6360.491160707133, 6378.585391949555, 6384.297727249998, 30538.389232215453, 30850.382992340026, 31571.0, 31671.683283167335, 31858.840705796556, 2241.181968581472, 2280.441291883483, 2282.395165281202, 2284.7486776454575, 2285.108807565051, 20737.170513179455, 21079.789202107935, 21110.788892111188, 21207.363779086652, 21363.67954480684, 2462.963055554168, 2539.212844018342, 2579.1488808693084, 2581.838172822219, 2582.173704414588, 143747.28126359405, 150504.0, 156739.0, 161102.19448902798, 161653.0, 16488.505344839676, 16696.0, 16715.749263761052, 17010.914945425193, 17365.565860853327, 27084.458310833674, 27115.1865444037, 27253.318667033087, 27265.591016134775, 27279.727202727718, 10921.399323037309, 10945.616903408343, 11027.786943436216, 11099.778004439866, 11245.887541124648, 9960.605515227873, 9968.80062398748, 10024.19806415485, 10030.799384012278, 10215.744606384751, 9897.950510247403, 9941.850872236922, 10029.0, 10111.7472063199, 10130.81351839484, 2941.382309714941, 2995.176326510227, 2996.580478732979, 3015.472292348874, 3061.6019917410595, 1039.8492218628407, 1043.2592859069994, 1056.8309070548676, 1059.3220338983058, 1076.4025965589017, 21959.780402195775, 21962.560748784934, 22046.228382006873, 22157.66763498549, 22671.546569068858, 1109.628274528042, 1112.7996960547018, 1114.3481063577735, 1114.8550688410617, 1130.4912789244872, 11946.820797688042, 12275.263484190977, 12384.256944583354, 12402.75194496123, 12537.561185358469, 572793.0, 589844.0, 595364.0, 595819.0, 598447.0, 129976.0, 131840.0, 132610.33694831465, 132958.0, 133807.33096334455, 1243.4715246020405, 1243.9253644781343, 1271.6693659648558, 1273.4333221716247, 1277.8402699662543, 19626.803731963068, 19716.90141549283, 19975.20099196016, 19984.300549480697, 20068.197272109537, 63111.6844415775, 63311.6834415825, 63322.36677633165, 64949.35050649433, 65451.34548654643, 79740.0, 79814.0, 80205.0, 81066.5946670263, 83566.58216709121, 16253.268602912662, 16483.0, 16589.336426542803, 16630.085345306125, 16661.333546658, 22699.773002270427, 22801.429964251027, 23336.18323358742, 23343.41641458909, 23378.532429350977, 20555.58888822245, 20799.480012999797, 20914.47713807167, 20930.37208883736, 21199.576008480053, 16791.832081679026, 17481.300747969937, 17540.82459175392, 17911.820881791016, 17936.82063179404, 18027.729584056513, 18082.367117150836, 18165.545861353043, 18250.36123735663, 20675.68986465174, 14534.05528640635, 14540.200288984208, 14543.200123993282, 14579.562613121623, 14656.633584160054, 18943.526411839815, 19197.232110715417, 19284.517887052934, 20618.278360257318, 20834.374968750963], "value": 13001.977793234288, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.5102689572097, 1458.7228426598952, 1470.088545102037, 1480.252472501387, 1480.9851901480981, 16537.421190258345, 17405.56486087847, 17415.73876391855, 17416.564585885328, 17421.128943552834, 16888.83111168888, 17067.91466042668, 17075.060871652055, 17080.23138958747, 17098.914505427485, 2622.816402851806, 2718.537848565739, 2718.565029595265, 2728.672559292888, 2733.9726602734017, 2702.9324266893386, 2730.8361498310064, 2741.561350183971, 2745.1627253687616, 2756.531389663762, 2757.6139340492346, 2858.042555743818, 2859.642544681915, 2860.027590619189, 2860.6710228323695, 2798.776097912162, 2804.901828436005, 2817.197098826835, 2828.4484525517532, 2829.2078218098964, 2682.9597556036674, 2871.253474096729, 2876.022152468171, 2876.1659118855505, 2878.409925965193, 16964.3214271429, 17137.742933856003, 17193.82806171935, 17207.913960430244, 17220.311187552485, 8091.150429204908, 8332.708355207538, 8364.330853531703, 8398.83202335956, 8411.116832732536, 5657.2928383952, 5659.717014149276, 5829.125631155318, 5871.236739223874, 5886.381929897342, 2082.2087606709506, 2140.7217061782026, 2146.2809958663865, 2173.6848157017303, 2202.548477562112, 30607.387852243053, 30648.38703225923, 30732.53901191484, 30789.38421231563, 30790.846045769627, 7323.926760732431, 7768.689252429839, 7824.21757824213, 8073.394495412867, 8160.877586836202, 19514.414567562995, 19549.511262218275, 19554.608907821763, 19560.902195489216, 19646.901765491082, 8390.077091519928, 8546.78633034179, 8562.871556926651, 8581.313494920392, 8581.485110893242, 7767.417443691746, 7808.609569521501, 7830.765077047698, 7880.211978802074, 7948.403869709795, 5718.714064296769, 5825.883482330414, 5825.922204392201, 5890.4979230296, 5939.109133629903, 1702.285040283084, 1710.606560491069, 1737.3224442467447, 1740.817214192517, 1758.5779412940801, 960.5101398286924, 964.1274646444979, 983.4689267795453, 996.7707427291764, 1000.5547531348626, 8396.118407567239, 8469.703560375357, 8474.1949514796, 8534.53060081689, 8540.060593334729, 780.1106738318322, 806.9435139540176, 811.111832543364, 820.6143112737004, 824.8803923431069, 5034.874128146753, 5252.290940722954, 5626.324841019104, 5972.9328107390975, 6196.597221180699, 23605.645915311285, 24836.130735424173, 24895.128670496444, 24971.375715606893, 24983.0, 23121.190758323377, 24109.51780964371, 24269.271921842374, 24296.392590185387, 24818.627720584205, 12771.808422873664, 12815.423305951255, 12816.871831281755, 12949.093563450657, 13007.934960325327, 9038.502882341272, 9198.67804626835, 9234.769130771785, 9280.396774209656, 9304.860427093734, 20970.790292096885, 21048.579028419652, 21448.785512144677, 21619.459513512287, 21968.45078873041, 21634.89182554077, 21973.890130549244, 21981.450463738536, 22123.225687100876, 22177.66733499031, 12136.453859576517, 12345.691357716129, 12371.628851134481, 12379.257244565355, 12395.814062788884, 15209.239538023276, 15456.459023934558, 15620.218989050729, 15627.374905003673, 15664.0, 12547.686307842378, 12921.741565168455, 13013.414396352377, 13182.934085329513, 13290.006499024837, 12418.254904705747, 12443.626691199279, 12492.37538123072, 12829.294388808705, 13032.804507932198, 10119.848202276824, 10173.389596624227, 10180.949095254477, 10280.794384112127, 10303.484825758833, 8269.95865020671, 8369.539675317916, 8379.329653627574, 8437.831243375222, 8524.318054555744, 8171.673133074848, 8275.54484503358, 8303.377246706401, 8308.792280193044, 8364.749057528285], "value": 7289.677387518898, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.9479449452303, 562.4797062716987, 572.6420986883198, 587.7531436796546, 591.8402031451506, 5816.360200377961, 6126.142340072393, 6187.412195841399, 6192.78325258616, 6338.271098823637, 6048.004158627653, 6080.939190608093, 6092.66490343031, 6116.510679145669, 6135.8772824543485, 4943.728094954776, 4979.356812251966, 4998.2752500887345, 5023.246513023039, 5034.910512137477, 4880.755962201893, 4953.628477864175, 4973.278874563204, 4985.750712464363, 5037.395512538501, 4949.133901567229, 4957.876053098666, 4971.875703107415, 4993.925091123636, 5030.6981581105065, 4915.3364295819965, 4918.680285781431, 4951.331570238008, 4979.47715489872, 4981.12830254704, 4421.668374871898, 4464.419625448703, 4504.909901801979, 4548.704334218265, 4571.8570357410645, 6158.907616385758, 6187.257529096492, 6188.0, 6204.410580994799, 6210.223722034746, 5727.1695604137585, 5781.508571771405, 5799.768009279624, 5832.445917637818, 5844.386339434383, 6530.183727034121, 6532.5753826001155, 6566.277709451956, 6580.703868325889, 6600.86798264032, 4863.78112984913, 4974.253861920741, 5030.144875371196, 5037.899242015176, 5048.924266136011, 6524.93475065248, 6707.899381509281, 6813.0, 6839.829004274933, 6882.380585747307, 5135.512126347991, 5138.150265904272, 5146.871328216825, 5159.535641792257, 5176.197689358156, 5175.767090480937, 5202.92195617066, 5223.9439927642, 5242.239875218148, 5247.527722504993, 5769.971150144306, 5810.099434587646, 5831.2184009112125, 5841.88316233673, 5849.590528663038, 6591.703373348115, 6608.966955165193, 6626.801195964129, 6629.3370662934285, 6659.9001014984815, 1773.6364045370667, 1775.849052830524, 1785.366195000782, 1798.2447372103748, 1803.4589623113013, 1236.5902870727377, 1288.368699337318, 1293.1077556485996, 1297.3642914971597, 1306.1248963194682, 6010.0, 6086.147939288503, 6143.941779503827, 6149.96925015381, 6189.96905015472, 6543.280239173687, 6617.834554136185, 6622.503312251601, 6642.568233064835, 6807.65961701913, 6140.631562106288, 6227.470664993436, 6233.438990490787, 6240.188775459162, 6242.968785156045, 3448.8448019839166, 3487.145649315934, 3509.8069606171393, 3514.683678468899, 3530.223350862806, 6803.149606299213, 6805.591664500146, 6983.580985140908, 7005.719771209095, 7033.402160816286, 6750.0, 6800.183977922681, 6839.897401538981, 6854.903215485598, 6877.2091209510545, 6693.698783554752, 6822.9317706823285, 6829.282925292872, 6902.685821361649, 6956.965215173993, 6728.899066513908, 6736.0, 6747.224069232101, 6756.898646520208, 6767.89848152288, 6674.632895190617, 6683.699233534599, 6722.394984451423, 6749.628770417674, 6750.32496750321, 7035.47233957445, 7037.437005039482, 7038.260982596754, 7054.400375967895, 7086.574805511686, 5190.143626301769, 5207.29701490294, 5207.76565054581, 5215.0, 5225.5558277545315, 6429.357064293533, 6542.378474044958, 6614.8346291343105, 6785.575029243717, 6840.726370945106, 6264.21697287839, 6387.137736405712, 6395.936040639534, 6469.5794773339585, 6502.414782669583, 6355.586886852339, 6395.136656551306, 6432.742690292336, 6463.741450341934, 6523.18460192476, 6246.718897649525, 6284.591501552384, 6290.8676438241555, 6340.936590634219, 6408.935910640834, 6482.666240153447, 6517.4460170886005, 6535.673216339069, 6555.2133743951035, 6578.703958321791, 6256.405641464054, 6320.399562041599, 6378.553501254868, 6391.201099862517, 6453.290138084901], "value": 5135.405677255194, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [957.5164541906337, 979.8285300072488, 994.7264502261877, 997.2620261006848, 1006.2252065909248, 20892.477688057807, 21094.0, 21098.789012109875, 21175.258865939697, 21182.99999999998, 17963.371282005133, 18081.81918180818, 18084.638307233847, 19431.0, 19640.705389419134, 1046.1787496815002, 1079.9784004319908, 1080.8324709670014, 1082.5940272397852, 1083.2471432354516, 1066.4401189375562, 1066.7599790047216, 1069.6523629820301, 1070.7751372211806, 1070.9303895246824, 1002.3584905660347, 1128.582424502935, 1130.4065365683, 1131.6322195286523, 1140.1278022312938, 1131.660501849446, 1135.5117299561186, 1136.5794655977259, 1137.1357768096223, 1137.5051852444171, 786.3276898252027, 806.7741032510907, 814.8940637717059, 821.6795449774593, 821.9589020549008, 18203.817961820343, 18247.817521824745, 18289.725654115067, 18314.26742930281, 18348.724769128472, 21888.671669924963, 21938.0, 22366.32901012956, 22633.77366226333, 22861.54276914469, 18750.0624968751, 18752.81247187538, 18823.247070117315, 19097.522561935923, 19269.22923083075, 3993.520777506689, 4005.959940400588, 4022.416749571296, 4023.3361495353233, 4023.758574485511, 130696.0, 162232.0, 164883.0, 166439.0, 170290.0, 18521.518278537686, 18793.34223302178, 19112.139953702117, 19124.0, 19406.70889936652, 33559.32881342409, 34307.48538771921, 34611.4808277876, 34858.0, 35185.824070879484, 10217.489125543692, 10265.794684106277, 10283.485825708685, 10293.53679084443, 10301.0, 4677.134730074947, 4678.391809064799, 4697.976510117427, 4764.190087685102, 4774.594159496482, 5983.790567330123, 6035.094735789667, 6067.787627433018, 6075.149479072933, 6092.39076092396, 1214.4474264209764, 1263.564070395712, 1268.2200446725199, 1282.0256604980282, 1283.8716128387273, 727.8871774874902, 741.2032065529577, 746.7834328044914, 750.5421692767408, 761.2767870523026, 12534.937325313498, 12685.302308372944, 13394.598162055154, 14177.5037873676, 14287.714245715235, 683.2552517755571, 696.8153439338579, 704.6089420371641, 711.494838664554, 713.7537549545399, 5783.739731712083, 5828.6502809831545, 5919.644821310735, 6003.789867354709, 6018.2176317079375, 149617.0, 151171.0, 151309.0, 151843.0, 153346.9330613404, 126767.36616317045, 127973.36013319874, 129247.0, 133674.0, 138440.0, 113422.0, 114187.0, 114818.0, 118377.0, 118655.99999999827, 13498.52755153565, 13584.592462226148, 13879.167249965034, 14023.298835058002, 14572.271386430848, 51441.228381575056, 52899.73550132225, 53154.0, 54107.72946135244, 54235.0, 69042.96435553572, 70872.0, 93026.53486732523, 95167.0, 95945.0, 20904.58190836205, 21389.35831925045, 21448.46378840479, 21609.783902160776, 21677.783222168207, 20712.585748284648, 21088.156473741492, 21305.36083917485, 23437.76562234356, 23588.410289742893, 20058.498537536678, 20163.193472261533, 20167.697484538035, 20472.692909606667, 20930.47673808167, 19106.713399298744, 19472.805271947098, 19537.21851125939, 20777.584448311252, 21612.243571474923, 19355.516112096746, 19433.611327773648, 19687.114079866726, 21697.783022169577, 22279.99740011671, 13632.65918352049, 13907.58277251684, 14005.719885602028, 14258.572242832732, 14393.136411815325, 15502.689946201239, 15797.36810527566, 16362.100084495467, 16417.0, 16638.3344666212], "value": 10304.245871721072, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1376.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 106.0, 106.0, 107.0, 108.0, 107.0, 105.0, 105.0, 105.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 111.0, 115.0, 112.0, 112.0, 114.0, 115.0, 121.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 163.0, 165.0, 164.0, 166.0, 162.0, 166.0, 167.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 74.0, 73.0, 73.0, 72.0, 72.0, 74.0, 75.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 77.0, 82.0, 79.0, 79.0, 79.0, 79.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 114.0, 115.0, 111.0, 114.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 152.0, 150.0, 150.0, 150.0, 149.0, 150.0, 149.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 47.0, 45.0, 44.0, 47.0, 45.0, 43.0, 46.0, 44.0, 44.0], "value": 45.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 38.0, 38.0, 38.0, 42.0, 37.0, 38.0, 37.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 71.0, 72.0, 71.0, 71.0, 71.0, 70.0, 79.0, 75.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 108.0, 111.0, 116.0, 107.0, 107.0, 111.0, 101.0, 107.0], "value": 108.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 153.0, 156.0, 155.0, 153.0, 154.0, 167.0, 157.0, 154.0, 152.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 58.0, 58.0, 60.0, 63.0, 64.0, 59.0, 61.0, 59.0], "value": 60.3, "unit": "score"}]}]} 16:31:53 INFO - Return code: 0 16:31:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:31:53 INFO - # TBPL SUCCESS # 16:31:53 INFO - Running post-action listener: _package_coverage_data 16:31:53 INFO - Running post-action listener: _resource_record_post_action 16:31:53 INFO - [mozharness: 2017-09-24 23:31:53.346564Z] Finished run-tests step (success) 16:31:53 INFO - Running post-run listener: _resource_record_post_run 16:31:53 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 327794688; Read time: 0; Write time: 236656 16:31:53 INFO - TinderboxPrint: CPU usage
13.1% 16:31:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:31:53 INFO - TinderboxPrint: I/O write bytes / time
327,794,688 / 236,656 16:31:53 INFO - TinderboxPrint: CPU idle
8,205.9 (86.9%) 16:31:53 INFO - TinderboxPrint: CPU user
1,186.0 (12.6%) 16:31:53 INFO - TinderboxPrint: Swap in / out
0 / 0 16:31:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13099008; Read time: 0; Write time: 2244 16:31:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:31:53 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 0; Write bytes: 314306560; Read time: 0; Write time: 234360 16:31:53 INFO - Running post-run listener: _upload_blobber_files 16:31:53 INFO - Blob upload gear active. 16:31:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:31:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:31:54 INFO - (blobuploader) - INFO - Open directory for files ... 16:31:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:31:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:31:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:55 INFO - (blobuploader) - INFO - Done attempting. 16:31:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:31:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:32:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:02 INFO - (blobuploader) - INFO - Done attempting. 16:32:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:32:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:32:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:03 INFO - (blobuploader) - INFO - Done attempting. 16:32:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:32:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:32:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:04 INFO - (blobuploader) - INFO - Done attempting. 16:32:04 INFO - (blobuploader) - INFO - Iteration through files over. 16:32:04 INFO - Return code: 0 16:32:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:32:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:32:04 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0161ef38241136678f6adf01f39f9907e711c4c19ae92dbedf294af926b27f3b311d0abbfa3d197cc31270015807480127e0ed807561ec9f20a9089825f9506c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434d166f8f879d893229b86da7a0bbb9b77a0f23a874b8730abd0768a292b8c90a170cbda583bf762c4484e0752327033caef7b709bedf8d3a66a6e3eec95cf5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07775e399be2c1ee8b955c1baa01145d140e43fc69535987614d93f327f9df6f47a132d204d3d02f86a758b1342b4dda4ff9e73820f0994d75c3c02620af3523", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73e2960ec4df84599398300610df8b102039bb3844749c57ee97867b509389da545bf27804f8b029127817b9d83a4ba9f4ef7ddac034d1ed816960ccc64f38d0"} 16:32:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:32:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:32:04 INFO - Contents: 16:32:04 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0161ef38241136678f6adf01f39f9907e711c4c19ae92dbedf294af926b27f3b311d0abbfa3d197cc31270015807480127e0ed807561ec9f20a9089825f9506c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434d166f8f879d893229b86da7a0bbb9b77a0f23a874b8730abd0768a292b8c90a170cbda583bf762c4484e0752327033caef7b709bedf8d3a66a6e3eec95cf5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07775e399be2c1ee8b955c1baa01145d140e43fc69535987614d93f327f9df6f47a132d204d3d02f86a758b1342b4dda4ff9e73820f0994d75c3c02620af3523", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73e2960ec4df84599398300610df8b102039bb3844749c57ee97867b509389da545bf27804f8b029127817b9d83a4ba9f4ef7ddac034d1ed816960ccc64f38d0"} 16:32:04 INFO - Running post-run listener: copy_logs_to_upload_dir 16:32:04 INFO - Copying logs to upload dir... 16:32:04 INFO - mkdir: /builds/slave/test/build/upload/logs 16:32:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.484609 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-24 16:32:04.371748) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 16:32:04.375980) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798 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/0161ef38241136678f6adf01f39f9907e711c4c19ae92dbedf294af926b27f3b311d0abbfa3d197cc31270015807480127e0ed807561ec9f20a9089825f9506c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434d166f8f879d893229b86da7a0bbb9b77a0f23a874b8730abd0768a292b8c90a170cbda583bf762c4484e0752327033caef7b709bedf8d3a66a6e3eec95cf5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07775e399be2c1ee8b955c1baa01145d140e43fc69535987614d93f327f9df6f47a132d204d3d02f86a758b1342b4dda4ff9e73820f0994d75c3c02620af3523", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73e2960ec4df84599398300610df8b102039bb3844749c57ee97867b509389da545bf27804f8b029127817b9d83a4ba9f4ef7ddac034d1ed816960ccc64f38d0"} build_url:https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/ce0ldRR8TaGxVM0-hHQ4zg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0161ef38241136678f6adf01f39f9907e711c4c19ae92dbedf294af926b27f3b311d0abbfa3d197cc31270015807480127e0ed807561ec9f20a9089825f9506c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434d166f8f879d893229b86da7a0bbb9b77a0f23a874b8730abd0768a292b8c90a170cbda583bf762c4484e0752327033caef7b709bedf8d3a66a6e3eec95cf5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07775e399be2c1ee8b955c1baa01145d140e43fc69535987614d93f327f9df6f47a132d204d3d02f86a758b1342b4dda4ff9e73820f0994d75c3c02620af3523", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73e2960ec4df84599398300610df8b102039bb3844749c57ee97867b509389da545bf27804f8b029127817b9d83a4ba9f4ef7ddac034d1ed816960ccc64f38d0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 16:32:04.407146) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:32:04.407443) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1506293641.363541-1963218798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:32:04.487270) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 16:32:04.487555) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 16:32:04.490893) ========= ========= Total master_lag: 0.25 =========