builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1505913296.25 results: success (0) revision: a20de99fa3c1ba6287fe47d493a859a4e95120b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 06:14:56.245374) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 06:14:56.245906) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 06:14:56.246177) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 06:14:56.371110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:14:56.371389) ========= 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=ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 06:14:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.2M=0s 2017-09-20 06:14:56 (45.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:14:56.517089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:14:56.517456) ========= 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=ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015556 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:14:56.607226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-20 06:14:56.607558) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a20de99fa3c1ba6287fe47d493a859a4e95120b0 --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 a20de99fa3c1ba6287fe47d493a859a4e95120b0 --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=ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 06:14:56,849 truncating revision to first 12 chars 2017-09-20 06:14:56,849 Setting DEBUG logging. 2017-09-20 06:14:56,849 attempt 1/10 2017-09-20 06:14:56,849 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a20de99fa3c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 06:14:57,702 unpacking tar archive at: mozilla-central-a20de99fa3c1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.171421 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-20 06:14:57.812230) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 06:14:57.812553) ========= script_repo_revision: a20de99fa3c1ba6287fe47d493a859a4e95120b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 06:14:57.812968) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 06:14:57.813260) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 06:14:57.832825) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-20 06:14:57.833153) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-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-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=ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:14:58 INFO - MultiFileLogger online at 20170920 06:14:58 in /builds/slave/test 06:14:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:14:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:14:58 INFO - {'append_to_log': False, 06:14:58 INFO - 'base_work_dir': '/builds/slave/test', 06:14:58 INFO - 'blob_upload_branch': 'Firefox', 06:14:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:14:58 INFO - 'branch': 'Firefox', 06:14:58 INFO - 'buildbot_json_path': 'buildprops.json', 06:14:58 INFO - 'code_coverage': False, 06:14:58 INFO - 'config_files': ('talos/linux_config.py',), 06:14:58 INFO - 'default_actions': ('clobber', 06:14:58 INFO - 'read-buildbot-config', 06:14:58 INFO - 'download-and-extract', 06:14:58 INFO - 'populate-webroot', 06:14:58 INFO - 'create-virtualenv', 06:14:58 INFO - 'install', 06:14:58 INFO - 'setup-mitmproxy', 06:14:58 INFO - 'run-tests'), 06:14:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:14:58 INFO - 'disable_ccov_upload': False, 06:14:58 INFO - 'disable_stylo': False, 06:14:58 INFO - 'download_minidump_stackwalk': True, 06:14:58 INFO - 'download_symbols': 'ondemand', 06:14:58 INFO - 'enable_stylo': False, 06:14:58 INFO - 'enable_webrender': False, 06:14:58 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 06:14:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:14:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:14:58 INFO - 'gecko_profile': False, 06:14:58 INFO - 'gecko_profile_interval': 0, 06:14:58 INFO - 'installer_path': 'installer.exe', 06:14:58 INFO - 'log_level': 'info', 06:14:58 INFO - 'log_name': 'talos', 06:14:58 INFO - 'log_to_console': True, 06:14:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:14:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:14:58 INFO - 'opt_config_files': (), 06:14:58 INFO - 'pip_index': False, 06:14:58 INFO - 'suite': 'dromaeojs-e10s', 06:14:58 INFO - 'system_bits': '32', 06:14:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:14:58 INFO - 'title': 'talos-linux64-ix-029', 06:14:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:14:58 INFO - 'use_talos_json': True, 06:14:58 INFO - 'verify': 'False', 06:14:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:14:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:14:58 INFO - 'work_dir': 'build'} 06:14:58 INFO - [mozharness: 2017-09-20 13:14:58.200827Z] Running clobber step. 06:14:58 INFO - Running pre-action listener: _resource_record_pre_action 06:14:58 INFO - Running main action method: clobber 06:14:58 INFO - rmtree: /builds/slave/test/build 06:14:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:14:59 INFO - Running post-action listener: _resource_record_post_action 06:14:59 INFO - [mozharness: 2017-09-20 13:14:59.718313Z] Finished clobber step (success) 06:14:59 INFO - [mozharness: 2017-09-20 13:14:59.718410Z] Running read-buildbot-config step. 06:14:59 INFO - Running pre-action listener: _resource_record_pre_action 06:14:59 INFO - Running main action method: read_buildbot_config 06:14:59 INFO - Using buildbot properties: 06:14:59 INFO - { 06:14:59 INFO - "project": "", 06:14:59 INFO - "product": "firefox", 06:14:59 INFO - "who": "archaeopteryx@coole-files.de", 06:14:59 INFO - "installer_path": "public/build/target.tar.bz2", 06:14:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 06:14:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:14:59 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 06:14:59 INFO - "stage_platform": "linux64-qr", 06:14:59 INFO - "basedir": "/builds/slave/test", 06:14:59 INFO - "buildnumber": 80, 06:14:59 INFO - "platform": "ubuntu64_hw_qr", 06:14:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:14:59 INFO - "slavebuilddir": "test", 06:14:59 INFO - "taskId": "XwcyDqbCQCehlNE8QywPqA", 06:14:59 INFO - "branch": "mozilla-central", 06:14:59 INFO - "script_repo_revision": "production", 06:14:59 INFO - "revision": "a20de99fa3c1ba6287fe47d493a859a4e95120b0", 06:14:59 INFO - "slavename": "talos-linux64-ix-029", 06:14:59 INFO - "repo_path": "mozilla-central" 06:14:59 INFO - } 06:14:59 INFO - Finding installer, test and symbols from parent task. 06:14:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XwcyDqbCQCehlNE8QywPqA'}, attempt #1 06:15:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XwcyDqbCQCehlNE8QywPqA'}, attempt #1 06:15:00 INFO - Task dependencies: HBUujFfqTheR_yOD7KSOzg 06:15:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg'}, attempt #1 06:15:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.tar.bz2 06:15:01 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.test_packages.json 06:15:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.crashreporter-symbols.zip 06:15:01 INFO - Running post-action listener: _resource_record_post_action 06:15:01 INFO - [mozharness: 2017-09-20 13:15:01.094525Z] Finished read-buildbot-config step (success) 06:15:01 INFO - [mozharness: 2017-09-20 13:15:01.094744Z] Running download-and-extract step. 06:15:01 INFO - Running pre-action listener: _resource_record_pre_action 06:15:01 INFO - Running main action method: download_and_extract 06:15:01 INFO - mkdir: /builds/slave/test/build/tests 06:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:01 INFO - trying https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.test_packages.json 06:15:01 INFO - Downloading https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:15:01 INFO - Downloaded 989 bytes. 06:15:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:15:01 INFO - Using the following test package requirements: 06:15:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:15:01 INFO - u'common': [u'target.common.tests.zip'], 06:15:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:15:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:15:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:15:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:15:01 INFO - u'mozbase': [u'target.common.tests.zip'], 06:15:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:15:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:15:01 INFO - u'web-platform': [u'target.common.tests.zip', 06:15:01 INFO - u'target.web-platform.tests.tar.gz'], 06:15:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:15:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 06:15:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.common.tests.zip 06:15:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:15:01 INFO - Fetch https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.common.tests.zip into memory 06:15:02 INFO - Content-Length response header: 54731844 06:15:02 INFO - Bytes received: 54731844 06:15:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.talos.tests.zip 06:15:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:15:13 INFO - Fetch https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.talos.tests.zip into memory 06:15:14 INFO - Content-Length response header: 14508893 06:15:14 INFO - Bytes received: 14508893 06:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:14 INFO - trying https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.tar.bz2 06:15:14 INFO - Downloading https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:15:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:15:16 INFO - Downloaded 61677877 bytes. 06:15:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.tar.bz2 06:15:16 INFO - mkdir: /builds/slave/test/properties 06:15:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:15:16 INFO - Writing to file /builds/slave/test/properties/build_url 06:15:16 INFO - Contents: 06:15:16 INFO - build_url:https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.tar.bz2 06:15:16 INFO - Running post-action listener: _resource_record_post_action 06:15:16 INFO - Running post-action listener: find_tests_for_verification 06:15:16 INFO - Running post-action listener: set_extra_try_arguments 06:15:16 INFO - [mozharness: 2017-09-20 13:15:16.064522Z] Finished download-and-extract step (success) 06:15:16 INFO - [mozharness: 2017-09-20 13:15:16.064635Z] Running populate-webroot step. 06:15:16 INFO - Running pre-action listener: _resource_record_pre_action 06:15:16 INFO - Running main action method: populate_webroot 06:15:16 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:15:16 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:16 INFO - 'tests': ['tresize', 06:15:16 INFO - 'tcanvasmark']}, 06:15:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:15:16 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:16 INFO - 'tests': ['dromaeo_css', 06:15:16 INFO - 'kraken']}, 06:15:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:15:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:16 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:15:16 INFO - 'talos_options': ['--disable-stylo'], 06:15:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:15:16 INFO - 'tests': ['damp', 'tps']}, 06:15:16 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:15:16 INFO - 'talos_options': ['--disable-stylo'], 06:15:16 INFO - 'tests': ['damp', 'tps']}, 06:15:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:15:16 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:16 INFO - 'tests': ['dromaeo_dom']}, 06:15:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:15:16 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:16 INFO - 'tests': ['basic_compositor_video', 06:15:16 INFO - 'glvideo']}, 06:15:16 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:15:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:15:16 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:15:16 INFO - 'talos_options': ['--disable-stylo'], 06:15:16 INFO - 'tests': ['ts_paint_webext', 06:15:16 INFO - 'tp5o_webext']}, 06:15:16 INFO - 'other-e10s': {'tests': ['a11yr', 06:15:16 INFO - 'ts_paint', 06:15:16 INFO - 'tpaint', 06:15:16 INFO - 'sessionrestore', 06:15:16 INFO - 'sessionrestore_many_windows', 06:15:16 INFO - 'sessionrestore_no_auto_restore', 06:15:16 INFO - 'tabpaint']}, 06:15:16 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:16 INFO - 'tests': ['a11yr', 06:15:16 INFO - 'ts_paint', 06:15:16 INFO - 'tpaint', 06:15:16 INFO - 'sessionrestore', 06:15:16 INFO - 'sessionrestore_many_windows', 06:15:16 INFO - 'sessionrestore_no_auto_restore', 06:15:16 INFO - 'tabpaint']}, 06:15:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:15:16 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 06:15:16 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:16 INFO - 'tests': ['perf_reftest_singletons']}, 06:15:16 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:16 INFO - 'tests': ['bloom_basic']}, 06:15:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:15:16 INFO - 'tsvgr_opacity', 06:15:16 INFO - 'tart', 06:15:16 INFO - 'tscrollx', 06:15:16 INFO - 'tsvg_static']}, 06:15:16 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:16 INFO - 'tests': ['tsvgx', 06:15:16 INFO - 'tsvgr_opacity', 06:15:16 INFO - 'tart', 06:15:16 INFO - 'tscrollx', 06:15:16 INFO - 'tsvg_static']}, 06:15:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:15:16 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:15:16 INFO - 'talos_options': ['--disable-stylo'], 06:15:16 INFO - 'tests': ['tp5o']}, 06:15:16 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:15:16 INFO - 'talos_options': ['--mitmproxy', 06:15:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:15:16 INFO - '--firstNonBlankPaint'], 06:15:16 INFO - 'tests': ['tp6_google', 06:15:16 INFO - 'tp6_youtube', 06:15:16 INFO - 'tp6_amazon', 06:15:16 INFO - 'tp6_facebook']}, 06:15:16 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:15:16 INFO - 'talos_options': ['--disable-stylo', 06:15:16 INFO - '--mitmproxy', 06:15:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:15:16 INFO - '--firstNonBlankPaint'], 06:15:16 INFO - 'tests': ['tp6_google', 06:15:16 INFO - 'tp6_youtube', 06:15:16 INFO - 'tp6_amazon', 06:15:16 INFO - 'tp6_facebook']}, 06:15:16 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:15:16 INFO - 'talos_options': ['--stylo-threads=1', 06:15:16 INFO - '--mitmproxy', 06:15:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:15:16 INFO - '--firstNonBlankPaint'], 06:15:16 INFO - 'tests': ['tp6_google', 06:15:16 INFO - 'tp6_youtube', 06:15:16 INFO - 'tp6_amazon', 06:15:16 INFO - 'tp6_facebook']}, 06:15:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:15:16 INFO - 'talos_options': ['--xperf_path', 06:15:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:16 INFO - 'tests': ['tp5n']}, 06:15:16 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:15:16 INFO - 'talos_options': ['--disable-stylo', 06:15:16 INFO - '--xperf_path', 06:15:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:16 INFO - 'tests': ['tp5n']}}} 06:15:16 INFO - Running post-action listener: _resource_record_post_action 06:15:16 INFO - [mozharness: 2017-09-20 13:15:16.727297Z] Finished populate-webroot step (success) 06:15:16 INFO - [mozharness: 2017-09-20 13:15:16.727394Z] Running create-virtualenv step. 06:15:16 INFO - Running pre-action listener: _resource_record_pre_action 06:15:16 INFO - Running main action method: create_virtualenv 06:15:16 INFO - Creating virtualenv /builds/slave/test/build/venv 06:15:16 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:15:16 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 06:15:16 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:15:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:15:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:15:18 INFO - Installing distribute.............................................................................................................................................................................................done. 06:15:18 INFO - Installing pip...............done. 06:15:18 INFO - Return code: 0 06:15:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:15:18 INFO - Reading from file tmpfile_stdout 06:15:18 INFO - Output received: 06:15:18 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 06:15:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:15:18 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')]} 06:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:18 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')]} 06:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:18 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 0x28331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3090>, '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 0x2ba3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9df90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', '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 06:15:18 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 06:15:18 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 06:15:18 INFO - Using env: {'DISPLAY': ':0', 06:15:18 INFO - 'HOME': '/home/cltbld', 06:15:18 INFO - 'LANG': 'en_US.UTF-8', 06:15:18 INFO - 'LANGUAGE': 'en_US:en', 06:15:18 INFO - 'LOGNAME': 'cltbld', 06:15:18 INFO - 'MAIL': '/var/mail/cltbld', 06:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:18 INFO - 'MOZ_NO_REMOTE': '1', 06:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:18 INFO - 'NO_EM_RESTART': '1', 06:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:18 INFO - 'PWD': '/builds/slave/test', 06:15:18 INFO - 'SHELL': '/bin/bash', 06:15:18 INFO - 'SHLVL': '1', 06:15:18 INFO - 'TERM': 'linux', 06:15:18 INFO - 'TMOUT': '86400', 06:15:18 INFO - 'USER': 'cltbld', 06:15:18 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', 06:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:18 INFO - '_': '/tools/buildbot/bin/python'} 06:15:19 INFO - Ignoring indexes: http://pypi.python.org/simple/ 06:15:19 INFO - Downloading/unpacking pip>=1.5 06:15:19 INFO - Running setup.py egg_info for package pip 06:15:19 INFO - warning: no files found matching 'pip/cacert.pem' 06:15:19 INFO - warning: no files found matching '*.html' under directory 'docs' 06:15:19 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:15:19 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:15:19 INFO - Installing collected packages: pip 06:15:19 INFO - Found existing installation: pip 1.1 06:15:19 INFO - Uninstalling pip: 06:15:19 INFO - Successfully uninstalled pip 06:15:19 INFO - Running setup.py install for pip 06:15:19 INFO - warning: no files found matching 'pip/cacert.pem' 06:15:19 INFO - warning: no files found matching '*.html' under directory 'docs' 06:15:19 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:15:19 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:15:19 INFO - Installing pip script to /builds/slave/test/build/venv/bin 06:15:19 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 06:15:19 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 06:15:19 INFO - Successfully installed pip 06:15:19 INFO - Cleaning up... 06:15:19 INFO - Return code: 0 06:15:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:15:19 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')]} 06:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:19 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')]} 06:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:19 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 0x28331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3090>, '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 0x2ba3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9df90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', '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 06:15:19 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 06:15:19 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 06:15:19 INFO - Using env: {'DISPLAY': ':0', 06:15:19 INFO - 'HOME': '/home/cltbld', 06:15:19 INFO - 'LANG': 'en_US.UTF-8', 06:15:19 INFO - 'LANGUAGE': 'en_US:en', 06:15:19 INFO - 'LOGNAME': 'cltbld', 06:15:19 INFO - 'MAIL': '/var/mail/cltbld', 06:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:19 INFO - 'MOZ_NO_REMOTE': '1', 06:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:19 INFO - 'NO_EM_RESTART': '1', 06:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:19 INFO - 'PWD': '/builds/slave/test', 06:15:19 INFO - 'SHELL': '/bin/bash', 06:15:19 INFO - 'SHLVL': '1', 06:15:19 INFO - 'TERM': 'linux', 06:15:19 INFO - 'TMOUT': '86400', 06:15:19 INFO - 'USER': 'cltbld', 06:15:19 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', 06:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:19 INFO - '_': '/tools/buildbot/bin/python'} 06:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:19 INFO - Downloading/unpacking psutil>=3.1.1 06:15:19 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 06:15:19 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 06:15:19 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 06:15:19 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 06:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:15:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:21 INFO - Installing collected packages: psutil 06:15:21 INFO - Running setup.py install for psutil 06:15:21 INFO - building 'psutil._psutil_linux' extension 06:15:21 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 06:15:21 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 06:15:21 INFO - building 'psutil._psutil_posix' extension 06:15:21 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 06:15:21 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 06:15:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:23 INFO - Successfully installed psutil 06:15:23 INFO - Cleaning up... 06:15:23 INFO - Return code: 0 06:15:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:15:23 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')]} 06:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:23 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')]} 06:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:23 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 0x28331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3090>, '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 0x2ba3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9df90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', '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 06:15:23 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 06:15:23 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 06:15:23 INFO - Using env: {'DISPLAY': ':0', 06:15:23 INFO - 'HOME': '/home/cltbld', 06:15:23 INFO - 'LANG': 'en_US.UTF-8', 06:15:23 INFO - 'LANGUAGE': 'en_US:en', 06:15:23 INFO - 'LOGNAME': 'cltbld', 06:15:23 INFO - 'MAIL': '/var/mail/cltbld', 06:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:23 INFO - 'MOZ_NO_REMOTE': '1', 06:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:23 INFO - 'NO_EM_RESTART': '1', 06:15:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:23 INFO - 'PWD': '/builds/slave/test', 06:15:23 INFO - 'SHELL': '/bin/bash', 06:15:23 INFO - 'SHLVL': '1', 06:15:23 INFO - 'TERM': 'linux', 06:15:23 INFO - 'TMOUT': '86400', 06:15:23 INFO - 'USER': 'cltbld', 06:15:23 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', 06:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:23 INFO - '_': '/tools/buildbot/bin/python'} 06:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:15:23 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 06:15:23 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 06:15:23 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 06:15:23 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 06:15:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:15:24 INFO - Installing collected packages: mozsystemmonitor 06:15:24 INFO - Running setup.py install for mozsystemmonitor 06:15:25 INFO - Successfully installed mozsystemmonitor 06:15:25 INFO - Cleaning up... 06:15:26 INFO - Return code: 0 06:15:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:15: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')]} 06:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15: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')]} 06:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:26 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 0x28331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3090>, '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 0x2ba3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9df90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', '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 06:15:26 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 06:15:26 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 06:15:26 INFO - Using env: {'DISPLAY': ':0', 06:15:26 INFO - 'HOME': '/home/cltbld', 06:15:26 INFO - 'LANG': 'en_US.UTF-8', 06:15:26 INFO - 'LANGUAGE': 'en_US:en', 06:15:26 INFO - 'LOGNAME': 'cltbld', 06:15:26 INFO - 'MAIL': '/var/mail/cltbld', 06:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:26 INFO - 'MOZ_NO_REMOTE': '1', 06:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:26 INFO - 'NO_EM_RESTART': '1', 06:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:26 INFO - 'PWD': '/builds/slave/test', 06:15:26 INFO - 'SHELL': '/bin/bash', 06:15:26 INFO - 'SHLVL': '1', 06:15:26 INFO - 'TERM': 'linux', 06:15:26 INFO - 'TMOUT': '86400', 06:15:26 INFO - 'USER': 'cltbld', 06:15:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', 06:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:26 INFO - '_': '/tools/buildbot/bin/python'} 06:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:26 INFO - Downloading/unpacking jsonschema==2.5.1 06:15:26 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 06:15:26 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 06:15:26 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 06:15:26 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 06:15:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:15:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:15:29 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 06:15:29 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 06:15:29 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 06:15:29 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 06:15:29 INFO - Downloading functools32-3.2.3-2.tar.gz 06:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:15:29 INFO - warning: no files found matching '*.txt' 06:15:29 INFO - no previously-included directories found matching 'build' 06:15:29 INFO - no previously-included directories found matching 'dist' 06:15:29 INFO - no previously-included directories found matching '.git*' 06:15:29 INFO - Installing collected packages: jsonschema, functools32 06:15:29 INFO - Running setup.py install for functools32 06:15:30 INFO - warning: no files found matching '*.txt' 06:15:30 INFO - no previously-included directories found matching 'build' 06:15:30 INFO - no previously-included directories found matching 'dist' 06:15:30 INFO - no previously-included directories found matching '.git*' 06:15:30 INFO - Successfully installed jsonschema functools32 06:15:30 INFO - Cleaning up... 06:15:30 INFO - Return code: 0 06:15:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:30 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 0x28331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3090>, '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 0x2ba3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9df90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', '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 06:15:30 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 06:15:30 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 06:15:30 INFO - Using env: {'DISPLAY': ':0', 06:15:30 INFO - 'HOME': '/home/cltbld', 06:15:30 INFO - 'LANG': 'en_US.UTF-8', 06:15:30 INFO - 'LANGUAGE': 'en_US:en', 06:15:30 INFO - 'LOGNAME': 'cltbld', 06:15:30 INFO - 'MAIL': '/var/mail/cltbld', 06:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:30 INFO - 'MOZ_NO_REMOTE': '1', 06:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:30 INFO - 'NO_EM_RESTART': '1', 06:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:30 INFO - 'PWD': '/builds/slave/test', 06:15:30 INFO - 'SHELL': '/bin/bash', 06:15:30 INFO - 'SHLVL': '1', 06:15:30 INFO - 'TERM': 'linux', 06:15:30 INFO - 'TMOUT': '86400', 06:15:30 INFO - 'USER': 'cltbld', 06:15:30 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', 06:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:30 INFO - '_': '/tools/buildbot/bin/python'} 06:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:15:30 INFO - Cleaning up... 06:15:30 INFO - Return code: 0 06:15:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:30 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 0x28331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3090>, '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 0x2ba3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9df90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', '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 06:15:30 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 06:15:30 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 06:15:30 INFO - Using env: {'DISPLAY': ':0', 06:15:30 INFO - 'HOME': '/home/cltbld', 06:15:30 INFO - 'LANG': 'en_US.UTF-8', 06:15:30 INFO - 'LANGUAGE': 'en_US:en', 06:15:30 INFO - 'LOGNAME': 'cltbld', 06:15:30 INFO - 'MAIL': '/var/mail/cltbld', 06:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:30 INFO - 'MOZ_NO_REMOTE': '1', 06:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:30 INFO - 'NO_EM_RESTART': '1', 06:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:30 INFO - 'PWD': '/builds/slave/test', 06:15:30 INFO - 'SHELL': '/bin/bash', 06:15:30 INFO - 'SHLVL': '1', 06:15:30 INFO - 'TERM': 'linux', 06:15:30 INFO - 'TMOUT': '86400', 06:15:30 INFO - 'USER': 'cltbld', 06:15:30 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', 06:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:30 INFO - '_': '/tools/buildbot/bin/python'} 06:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:30 INFO - Downloading/unpacking blobuploader==1.2.4 06:15:30 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 06:15:30 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 06:15:30 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 06:15:30 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 06:15:31 INFO - Downloading blobuploader-1.2.4.tar.gz 06:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:15:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:15:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:15:32 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 06:15:32 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 06:15:32 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 06:15:32 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 06:15:32 INFO - Downloading docopt-0.6.1.tar.gz 06:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:15:32 INFO - Installing collected packages: blobuploader, requests, docopt 06:15:32 INFO - Running setup.py install for blobuploader 06:15:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:15:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:15:32 INFO - Running setup.py install for requests 06:15:32 INFO - Running setup.py install for docopt 06:15:32 INFO - Successfully installed blobuploader requests docopt 06:15:32 INFO - Cleaning up... 06:15:32 INFO - Return code: 0 06:15:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:32 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')]} 06:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:32 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')]} 06:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:32 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 0x28331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3090>, '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 0x2ba3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9df90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', '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 06:15:32 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 06:15:32 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 06:15:32 INFO - Using env: {'DISPLAY': ':0', 06:15:32 INFO - 'HOME': '/home/cltbld', 06:15:32 INFO - 'LANG': 'en_US.UTF-8', 06:15:32 INFO - 'LANGUAGE': 'en_US:en', 06:15:32 INFO - 'LOGNAME': 'cltbld', 06:15:32 INFO - 'MAIL': '/var/mail/cltbld', 06:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:32 INFO - 'MOZ_NO_REMOTE': '1', 06:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:32 INFO - 'NO_EM_RESTART': '1', 06:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:32 INFO - 'PWD': '/builds/slave/test', 06:15:32 INFO - 'SHELL': '/bin/bash', 06:15:32 INFO - 'SHLVL': '1', 06:15:32 INFO - 'TERM': 'linux', 06:15:32 INFO - 'TMOUT': '86400', 06:15:32 INFO - 'USER': 'cltbld', 06:15:32 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', 06:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:32 INFO - '_': '/tools/buildbot/bin/python'} 06:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:33 INFO - Running setup.py (path:/tmp/pip-EXn9tM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:33 INFO - Running setup.py (path:/tmp/pip-n2LT9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:33 INFO - Running setup.py (path:/tmp/pip-nZPg3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:33 INFO - Running setup.py (path:/tmp/pip-_a9dCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:33 INFO - Running setup.py (path:/tmp/pip-82c3Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:33 INFO - Running setup.py (path:/tmp/pip-l8JyhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:33 INFO - Running setup.py (path:/tmp/pip-nkK4WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:33 INFO - Running setup.py (path:/tmp/pip-hem7gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:33 INFO - Running setup.py (path:/tmp/pip-ySYBgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:33 INFO - Running setup.py (path:/tmp/pip-Ig23us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:33 INFO - Running setup.py (path:/tmp/pip-owzh8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:33 INFO - Running setup.py (path:/tmp/pip-S80ylW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:33 INFO - Running setup.py (path:/tmp/pip-GL827N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:33 INFO - Running setup.py (path:/tmp/pip-my695B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:34 INFO - Running setup.py (path:/tmp/pip-StOMIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:34 INFO - Running setup.py (path:/tmp/pip-rb4IiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:34 INFO - Running setup.py (path:/tmp/pip-i0cEmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:15:34 INFO - Running setup.py install for manifestparser 06:15:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:15:34 INFO - Running setup.py install for mozcrash 06:15:34 INFO - Running setup.py install for mozdebug 06:15:34 INFO - Running setup.py install for mozdevice 06:15:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:15:34 INFO - Running setup.py install for mozfile 06:15:34 INFO - Running setup.py install for mozhttpd 06:15:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:15:34 INFO - Running setup.py install for mozinfo 06:15:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:15:34 INFO - Running setup.py install for mozInstall 06:15:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Running setup.py install for mozleak 06:15:35 INFO - Running setup.py install for mozlog 06:15:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Running setup.py install for moznetwork 06:15:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Running setup.py install for mozprocess 06:15:35 INFO - Running setup.py install for mozprofile 06:15:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Running setup.py install for mozrunner 06:15:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Running setup.py install for mozscreenshot 06:15:35 INFO - Running setup.py install for moztest 06:15:35 INFO - Running setup.py install for mozversion 06:15:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:15:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:15:36 INFO - Cleaning up... 06:15:36 INFO - Return code: 0 06:15:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:36 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')]} 06:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:36 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')]} 06:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:36 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 0x28331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3090>, '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 0x2ba3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9df90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', '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 06:15:36 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 06:15:36 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 06:15:36 INFO - Using env: {'DISPLAY': ':0', 06:15:36 INFO - 'HOME': '/home/cltbld', 06:15:36 INFO - 'LANG': 'en_US.UTF-8', 06:15:36 INFO - 'LANGUAGE': 'en_US:en', 06:15:36 INFO - 'LOGNAME': 'cltbld', 06:15:36 INFO - 'MAIL': '/var/mail/cltbld', 06:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:36 INFO - 'MOZ_NO_REMOTE': '1', 06:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:36 INFO - 'NO_EM_RESTART': '1', 06:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:36 INFO - 'PWD': '/builds/slave/test', 06:15:36 INFO - 'SHELL': '/bin/bash', 06:15:36 INFO - 'SHLVL': '1', 06:15:36 INFO - 'TERM': 'linux', 06:15:36 INFO - 'TMOUT': '86400', 06:15:36 INFO - 'USER': 'cltbld', 06:15:36 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', 06:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:36 INFO - '_': '/tools/buildbot/bin/python'} 06:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:36 INFO - Running setup.py (path:/tmp/pip-2m38D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:36 INFO - Running setup.py (path:/tmp/pip-5AMxqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:36 INFO - Running setup.py (path:/tmp/pip-qJrfjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:36 INFO - Running setup.py (path:/tmp/pip-k8XmeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:36 INFO - Running setup.py (path:/tmp/pip-xg8eBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:36 INFO - Running setup.py (path:/tmp/pip-11k049-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:36 INFO - Running setup.py (path:/tmp/pip-ZUfPHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:36 INFO - Running setup.py (path:/tmp/pip-PDZEtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:36 INFO - Running setup.py (path:/tmp/pip-kvNatt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:36 INFO - Running setup.py (path:/tmp/pip-BmLafh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:36 INFO - Running setup.py (path:/tmp/pip-UgCX1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:37 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)) 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:37 INFO - Running setup.py (path:/tmp/pip-4Oawyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:37 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)) 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:37 INFO - Running setup.py (path:/tmp/pip-DWF2UZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:37 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)) 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:37 INFO - Running setup.py (path:/tmp/pip-2lf7zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:37 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)) 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:37 INFO - Running setup.py (path:/tmp/pip-qwGRWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:37 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)) 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:37 INFO - Running setup.py (path:/tmp/pip-3uIYBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:37 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)) 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:37 INFO - Running setup.py (path:/tmp/pip-2A12eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:37 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)) 06:15:37 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)) 06:15:37 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)) 06:15:37 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)) 06:15:37 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)) 06:15:37 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)) 06:15:37 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)) 06:15:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:15:37 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 06:15:37 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 06:15:37 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 06:15:37 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 06:15:38 INFO - Downloading blessings-1.6.tar.gz 06:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:15:38 INFO - Installing collected packages: blessings 06:15:38 INFO - Running setup.py install for blessings 06:15:38 INFO - Successfully installed blessings 06:15:38 INFO - Cleaning up... 06:15:38 INFO - Return code: 0 06:15:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:15:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:38 INFO - Reading from file tmpfile_stdout 06:15:38 INFO - Current package versions: 06:15:39 INFO - argparse == 1.2.1 06:15:39 INFO - blessings == 1.6 06:15:39 INFO - blobuploader == 1.2.4 06:15:39 INFO - docopt == 0.6.1 06:15:39 INFO - functools32 == 3.2.3-2 06:15:39 INFO - jsonschema == 2.5.1 06:15:39 INFO - manifestparser == 1.1 06:15:39 INFO - mozInstall == 1.13 06:15:39 INFO - mozcrash == 1.0 06:15:39 INFO - mozdebug == 0.1 06:15:39 INFO - mozdevice == 0.51 06:15:39 INFO - mozfile == 1.2 06:15:39 INFO - mozhttpd == 0.7 06:15:39 INFO - mozinfo == 0.10 06:15:39 INFO - mozleak == 0.1 06:15:39 INFO - mozlog == 3.5 06:15:39 INFO - moznetwork == 0.27 06:15:39 INFO - mozprocess == 0.25 06:15:39 INFO - mozprofile == 0.28 06:15:39 INFO - mozrunner == 6.13 06:15:39 INFO - mozscreenshot == 0.1 06:15:39 INFO - mozsystemmonitor == 0.3 06:15:39 INFO - moztest == 0.8 06:15:39 INFO - mozversion == 1.4 06:15:39 INFO - psutil == 3.1.1 06:15:39 INFO - requests == 1.2.3 06:15:39 INFO - wsgiref == 0.1.2 06:15:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:39 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')]} 06:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:39 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')]} 06:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:39 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 0x28331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3090>, '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 0x2ba3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9df90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', '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 06:15:39 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 06:15:39 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 06:15:39 INFO - Using env: {'DISPLAY': ':0', 06:15:39 INFO - 'HOME': '/home/cltbld', 06:15:39 INFO - 'LANG': 'en_US.UTF-8', 06:15:39 INFO - 'LANGUAGE': 'en_US:en', 06:15:39 INFO - 'LOGNAME': 'cltbld', 06:15:39 INFO - 'MAIL': '/var/mail/cltbld', 06:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:39 INFO - 'MOZ_NO_REMOTE': '1', 06:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:39 INFO - 'NO_EM_RESTART': '1', 06:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:39 INFO - 'PWD': '/builds/slave/test', 06:15:39 INFO - 'SHELL': '/bin/bash', 06:15:39 INFO - 'SHLVL': '1', 06:15:39 INFO - 'TERM': 'linux', 06:15:39 INFO - 'TMOUT': '86400', 06:15:39 INFO - 'USER': 'cltbld', 06:15:39 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', 06:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:39 INFO - '_': '/tools/buildbot/bin/python'} 06:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:39 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)) 06:15:39 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)) 06:15:39 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)) 06:15:39 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)) 06:15:39 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)) 06:15:39 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)) 06:15:39 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)) 06:15:39 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)) 06:15:39 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)) 06:15:39 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:15:39 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 06:15:39 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 06:15:39 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 06:15:39 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 06:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:15:40 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)) 06:15:40 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)) 06:15:40 INFO - Installing collected packages: simplejson 06:15:40 INFO - Running setup.py install for simplejson 06:15:40 INFO - building 'simplejson._speedups' extension 06:15:40 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 06:15:41 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 06:15:41 INFO - Successfully installed simplejson 06:15:41 INFO - Cleaning up... 06:15:41 INFO - Return code: 0 06:15:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:41 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 0x28331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3090>, '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 0x2ba3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9df90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', '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 06:15:41 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 06:15:41 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 06:15:41 INFO - Using env: {'DISPLAY': ':0', 06:15:41 INFO - 'HOME': '/home/cltbld', 06:15:41 INFO - 'LANG': 'en_US.UTF-8', 06:15:41 INFO - 'LANGUAGE': 'en_US:en', 06:15:41 INFO - 'LOGNAME': 'cltbld', 06:15:41 INFO - 'MAIL': '/var/mail/cltbld', 06:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:41 INFO - 'MOZ_NO_REMOTE': '1', 06:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:41 INFO - 'NO_EM_RESTART': '1', 06:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:41 INFO - 'PWD': '/builds/slave/test', 06:15:41 INFO - 'SHELL': '/bin/bash', 06:15:41 INFO - 'SHLVL': '1', 06:15:41 INFO - 'TERM': 'linux', 06:15:41 INFO - 'TMOUT': '86400', 06:15:41 INFO - 'USER': 'cltbld', 06:15:41 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', 06:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:41 INFO - '_': '/tools/buildbot/bin/python'} 06:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:15:41 INFO - Cleaning up... 06:15:41 INFO - Return code: 0 06:15:41 INFO - Running post-action listener: _resource_record_post_action 06:15:41 INFO - Running post-action listener: _start_resource_monitoring 06:15:41 INFO - Starting resource monitoring. 06:15:41 INFO - [mozharness: 2017-09-20 13:15:41.712412Z] Finished create-virtualenv step (success) 06:15:41 INFO - [mozharness: 2017-09-20 13:15:41.712884Z] Running install step. 06:15:41 INFO - Running pre-action listener: _resource_record_pre_action 06:15:41 INFO - Running main action method: install 06:15:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:41 INFO - Reading from file tmpfile_stdout 06:15:41 INFO - Detecting whether we're running mozinstall >=1.0... 06:15:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:15:42 INFO - Reading from file tmpfile_stdout 06:15:42 INFO - Output received: 06:15:42 INFO - Usage: mozinstall [options] installer 06:15:42 INFO - Options: 06:15:42 INFO - -h, --help show this help message and exit 06:15:42 INFO - -d DEST, --destination=DEST 06:15:42 INFO - Directory to install application into. [default: 06:15:42 INFO - "/builds/slave/test"] 06:15:42 INFO - --app=APP Application being installed. [default: firefox] 06:15:42 INFO - mkdir: /builds/slave/test/build/application 06:15:42 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'] 06:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:15:59 INFO - Reading from file tmpfile_stdout 06:15:59 INFO - Output received: 06:15:59 INFO - /builds/slave/test/build/application/firefox/firefox 06:15:59 INFO - Running post-action listener: _resource_record_post_action 06:15:59 INFO - [mozharness: 2017-09-20 13:15:59.824233Z] Finished install step (success) 06:15:59 INFO - [mozharness: 2017-09-20 13:15:59.824489Z] Running setup-mitmproxy step. 06:15:59 INFO - Running pre-action listener: _resource_record_pre_action 06:15:59 INFO - Running main action method: setup_mitmproxy 06:15:59 INFO - Skipping: mitmproxy is not required 06:15:59 INFO - Running post-action listener: _resource_record_post_action 06:15:59 INFO - [mozharness: 2017-09-20 13:15:59.825614Z] Finished setup-mitmproxy step (success) 06:15:59 INFO - [mozharness: 2017-09-20 13:15:59.825835Z] Running run-tests step. 06:15:59 INFO - Running pre-action listener: _resource_record_pre_action 06:15:59 INFO - Running pre-action listener: _set_gcov_prefix 06:15:59 INFO - Running main action method: run_tests 06:15:59 WARNING - Try message not found. 06:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:15:59 INFO - Python 2.7.3 06:15:59 INFO - Return code: 0 06:15:59 INFO - grabbing minidump binary from tooltool 06:15: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')]} 06:15:59 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 0x2ba3090>, '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 0x2ba3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:15:59 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 06:15:59 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 06:15:59 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 06:15:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:15:59 INFO - Return code: 0 06:15:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:15:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:15:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:15:59 INFO - ENV: RUST_BACKTRACE is now full 06:15:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:15:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:15:59 INFO - Using env: {'DISPLAY': ':0', 06:15:59 INFO - 'HOME': '/home/cltbld', 06:15:59 INFO - 'LANG': 'en_US.UTF-8', 06:15:59 INFO - 'LANGUAGE': 'en_US:en', 06:15:59 INFO - 'LOGNAME': 'cltbld', 06:15:59 INFO - 'MAIL': '/var/mail/cltbld', 06:15:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:15:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:15:59 INFO - 'MOZ_ACCELERATED': '1', 06:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:59 INFO - 'MOZ_NO_REMOTE': '1', 06:15:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:15:59 INFO - 'MOZ_WEBRENDER': '1', 06:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:59 INFO - 'NO_EM_RESTART': '1', 06:15:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:59 INFO - 'PWD': '/builds/slave/test', 06:15:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:15:59 INFO - 'RUST_BACKTRACE': 'full', 06:15:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:15:59 INFO - 'SHELL': '/bin/bash', 06:15:59 INFO - 'SHLVL': '1', 06:15:59 INFO - 'TERM': 'linux', 06:15:59 INFO - 'TMOUT': '86400', 06:15:59 INFO - 'USER': 'cltbld', 06:15:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', 06:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:59 INFO - '_': '/tools/buildbot/bin/python'} 06:15:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:16:00 INFO - mozversion application_buildid: 20170920094823 06:16:00 INFO - mozversion application_changeset: a20de99fa3c1ba6287fe47d493a859a4e95120b0 06:16:00 INFO - mozversion application_display_name: Nightly 06:16:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:16:00 INFO - mozversion application_name: Firefox 06:16:00 INFO - mozversion application_remotingname: firefox 06:16:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:16:00 INFO - mozversion application_vendor: Mozilla 06:16:00 INFO - mozversion application_version: 57.0a1 06:16:00 INFO - mozversion platform_buildid: 20170920094823 06:16:00 INFO - mozversion platform_changeset: a20de99fa3c1ba6287fe47d493a859a4e95120b0 06:16:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:16:00 INFO - mozversion platform_version: 57.0a1 06:16:00 INFO - using testdate: 1505913360 06:16:00 INFO - actual date: 1505913360 06:16:00 INFO - starting webserver on 'localhost:53124' 06:16:00 INFO - SUITE-START | Running 2 tests 06:16:00 INFO - TEST-START | dromaeo_css 06:16:00 INFO - Initialising browser for dromaeo_css test... 06:16:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53124/getInfo.html -profile /tmp/tmpRmQjNQ/profile 06:16:00 INFO - TEST-INFO | started process 14908 (/builds/slave/test/build/application/firefox/firefox http://localhost:53124/getInfo.html) 06:16:07 INFO - TEST-INFO | 14908: exit 0 06:16:07 INFO - Browser initialized. 06:16:07 INFO - Running cycle 1/1 for dromaeo_css test... 06:16:07 INFO - Using env: {'DISPLAY': ':0', 06:16:07 INFO - 'HOME': '/home/cltbld', 06:16:07 INFO - 'JSGC_DISABLE_POISONING': '1', 06:16:07 INFO - 'LANG': 'en_US.UTF-8', 06:16:07 INFO - 'LANGUAGE': 'en_US:en', 06:16:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:16:07 INFO - 'LOGNAME': 'cltbld', 06:16:07 INFO - 'MAIL': '/var/mail/cltbld', 06:16:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:16:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:16:07 INFO - 'MOZ_ACCELERATED': '1', 06:16:07 INFO - 'MOZ_CRASHREPORTER': '1', 06:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:16:07 INFO - 'MOZ_NO_REMOTE': '1', 06:16:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:16:07 INFO - 'MOZ_WEBRENDER': '1', 06:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:07 INFO - 'NO_EM_RESTART': '1', 06:16:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:07 INFO - 'PWD': '/builds/slave/test', 06:16:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:16:07 INFO - 'RUST_BACKTRACE': 'full', 06:16:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:16:07 INFO - 'SHELL': '/bin/bash', 06:16:07 INFO - 'SHLVL': '1', 06:16:07 INFO - 'TERM': 'linux', 06:16:07 INFO - 'TMOUT': '86400', 06:16:07 INFO - 'USER': 'cltbld', 06:16:07 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', 06:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:07 INFO - '_': '/tools/buildbot/bin/python'} 06:16:07 INFO - TEST-INFO | started process 15159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRmQjNQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:08 INFO - PID 15159 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:16:08 INFO - PID 15159 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:16:08 INFO - PID 15159 | 06:16:08 INFO - PID 15159 | (/builds/slave/test/build/application/firefox/firefox:15219): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:16:08 INFO - PID 15159 | 06:16:18 INFO - PID 15159 | RSS: Main: 186277888 06:16:18 INFO - PID 15159 | 06:19:16 INFO - PID 15159 | Cycle 1(1): loaded http://localhost:53124/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53124/tests/dromaeo/cssquery-ext.html) 06:19:17 INFO - PID 15159 | RSS: Main: 187351040 06:19:17 INFO - PID 15159 | 06:22:19 INFO - PID 15159 | Cycle 1(1): loaded http://localhost:53124/tests/dromaeo/cssquery-ext.html (next: http://localhost:53124/tests/dromaeo/cssquery-jquery.html) 06:22:20 INFO - PID 15159 | RSS: Main: 191033344 06:22:20 INFO - PID 15159 | 06:25:22 INFO - PID 15159 | Cycle 1(1): loaded http://localhost:53124/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53124/tests/dromaeo/cssquery-mootools.html) 06:25:23 INFO - PID 15159 | RSS: Main: 190885888 06:25:23 INFO - PID 15159 | 06:28:25 INFO - PID 15159 | Cycle 1(1): loaded http://localhost:53124/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53124/tests/dromaeo/cssquery-prototype.html) 06:28:25 INFO - PID 15159 | RSS: Main: 188973056 06:28:25 INFO - PID 15159 | 06:31:29 INFO - PID 15159 | Cycle 1(1): loaded http://localhost:53124/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53124/tests/dromaeo/cssquery-yui.html) 06:31:30 INFO - PID 15159 | RSS: Main: 190226432 06:31:30 INFO - PID 15159 | 06:34:31 INFO - PID 15159 | Cycle 1(1): loaded http://localhost:53124/tests/dromaeo/cssquery-yui.html (next: http://localhost:53124/tests/dromaeo/cssquery-dojo.html) 06:34:32 INFO - PID 15159 | RSS: Main: 192184320 06:34:32 INFO - PID 15159 | 06:34:32 INFO - PID 15159 | __start_tp_report 06:34:32 INFO - PID 15159 | _x_x_mozilla_page_load 06:34:32 INFO - PID 15159 | _x_x_mozilla_page_load_details 06:34:32 INFO - PID 15159 | |i|pagename|runs| 06:34:32 INFO - PID 15159 | |0;dojo.html;3111.268851819822;3120.141960960734;3144.8270345131023;3146.6695996920307;3170.2549900773315;6169.19800425944;6323.146375239353;6364.077208804721;6408.967955160224;6485.481161507074;6224.470919971808;6238.59449135807;6256.405641464065;6298.6535740534255;6305.117283580291;5760.452756988079;5863.882722345551;5927.792527261547;5928.881422371572;5933.614315069528;1275.5580990813896;5878.529717622601;5954.761809527614;5981.312149102865;5992.2809262888295;5375.919361209585;5667.801626943058;5689.345725241588;5898.115282707586;5906.527477801766;5820.912686309666;5831.562632802556;5861.6483011019045;5915.497182739472;5923.289205295349;5742.052561327418;5747.798827041033;5806.59353845231;5819.563532735062;5829.47534721877;6283.403076707706;6343.777967771152;6356.650384228866;6396.904046439261;6410.2628197757385;6766.052752614638;6836.213835408942;6861.897071543881;6864.519483636147;6880.518363714542;6607.174103237096;6644.534882558174;6813.557118787263;6899.551529150589;6903.896441553381;6248.937510624881;6308.526860485436;6408.551401401857;6421.999999999954;6423;6989.755358562527;7005.879059350479;7066.505344625827;7093.184283807428;7130.92869071313;6578.605283682994;6654.73381064752;6688.264290927994;6720.697568609425;6726.630035348005;6613.702383392759;6699.095622091053;6712.42944349726;6716.194056713226;6733.730650773914;6614.536982411185;6622.072909792633;6637.568558043712;6656.900146497806;6669.633170175687;6555.934440655627;6669.63317017559;6683.43190828785;6773.390394864486;6894.172699276119;5330.546903513167;5350.0904846176245;5368.812091576854;5371.274877891513;5376.946230537723;4565.954340456619;4630.467496237909;4671.182543054952;4672;4689.390379250675;5731.627444216113;5783.971080144573;5851.32709738377;5883;5893.233879595625;6692.86614267712;6772.8984065239065;6792.388685018372;6833.487488438387;6881.449484041264;5868.67722275279;5902.144189092557;5915.290165180206;5933.465988061009;5945.40545945402;5861.970690146607;5875.471207591338;5930.080837470199;5949.286085669747;5953.791617293374;6257.186565746515;6350.015747559136;6422.8715425691225;6536.150300460909;6624.006399040086;6665.400113989765;6710.563813352116;6716.29478904708;6723.630200339028;6742.797716068526;6361.300256971637;6470.902936456051;6487.026945958144;6496.317886622026;6503.2846386898345;6351.96824015877;6579.276279609144;6596.8350791230605;6606.10817539626;6650.235222949423;5805.303363596396;6865.862682746417;6873.140857392826;6906.827329316808;6946.0622815919205;6501.707423166064;6542.247641521096;6671.332866713484;6671.499637527302;6703.229128650072;6408.58344207625;6483.610983341015;6579.769708060195;6587.077809106633;6683.064370987969;6429.32492088324;6460;6476.546641735222;6486.772962946275;6496.70764815575;6580.618070205119;6584.176977877765;6599.472042236705;6624.56940298879;6746.291639377795;6464.612123272619;6496.090547323284;6497.4477169441125;6551.672416379257;6558.344165583403 06:34:32 INFO - PID 15159 | |1;ext.html;869.3870821071146;890.4123278636098;891.9108089191086;897.6544030548237;899.9685011024616;37286.81356593216;41743;41840.163196736125;41844.79077604615;41883.162336753245;37402.438963415574;37437;37674.24651506968;37745.62254377455;37919.431208531896;7114.075170227876;7182.102237220348;7184.928150718504;7239.493235473519;7242.239564845694;7760.844783104335;7876.842463150762;7884.211578842127;7899.88150177745;7954.00574928134;7903.960480197591;7913.208679132098;7960.681572737083;7968.760937171865;7977.122516523178;7843.921560784376;7903.762887113396;7915.920840791576;8125.512469251805;8125.512469251864;7831.569263690495;7909.090454597737;7921.801954951115;7930.841383172305;7952.562609056499;36985.075373115884;37038.44442333367;37066;37088;37259.4411083834;3559.75081744278;3576.624454432299;3579.821008949542;3589.74871758977;3596.1009747563107;30658.69341306581;30746.23134421635;30830.69169308323;31040.8447957761;31092.844535777404;5239.397469291042;5248.186531087687;5294.232336311252;5311.654742441729;5330.9733451332495;190837.04581477144;190841;191879;192581;192772;41399.58600413957;42567.361489577685;47960.28059579109;47968;48180;50000;50846.49153508492;50866;51060.744696276284;51286.743566281926;14945.17801520905;15008.474703385547;15130.697386052218;15160.696786064216;15181.772273415907;12089.57686480969;12157.148999569945;12168.81746773799;12177.817332740016;12203.45084471201;13840.23878686682;13968.161910285415;14076.648083797987;14106.294685265695;14250.85749142516;5530.86172845674;5586.413426590231;5617.32592088952;5739.62692424991;5742.109972954116;1004.3421558878946;1010.9848352274722;1020.1125021231428;1020.6733845169474;1022.1260821997234;22372.776272237068;22386;22399.88800056022;22662.66006009911;22689;1106.690126764507;1117.5585643670704;1123.084685980923;1127.5715228213226;1134.0983917785381;12191.695207619881;12287;12321;12346.259224446561;12380.690482738004;223255;223588;223775;225129;225684;51865.2220216697;51873;51919.48080519222;52024.73987630037;52081;1399.216438794258;1448.9492867749789;1458.3874772595536;1465.7874608181753;1468.7356275870445;22197.88901055549;22614.886925565268;22621.88689056544;22905.427364316027;23041.423964401023;36765.26469470649;36799.63200367962;36825.07937301589;36937.44593831148;36951.8152409247;197794;198826;199194;199927;200102;29983.05110167832;31046.22384440407;32633.836830815693;32839;33044.504332435514;41400.37899431451;41446;41928.371074434515;42433;42492;30640.84679576677;30880.227994300323;30984;31073.378532429677;31920.52119218167;30868.845655771576;30874.69125308718;31084;31135.68864311328;31461;34015;34918.30163396768;35068;35222.47166292457;35241.64758352384;30599.54100688447;30784.846075769477;30798.384032319675;30881.382372351978;30914;22358.329250122522;22646.320610381714;22715.432114197276;22792.658110128028;22815.88592057029 06:34:32 INFO - PID 15159 | |2;jquery.html;558.4555058817654;574.8562859285179;575.847400438884;576.4293349583908;587.6209844650201;22012.88993555032;23155.884220578915;23169;23186.768132318673;23241.418964525918;23516.88241558794;24112.156074537394;24515.387115322126;24696.75303246967;25067.24798256055;6436.581622194554;6554.901676474857;6610.3720146586;6633.170853643294;6644.202695676526;6573.605583664971;6641.568298060611;6663.933360666404;6688.799336019927;6691.966540167292;6328.462080723121;6556.14770079889;6571.3757193066585;6623.271440141581;6633.402993730563;6583.275839657634;6608.735650573995;6641.800745977628;6647.368499992517;6657.567258128206;5872.588918775645;6119.969400152971;6123.6938153092615;6162.106494558308;6191.907121393183;29159.562606560918;29767.25581860449;29798.404031919457;29799.851000744857;29804.850975744983;2062.2060506704875;2078.594674038563;2086.634838903201;2091.6757902524982;2096.3815674376096;17869;17945.641087178185;18148;18283.817161828476;18284.17721202536;2371.205646108556;2469.753024697534;2473.9257822265363;2474.5298393305393;2480.8635525046116;117439;121473.39263303627;128491;131708;135559;14622.568751648274;14745.189014604086;14831.546018769199;15149.683549046265;15314.157721325435;23305.650415243785;23346.53306933852;23401.180958666366;23430.414239644146;23486.7651323488;9543.139087877937;9705.563249653782;9749.220062394992;9785.951070244746;9837.163841073445;8751.168638979287;8786.60460279289;8834.469931804113;8857.11428857109;8883.111688831064;9057.780843693337;9089.22741566961;9180.265578753684;9193.598368603525;9195.90804091964;2587.275562842407;2612.529744645982;2632.7235640257495;2694.5553983592486;2743.5157350165177;940.5297351324338;959.194276807485;969.8205831920976;973.8149751547184;975.331897650112;19082.809171908382;19443.319483818283;20083.899580502297;20176.798232017492;20306;1021.6219998600566;1021.7905329407454;1028.7222449938474;1037.4397825174321;1042.3276986343917;11033;11083.889161108447;11093.611723589636;11230.382328971822;11351.205415620827;487455;494242;494590;506100;514272;107356.46321768341;109455.45272273588;109929;109948.4502577498;111432;1044.6552637629563;1127.7913585986619;1139.5783560082823;1184.1651635596884;1197.5150064224176;20677.58644827125;20981.580368392242;20987.370378888656;21082.262120825697;21192.83439410847;51775;54940.17589736237;55316.170257446975;55907.72046139743;57693;70930;71505.6424717873;71626;71923.28076719165;71927.64036179785;14783.630409239855;14926.328315226057;14929.552113436614;15005.849941500883;15307.693846123238;23021.769782301963;23542.293731188092;23852.284431467084;23868.88065559661;24152.75847241505;18546.072696365398;18711.906440467712;18911.148998295386;18916.905415472833;19096;16839.494815155565;16954.660906782043;16970;17282.65434691324;17488.125593720008;19027;19160;19434.8056519433;19671.901640491706;19691.40925772229;14796.704065918837;14903.254837258311;14908.850911490747;14964.40142394292;15003.724683401597;18388.816111839245;18452.261909524004;18838.3406580769;18852.34016809405;18944.52638684044 06:34:32 INFO - PID 15159 | |3;mootools.html;1319.2612137203166;1410.5909286306971;1416.1290806154211;1421.6374824419784;1423.7294913966346;14442.638934026641;15230.39078436864;15318.923405382986;15356;15394.692106157898;15071.095734255925;15181.240937953113;15202.315895784688;15203.847961520381;15214;2690.0853709738685;2726.6864310604237;2760.834349939;2761.972380276202;2776.1255204610484;2614.0720044384257;2677.170077276041;2685.704572497024;2701.3651791828906;2710.6747190337187;2570.7043689975703;2660.6940201876837;2733.3576609496754;2746.931326716828;2747.8900843966317;2685.6642919635046;2686.7984901132395;2713.091114476653;2713.430179662273;2717.1576811188397;2683.6242925990377;2715.5383584790634;2716.0765339784566;2719.945601087967;2725.4004119093966;14720.116792992347;15053.774193387108;15064.849351506455;15073;15073.924630376887;7469.663865126083;7703.1526532081425;7759.65081571325;7792.220777922219;7801;5408.513233808976;5490.1883559957605;5580.497755202051;5686.289213848269;5734.254546908917;1960.6666866632706;1993.5016245938516;2014.0634604908787;2018.8788672679539;2040.897955102239;26556.86721566399;26621.73378266212;26762.063327783435;26852.597211041655;26861.925522979058;7287.744928927462;7361.190269070398;7491.138519070268;7618.809529761689;7684.269994350528;17540.122993850255;17542.21060052301;17729.379471718687;17756.733648995276;17761.644767104586;7963.442559020813;8138.796530086795;8151.918480815235;8159.95920020408;8165.183481651906;7471.215522370181;7491.325780679765;7517.361024312885;7533.096028476618;7631.923680763232;5256.763445644955;5408.783648654088;5429.239906413105;5449.754761035763;5470.343558772973;1406.8874490040773;1551.697419003306;1555.1213564336115;1565.827758946515;1580.8103027636757;768.4352001279055;889.4352086425166;894.181823631383;907.0340087806596;911.8465141595887;8035.517868927883;8041.195880412029;8070.717524886718;8159.857619933214;8167.241120935136;1012.3875055591409;1018.2363227579316;1023.0637175627627;1027.6814187601867;1045.7019749371545;5361.544268737123;5385.111456609694;5425.330529596581;5433.864153396196;5464.12573988168;21484.24805131813;21827.345179644635;22303.888480557816;22510.21214257526;22518.32445026652;20807.68788468174;21833.235836745636;21861.781382185975;22114.668279975813;22194.88902555509;10512;10709.143268538499;11101.500432480558;11190.944045279884;11214.719632009102;8772.736817895473;8942.50816205115;8985.730428087169;9025.097490250922;9038.864417033617;18623.06884655789;18798.718019229447;18881.527961801065;18917;19259.22963081461;19099.8090019098;19263.74785638929;19595.412137635893;19774.70337944961;19943.301984430476;12222.75554488923;12291.32397718134;12337.444814983526;12439.067069969607;12512.74974500523;13758.243296618783;13957.162570245819;14018.719625607635;14026.579202623938;14065.085769424955;11281.71795705114;11305.547778088785;11354.716132096764;11438.714032149262;11599.072074233873;11009.449527523751;11129.16531260175;11208.775824483628;11220.438978051228;11369.772604548029;9635.662751803653;9702.078302561245;9748.171405430334;9781.706548803548;9782.41305521671;7054.894176587458;7096.183938847099;7112.253213412517;7147.463940204401;7214.675339609835;6907.481938854707;6958.652067396712;6987.301269872972;7104.502684812221;7186.820329491805 06:34:32 INFO - PID 15159 | |4;prototype.html;471.3683663890386;485.7037207303544;508.03726937453513;509.4803300633352;518.8573142385843;6222.160008398865;6294.748210071597;6316.936830631692;6318.494520438366;6368.363163683629;6145.846353841156;6166.6300021998595;6199.44205021548;6202.472789812871;6266.62400255985;5101.132807422729;5105.489451054883;5144.717040562768;5167.586593072545;5191.896162076756;5174.2238664200295;5176.741162941857;5193.45468725784;5202.271681964528;5238.371395432553;4754.215554433515;4944.629152813535;5023.321851550048;5034.848954531351;5088.974555127219;4949.3813273340475;4954.7027178369235;4962.6774259673;4971.577415919651;5008.323876276692;4289.978550107261;4433.379326894205;4451.198784218839;4461.910761784746;4469.977650111761;6050.515958723336;6057.363976782419;6085.574009819315;6099.48154406876;6118.816435506942;5665.405132461074;5673.574481913873;5692.5161361284345;5702.800401985952;5715.3998830122655;6492.415682588542;6510.967445162792;6517.543771935966;6558.311377305362;6579.473642108667;4606.170889239936;4807.326974223612;4861.659683822134;4902.681325713817;4906.803727850882;6682.820813869242;6765.93234067658;6888.96665500179;6910.239873613999;6953.860922781516;4882.7314497702255;4911.45973942866;4936.950630493649;4943.2585112233455;4985.875353116201;4973.477784832613;5030.798768049311;5031.6729412588065;5045.823396181116;5053.140966035783;5582.218489411485;5609.298837645294;5622.088489913449;5684.204211410406;5707.6290041147195;6542.738290468423;6564.606123632598;6590.340965903467;6624.205095388585;6702.296258892844;1730.1003478191521;1732.6794543009585;1734.540346808097;1748;1759.322660775585;1122.7810576937582;1169.5555988354376;1189.4647408666135;1189.7858385490522;1203.1157099531838;5635.380108188096;5705.4579814917515;5718.370979192286;5745.454181852718;5750.453706897838;6445.6169804533365;6468.353164683588;6602.73589056442;6674.199096108498;6695.296993815677;5680.715964201773;5685.77256909719;5712.285964254468;5731.885362292731;5774;3524.22467057247;3539.415996360623;3547.94678079829;3548.8643634037376;3555.928881422357;6251.687415629201;6338.334474880164;6393.8721225576155;6436.324185960407;6484.448821850196;6707.6981535831;6808.319168083152;6838.897416538756;6845.349691779273;6896.069030680894;6351.855831363505;6372.330905254974;6426.8714625707225;6439.356064393617;6495.902561461582;6500.8547179429725;6558.1802274715665;6597.80206593803;6652.900206497004;6666.600003999775;5977.850553736192;6425.036244563166;6457.740740555547;6531.791618550584;6617.544140289128;6256.937430625818;6261.592996455216;6329.746810127727;6368.203974503187;6392.9041064385;4847.5394837490385;4867.926981095357;4907.55831975124;4908.993656300521;4947.876303092451;6396.552241343062;6562.639054852029;6566.80299591013;6735.360140786617;6764.627945463047;6363.681815909279;6401.207661854688;6432.839179020375;6434.227892652912;6506.219253689398;6398.232212134573;6459.935400646122;6502.382273683992;6536.673166341759;6536.738530458919;6375.808725738235;6462.5153113515735;6466.644334561644;6476.319986401549;6511.73953041873;6488.740450381932;6511.479081673549;6546.312637173029;6548.639824809681;6669.533132680665;6380.776672816429;6391;6398.776042838478;6403.807885763435;6476.6114033158165 06:34:32 INFO - PID 15159 | |5;yui.html;904.895936967249;913.7669894176984;943.5706753427191;943.6414162618204;945.5461378538297;19353;20140.89929550352;20163.39509814704;20244;20358.694619580718;18124.90937545314;18363.72454413185;18702.064896755175;18864.245430182775;18931.148098335572;965.4352203960691;965.8647789309503;970.2771435280725;970.6748239339829;977.4135518688765;990.9752256193581;997.7505623594102;999.6201443451479;1000.3747657713928;1002.6139936124608;1001.1190152665644;1006.5369929832286;1007.7581380468671;1027.398971601614;1057.7144171073805;994.5623925472769;999.3803841618243;1002.5288114586169;1006.6929586476195;1051.2588625019382;710.1691021504852;721.8917162425626;735.3492159438881;750.8648443280207;755.958422286774;20220.49448763778;20475.38573842787;20552;20586.691199632016;20645.380638580868;21209.469763256042;21431.46421339479;22298.331050068526;22354.552908941892;22354.66468002981;14561.563153105424;15441.691166176613;15513.146776927264;15620.297086631128;15630.45293414725;3704.203596226824;3730.8880733578035;3764.7929363884973;3769.0577355661085;3771.283456143324;138473;138605.3069734645;141568;142750;142762.99999999895;16861.325546978227;17212.827871721373;17260.74108888368;17509.824901751075;17612;31890.362192756016;32320.515192272134;32480.675193248237;32649.347013059607;32895.177620559676;9085.091490850995;9200.769980750534;9204.815903682023;9206.355555111211;9210.263178945668;4228.5982831630945;4244.72409293395;4309.827606895752;4322.6325762309925;4355.4337936068105;5601.719914004365;5654.97172514143;5660.85847853807;5684.8010319638615;5698.373178950312;923.2291036984059;934.5887809363858;956.3974695941512;956.9856452153223;960.4237457525569;653.6208998780696;680.6426626021379;682.7200847652439;692.4529621598881;694.2883544366963;11406.48670809799;11761.823572646417;11901.761964760657;12009.159358844972;12378;686.2348481443155;691.7336825322186;693.7433149734529;705.4708968273794;715.9427245820322;5328.946710532922;5343.412224655285;5398.217258497496;5400.459954004568;5456.236126942231;114858;121821.39089304497;122862.38568807277;122868.38565807114;125508;104735;107883.46058269659;110552;110653;112689;85832.14167858366;87888.5605571968;88194.55902720445;88738.55630721805;90423.54788226017;10064.194864410683;10117.747056323651;10118.08937195656;10191.993361958388;10220;43414;43990;44290.77854610706;45666.08667826691;46021;57387.139192912975;58007.12989305248;58063.70968145132;58143.4185658138;58800.70599646975;15765.605859853595;15822.68354632924;16166.515004549883;16269.67460650804;16285.918570407071;16484.587885302964;16603.833961660228;16751.994880307222;16856.747148793023;17111;16083.517494475185;16119.597010074842;16192.352305907632;16246.512604621881;16639.50081497557;15919.8408015923;16069.758953615472;16118;16190.919045404698;16398.590035249214;15480.303386347416;15587.895634089706;15656.4520241791;15740.370385184464;15843.524694259191;10787.6224332148;10835.404052777172;11147.442627868411;11183.888161118284;11274.718132046437;11736.823947640964;12109.81835272454;12113;12156;12312.199707019015 06:34:32 INFO - PID 15159 | __end_tp_report 06:34:32 INFO - PID 15159 | __start_cc_report 06:34:32 INFO - PID 15159 | _x_x_mozilla_cycle_collect,275 06:34:32 INFO - PID 15159 | __end_cc_report 06:34:32 INFO - PID 15159 | __startTimestamp1505914472189__endTimestamp 06:34:32 INFO - PID 15159 | 06:34:32 INFO - PID 15159 | ------- Summary: start ------- 06:34:32 INFO - PID 15159 | Number of tests: 6 06:34:32 INFO - PID 15159 | 06:34:32 INFO - PID 15159 | [#0] dojo.html Cycles:165 Average:6188.49 Median:6460.00 stddev:835.63 (12.9%) stddev-sans-first:802.57 06:34:32 INFO - PID 15159 | Values: 3111.3 3120.1 3144.8 3146.7 3170.3 6169.2 6323.1 6364.1 6409.0 6485.5 6224.5 6238.6 6256.4 6298.7 6305.1 5760.5 5863.9 5927.8 5928.9 5933.6 1275.6 5878.5 5954.8 5981.3 5992.3 5375.9 5667.8 5689.3 5898.1 5906.5 5820.9 5831.6 5861.6 5915.5 5923.3 5742.1 5747.8 5806.6 5819.6 5829.5 6283.4 6343.8 6356.7 6396.9 6410.3 6766.1 6836.2 6861.9 6864.5 6880.5 6607.2 6644.5 6813.6 6899.6 6903.9 6248.9 6308.5 6408.6 6422.0 6423.0 6989.8 7005.9 7066.5 7093.2 7130.9 6578.6 6654.7 6688.3 6720.7 6726.6 6613.7 6699.1 6712.4 6716.2 6733.7 6614.5 6622.1 6637.6 6656.9 6669.6 6555.9 6669.6 6683.4 6773.4 6894.2 5330.5 5350.1 5368.8 5371.3 5376.9 4566.0 4630.5 4671.2 4672.0 4689.4 5731.6 5784.0 5851.3 5883.0 5893.2 6692.9 6772.9 6792.4 6833.5 6881.4 5868.7 5902.1 5915.3 5933.5 5945.4 5862.0 5875.5 5930.1 5949.3 5953.8 6257.2 6350.0 6422.9 6536.2 6624.0 6665.4 6710.6 6716.3 6723.6 6742.8 6361.3 6470.9 6487.0 6496.3 6503.3 6352.0 6579.3 6596.8 6606.1 6650.2 5805.3 6865.9 6873.1 6906.8 6946.1 6501.7 6542.2 6671.3 6671.5 6703.2 6408.6 6483.6 6579.8 6587.1 6683.1 6429.3 6460.0 6476.5 6486.8 6496.7 6580.6 6584.2 6599.5 6624.6 6746.3 6464.6 6496.1 6497.4 6551.7 6558.3 06:34:32 INFO - PID 15159 | 06:34:32 INFO - PID 15159 | [#1] ext.html Cycles:180 Average:36890.08 Median:34466.65 stddev:53229.17 (154.4%) stddev-sans-first:53309.78 06:34:32 INFO - PID 15159 | Values: 869.4 890.4 891.9 897.7 900.0 37286.8 41743.0 41840.2 41844.8 41883.2 37402.4 37437.0 37674.2 37745.6 37919.4 7114.1 7182.1 7184.9 7239.5 7242.2 7760.8 7876.8 7884.2 7899.9 7954.0 7904.0 7913.2 7960.7 7968.8 7977.1 7843.9 7903.8 7915.9 8125.5 8125.5 7831.6 7909.1 7921.8 7930.8 7952.6 36985.1 37038.4 37066.0 37088.0 37259.4 3559.8 3576.6 3579.8 3589.7 3596.1 30658.7 30746.2 30830.7 31040.8 31092.8 5239.4 5248.2 5294.2 5311.7 5331.0 190837.0 190841.0 191879.0 192581.0 192772.0 41399.6 42567.4 47960.3 47968.0 48180.0 50000.0 50846.5 50866.0 51060.7 51286.7 14945.2 15008.5 15130.7 15160.7 15181.8 12089.6 12157.1 12168.8 12177.8 12203.5 13840.2 13968.2 14076.6 14106.3 14250.9 5530.9 5586.4 5617.3 5739.6 5742.1 1004.3 1011.0 1020.1 1020.7 1022.1 22372.8 22386.0 22399.9 22662.7 22689.0 1106.7 1117.6 1123.1 1127.6 1134.1 12191.7 12287.0 12321.0 12346.3 12380.7 223255.0 223588.0 223775.0 225129.0 225684.0 51865.2 51873.0 51919.5 52024.7 52081.0 1399.2 1448.9 1458.4 1465.8 1468.7 22197.9 22614.9 22621.9 22905.4 23041.4 36765.3 36799.6 36825.1 36937.4 36951.8 197794.0 198826.0 199194.0 199927.0 200102.0 29983.1 31046.2 32633.8 32839.0 33044.5 41400.4 41446.0 41928.4 42433.0 42492.0 30640.8 30880.2 30984.0 31073.4 31920.5 30868.8 30874.7 31084.0 31135.7 31461.0 34015.0 34918.3 35068.0 35222.5 35241.6 30599.5 30784.8 30798.4 30881.4 30914.0 22358.3 22646.3 22715.4 22792.7 22815.9 06:34:32 INFO - PID 15159 | 06:34:32 INFO - PID 15159 | [#2] jquery.html Cycles:180 Average:34630.68 Median:23501.82 stddev:83485.57 (355.2%) stddev-sans-first:83680.58 06:34:32 INFO - PID 15159 | Values: 558.5 574.9 575.8 576.4 587.6 22012.9 23155.9 23169.0 23186.8 23241.4 23516.9 24112.2 24515.4 24696.8 25067.2 6436.6 6554.9 6610.4 6633.2 6644.2 6573.6 6641.6 6663.9 6688.8 6692.0 6328.5 6556.1 6571.4 6623.3 6633.4 6583.3 6608.7 6641.8 6647.4 6657.6 5872.6 6120.0 6123.7 6162.1 6191.9 29159.6 29767.3 29798.4 29799.9 29804.9 2062.2 2078.6 2086.6 2091.7 2096.4 17869.0 17945.6 18148.0 18283.8 18284.2 2371.2 2469.8 2473.9 2474.5 2480.9 117439.0 121473.4 128491.0 131708.0 135559.0 14622.6 14745.2 14831.5 15149.7 15314.2 23305.7 23346.5 23401.2 23430.4 23486.8 9543.1 9705.6 9749.2 9786.0 9837.2 8751.2 8786.6 8834.5 8857.1 8883.1 9057.8 9089.2 9180.3 9193.6 9195.9 2587.3 2612.5 2632.7 2694.6 2743.5 940.5 959.2 969.8 973.8 975.3 19082.8 19443.3 20083.9 20176.8 20306.0 1021.6 1021.8 1028.7 1037.4 1042.3 11033.0 11083.9 11093.6 11230.4 11351.2 487455.0 494242.0 494590.0 506100.0 514272.0 107356.5 109455.5 109929.0 109948.5 111432.0 1044.7 1127.8 1139.6 1184.2 1197.5 20677.6 20981.6 20987.4 21082.3 21192.8 51775.0 54940.2 55316.2 55907.7 57693.0 70930.0 71505.6 71626.0 71923.3 71927.6 14783.6 14926.3 14929.6 15005.8 15307.7 23021.8 23542.3 23852.3 23868.9 24152.8 18546.1 18711.9 18911.1 18916.9 19096.0 16839.5 16954.7 16970.0 17282.7 17488.1 19027.0 19160.0 19434.8 19671.9 19691.4 14796.7 14903.3 14908.9 14964.4 15003.7 18388.8 18452.3 18838.3 18852.3 18944.5 06:34:32 INFO - PID 15159 | 06:34:32 INFO - PID 15159 | [#3] mootools.html Cycles:180 Average:9456.28 Median:14719.62 stddev:6753.12 (45.9%) stddev-sans-first:6744.39 06:34:32 INFO - PID 15159 | Values: 1319.3 1410.6 1416.1 1421.6 1423.7 14442.6 15230.4 15318.9 15356.0 15394.7 15071.1 15181.2 15202.3 15203.8 15214.0 2690.1 2726.7 2760.8 2762.0 2776.1 2614.1 2677.2 2685.7 2701.4 2710.7 2570.7 2660.7 2733.4 2746.9 2747.9 2685.7 2686.8 2713.1 2713.4 2717.2 2683.6 2715.5 2716.1 2719.9 2725.4 14720.1 15053.8 15064.8 15073.0 15073.9 7469.7 7703.2 7759.7 7792.2 7801.0 5408.5 5490.2 5580.5 5686.3 5734.3 1960.7 1993.5 2014.1 2018.9 2040.9 26556.9 26621.7 26762.1 26852.6 26861.9 7287.7 7361.2 7491.1 7618.8 7684.3 17540.1 17542.2 17729.4 17756.7 17761.6 7963.4 8138.8 8151.9 8160.0 8165.2 7471.2 7491.3 7517.4 7533.1 7631.9 5256.8 5408.8 5429.2 5449.8 5470.3 1406.9 1551.7 1555.1 1565.8 1580.8 768.4 889.4 894.2 907.0 911.8 8035.5 8041.2 8070.7 8159.9 8167.2 1012.4 1018.2 1023.1 1027.7 1045.7 5361.5 5385.1 5425.3 5433.9 5464.1 21484.2 21827.3 22303.9 22510.2 22518.3 20807.7 21833.2 21861.8 22114.7 22194.9 10512.0 10709.1 11101.5 11190.9 11214.7 8772.7 8942.5 8985.7 9025.1 9038.9 18623.1 18798.7 18881.5 18917.0 19259.2 19099.8 19263.7 19595.4 19774.7 19943.3 12222.8 12291.3 12337.4 12439.1 12512.7 13758.2 13957.2 14018.7 14026.6 14065.1 11281.7 11305.5 11354.7 11438.7 11599.1 11009.4 11129.2 11208.8 11220.4 11369.8 9635.7 9702.1 9748.2 9781.7 9782.4 7054.9 7096.2 7112.3 7147.5 7214.7 6907.5 6958.7 6987.3 7104.5 7186.8 06:34:32 INFO - PID 15159 | 06:34:32 INFO - PID 15159 | [#4] prototype.html Cycles:180 Average:5475.07 Median:6132.33 stddev:1531.52 (25.0%) stddev-sans-first:1489.05 06:34:32 INFO - PID 15159 | Values: 471.4 485.7 508.0 509.5 518.9 6222.2 6294.7 6316.9 6318.5 6368.4 6145.8 6166.6 6199.4 6202.5 6266.6 5101.1 5105.5 5144.7 5167.6 5191.9 5174.2 5176.7 5193.5 5202.3 5238.4 4754.2 4944.6 5023.3 5034.8 5089.0 4949.4 4954.7 4962.7 4971.6 5008.3 4290.0 4433.4 4451.2 4461.9 4470.0 6050.5 6057.4 6085.6 6099.5 6118.8 5665.4 5673.6 5692.5 5702.8 5715.4 6492.4 6511.0 6517.5 6558.3 6579.5 4606.2 4807.3 4861.7 4902.7 4906.8 6682.8 6765.9 6889.0 6910.2 6953.9 4882.7 4911.5 4937.0 4943.3 4985.9 4973.5 5030.8 5031.7 5045.8 5053.1 5582.2 5609.3 5622.1 5684.2 5707.6 6542.7 6564.6 6590.3 6624.2 6702.3 1730.1 1732.7 1734.5 1748.0 1759.3 1122.8 1169.6 1189.5 1189.8 1203.1 5635.4 5705.5 5718.4 5745.5 5750.5 6445.6 6468.4 6602.7 6674.2 6695.3 5680.7 5685.8 5712.3 5731.9 5774.0 3524.2 3539.4 3547.9 3548.9 3555.9 6251.7 6338.3 6393.9 6436.3 6484.4 6707.7 6808.3 6838.9 6845.3 6896.1 6351.9 6372.3 6426.9 6439.4 6495.9 6500.9 6558.2 6597.8 6652.9 6666.6 5977.9 6425.0 6457.7 6531.8 6617.5 6256.9 6261.6 6329.7 6368.2 6392.9 4847.5 4867.9 4907.6 4909.0 4947.9 6396.6 6562.6 6566.8 6735.4 6764.6 6363.7 6401.2 6432.8 6434.2 6506.2 6398.2 6459.9 6502.4 6536.7 6536.7 6375.8 6462.5 6466.6 6476.3 6511.7 6488.7 6511.5 6546.3 6548.6 6669.5 6380.8 6391.0 6398.8 6403.8 6476.6 06:34:32 INFO - PID 15159 | 06:34:32 INFO - PID 15159 | [#5] yui.html Cycles:180 Average:24198.91 Median:20417.04 stddev:35019.89 (171.5%) stddev-sans-first:35074.45 06:34:32 INFO - PID 15159 | Values: 904.9 913.8 943.6 943.6 945.5 19353.0 20140.9 20163.4 20244.0 20358.7 18124.9 18363.7 18702.1 18864.2 18931.1 965.4 965.9 970.3 970.7 977.4 991.0 997.8 999.6 1000.4 1002.6 1001.1 1006.5 1007.8 1027.4 1057.7 994.6 999.4 1002.5 1006.7 1051.3 710.2 721.9 735.3 750.9 756.0 20220.5 20475.4 20552.0 20586.7 20645.4 21209.5 21431.5 22298.3 22354.6 22354.7 14561.6 15441.7 15513.1 15620.3 15630.5 3704.2 3730.9 3764.8 3769.1 3771.3 138473.0 138605.3 141568.0 142750.0 142763.0 16861.3 17212.8 17260.7 17509.8 17612.0 31890.4 32320.5 32480.7 32649.3 32895.2 9085.1 9200.8 9204.8 9206.4 9210.3 4228.6 4244.7 4309.8 4322.6 4355.4 5601.7 5655.0 5660.9 5684.8 5698.4 923.2 934.6 956.4 957.0 960.4 653.6 680.6 682.7 692.5 694.3 11406.5 11761.8 11901.8 12009.2 12378.0 686.2 691.7 693.7 705.5 715.9 5328.9 5343.4 5398.2 5400.5 5456.2 114858.0 121821.4 122862.4 122868.4 125508.0 104735.0 107883.5 110552.0 110653.0 112689.0 85832.1 87888.6 88194.6 88738.6 90423.5 10064.2 10117.7 10118.1 10192.0 10220.0 43414.0 43990.0 44290.8 45666.1 46021.0 57387.1 58007.1 58063.7 58143.4 58800.7 15765.6 15822.7 16166.5 16269.7 16285.9 16484.6 16603.8 16752.0 16856.7 17111.0 16083.5 16119.6 16192.4 16246.5 16639.5 15919.8 16069.8 16118.0 16190.9 16398.6 15480.3 15587.9 15656.5 15740.4 15843.5 10787.6 10835.4 11147.4 11183.9 11274.7 11736.8 12109.8 12113.0 12156.0 12312.2 06:34:32 INFO - PID 15159 | -------- Summary: end -------- 06:34:32 INFO - PID 15159 | 06:34:33 INFO - TEST-INFO | 15159: exit 0 06:34:33 INFO - TEST-OK | dromaeo_css | took 1113127ms 06:34:33 INFO - TEST-START | kraken 06:34:33 INFO - Initialising browser for kraken test... 06:34:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53124/getInfo.html -profile /tmp/tmp23qnOE/profile 06:34:33 INFO - TEST-INFO | started process 15554 (/builds/slave/test/build/application/firefox/firefox http://localhost:53124/getInfo.html) 06:34:39 INFO - TEST-INFO | 15554: exit 0 06:34:39 INFO - Browser initialized. 06:34:39 INFO - Running cycle 1/1 for kraken test... 06:34:39 INFO - Using env: {'DISPLAY': ':0', 06:34:39 INFO - 'HOME': '/home/cltbld', 06:34:39 INFO - 'JSGC_DISABLE_POISONING': '1', 06:34:39 INFO - 'LANG': 'en_US.UTF-8', 06:34:39 INFO - 'LANGUAGE': 'en_US:en', 06:34:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:34:39 INFO - 'LOGNAME': 'cltbld', 06:34:39 INFO - 'MAIL': '/var/mail/cltbld', 06:34:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:34:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:34:39 INFO - 'MOZ_ACCELERATED': '1', 06:34:39 INFO - 'MOZ_CRASHREPORTER': '1', 06:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:34:39 INFO - 'MOZ_NO_REMOTE': '1', 06:34:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:34:39 INFO - 'MOZ_WEBRENDER': '1', 06:34:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:39 INFO - 'NO_EM_RESTART': '1', 06:34:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:39 INFO - 'PWD': '/builds/slave/test', 06:34:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:34:39 INFO - 'RUST_BACKTRACE': 'full', 06:34:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:34:39 INFO - 'SHELL': '/bin/bash', 06:34:39 INFO - 'SHLVL': '1', 06:34:39 INFO - 'TERM': 'linux', 06:34:39 INFO - 'TMOUT': '86400', 06:34:39 INFO - 'USER': 'cltbld', 06:34:39 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460', 06:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:39 INFO - '_': '/tools/buildbot/bin/python'} 06:34:39 INFO - TEST-INFO | started process 15798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp23qnOE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:40 INFO - PID 15798 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:34:40 INFO - PID 15798 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:34:41 INFO - PID 15798 | 06:34:41 INFO - PID 15798 | (/builds/slave/test/build/application/firefox/firefox:15858): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:34:41 INFO - PID 15798 | 06:34:51 INFO - PID 15798 | RSS: Main: 181723136 06:34:51 INFO - PID 15798 | 06:34:54 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53124/tests/kraken/driver.html?testName=audio-beat-detection) 06:34:55 INFO - PID 15798 | RSS: Main: 181858304 06:34:55 INFO - PID 15798 | 06:34:57 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53124/tests/kraken/driver.html?testName=audio-dft) 06:34:58 INFO - PID 15798 | RSS: Main: 182947840 06:34:58 INFO - PID 15798 | 06:35:01 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53124/tests/kraken/driver.html?testName=audio-fft) 06:35:02 INFO - PID 15798 | RSS: Main: 180645888 06:35:02 INFO - PID 15798 | 06:35:04 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53124/tests/kraken/driver.html?testName=audio-oscillator) 06:35:04 INFO - PID 15798 | RSS: Main: 180985856 06:35:04 INFO - PID 15798 | 06:35:06 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53124/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:35:07 INFO - PID 15798 | RSS: Main: 180609024 06:35:07 INFO - PID 15798 | 06:35:10 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53124/tests/kraken/driver.html?testName=imaging-darkroom) 06:35:11 INFO - PID 15798 | RSS: Main: 183205888 06:35:11 INFO - PID 15798 | 06:35:15 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53124/tests/kraken/driver.html?testName=imaging-desaturate) 06:35:15 INFO - PID 15798 | RSS: Main: 182915072 06:35:15 INFO - PID 15798 | 06:35:18 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53124/tests/kraken/driver.html?testName=json-parse-financial) 06:35:19 INFO - PID 15798 | RSS: Main: 183894016 06:35:19 INFO - PID 15798 | 06:35:21 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53124/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:35:21 INFO - PID 15798 | RSS: Main: 184926208 06:35:21 INFO - PID 15798 | 06:35:23 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:35:24 INFO - PID 15798 | RSS: Main: 184467456 06:35:24 INFO - PID 15798 | 06:35:26 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:35:26 INFO - PID 15798 | RSS: Main: 184360960 06:35:26 INFO - PID 15798 | 06:35:29 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:35:30 INFO - PID 15798 | RSS: Main: 184627200 06:35:30 INFO - PID 15798 | 06:35:33 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:35:33 INFO - PID 15798 | RSS: Main: 184393728 06:35:33 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53124/tests/kraken/driver.html?testName=ai-astar) 06:35:35 INFO - PID 15798 | RSS: Main: 186126336 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | __start_tp_report 06:35:35 INFO - PID 15798 | _x_x_mozilla_page_load 06:35:35 INFO - PID 15798 | _x_x_mozilla_page_load_details 06:35:35 INFO - PID 15798 | |i|pagename|runs| 06:35:35 INFO - PID 15798 | |0;ai-astar;116;118;110;108;117;115;107;109;114;111 06:35:35 INFO - PID 15798 | |1;audio-beat-detection;116;119;120;123;146;113;121;120;120;128 06:35:35 INFO - PID 15798 | |2;audio-dft;164;163;171;164;167;181;169;170;166;171 06:35:35 INFO - PID 15798 | |3;audio-fft;79;81;93;75;83;79;78;92;75;77 06:35:35 INFO - PID 15798 | |4;audio-oscillator;88;81;82;78;85;87;80;87;84;79 06:35:35 INFO - PID 15798 | |5;imaging-gaussian-blur;114;120;113;116;113;116;119;115;125;114 06:35:35 INFO - PID 15798 | |6;imaging-darkroom;155;150;151;148;148;149;150;150;148;147 06:35:35 INFO - PID 15798 | |7;imaging-desaturate;98;95;99;94;95;94;95;95;95;96 06:35:35 INFO - PID 15798 | |8;json-parse-financial;54;55;58;62;57;57;63;53;54;54 06:35:35 INFO - PID 15798 | |9;json-stringify-tinderbox;38;40;40;42;47;41;48;45;38;38 06:35:35 INFO - PID 15798 | |10;stanford-crypto-aes;75;76;85;85;74;84;77;75;75;82 06:35:35 INFO - PID 15798 | |11;stanford-crypto-ccm;109;112;110;124;118;118;117;114;128;120 06:35:35 INFO - PID 15798 | |12;stanford-crypto-pbkdf2;182;171;175;174;175;168;169;169;169;167 06:35:35 INFO - PID 15798 | |13;stanford-crypto-sha256-iterative;65;65;67;69;65;66;67;65;66;71 06:35:35 INFO - PID 15798 | __end_tp_report 06:35:35 INFO - PID 15798 | __start_cc_report 06:35:35 INFO - PID 15798 | _x_x_mozilla_cycle_collect,715 06:35:35 INFO - PID 15798 | __end_cc_report 06:35:35 INFO - PID 15798 | __startTimestamp1505914535747__endTimestamp 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | ------- Summary: start ------- 06:35:35 INFO - PID 15798 | Number of tests: 14 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.50 stddev:3.98 (3.5%) stddev-sans-first:4.01 06:35:35 INFO - PID 15798 | Values: 116.0 118.0 110.0 108.0 117.0 115.0 107.0 109.0 114.0 111.0 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#1] audio-beat-detection Cycles:10 Average:122.60 Median:120.50 stddev:9.12 (7.6%) stddev-sans-first:9.35 06:35:35 INFO - PID 15798 | Values: 116.0 119.0 120.0 123.0 146.0 113.0 121.0 120.0 120.0 128.0 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#2] audio-dft Cycles:10 Average:168.60 Median:169.50 stddev:5.27 (3.1%) stddev-sans-first:5.33 06:35:35 INFO - PID 15798 | Values: 164.0 163.0 171.0 164.0 167.0 181.0 169.0 170.0 166.0 171.0 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#3] audio-fft Cycles:10 Average:81.20 Median:80.00 stddev:6.44 (8.1%) stddev-sans-first:6.78 06:35:35 INFO - PID 15798 | Values: 79.0 81.0 93.0 75.0 83.0 79.0 78.0 92.0 75.0 77.0 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#4] audio-oscillator Cycles:10 Average:83.10 Median:84.50 stddev:3.60 (4.3%) stddev-sans-first:3.36 06:35:35 INFO - PID 15798 | Values: 88.0 81.0 82.0 78.0 85.0 87.0 80.0 87.0 84.0 79.0 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.00 stddev:3.81 (3.3%) stddev-sans-first:3.93 06:35:35 INFO - PID 15798 | Values: 114.0 120.0 113.0 116.0 113.0 116.0 119.0 115.0 125.0 114.0 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:2.27 (1.5%) stddev-sans-first:1.32 06:35:35 INFO - PID 15798 | Values: 155.0 150.0 151.0 148.0 148.0 149.0 150.0 150.0 148.0 147.0 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.65 (1.7%) stddev-sans-first:1.50 06:35:35 INFO - PID 15798 | Values: 98.0 95.0 99.0 94.0 95.0 94.0 95.0 95.0 95.0 96.0 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:3.47 (6.1%) stddev-sans-first:3.54 06:35:35 INFO - PID 15798 | Values: 54.0 55.0 58.0 62.0 57.0 57.0 63.0 53.0 54.0 54.0 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#9] json-stringify-tinderbox Cycles:10 Average:41.70 Median:41.50 stddev:3.74 (9.0%) stddev-sans-first:3.72 06:35:35 INFO - PID 15798 | Values: 38.0 40.0 40.0 42.0 47.0 41.0 48.0 45.0 38.0 38.0 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:79.50 stddev:4.61 (5.8%) stddev-sans-first:4.68 06:35:35 INFO - PID 15798 | Values: 75.0 76.0 85.0 85.0 74.0 84.0 77.0 75.0 75.0 82.0 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:118.00 stddev:6.04 (5.1%) stddev-sans-first:5.67 06:35:35 INFO - PID 15798 | Values: 109.0 112.0 110.0 124.0 118.0 118.0 117.0 114.0 128.0 120.0 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:172.50 stddev:4.61 (2.7%) stddev-sans-first:3.11 06:35:35 INFO - PID 15798 | Values: 182.0 171.0 175.0 174.0 175.0 168.0 169.0 169.0 169.0 167.0 06:35:35 INFO - PID 15798 | 06:35:35 INFO - PID 15798 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:2.01 (3.0%) stddev-sans-first:2.05 06:35:35 INFO - PID 15798 | Values: 65.0 65.0 67.0 69.0 65.0 66.0 67.0 65.0 66.0 71.0 06:35:35 INFO - PID 15798 | -------- Summary: end -------- 06:35:35 INFO - PID 15798 | 06:35:36 INFO - PID 15798 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:35:36 INFO - TEST-INFO | 15798: exit 0 06:35:36 INFO - TEST-OK | kraken | took 63331ms 06:35:36 INFO - SUITE-END | took 1176s 06:35:36 INFO - Completed test suite (00:19:36) 06:35:36 INFO - javascript benchmark 06:35:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8491.423278906386, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.268851819822, 3120.141960960734, 3144.8270345131023, 3146.6695996920307, 3170.2549900773315, 6169.19800425944, 6323.146375239353, 6364.077208804721, 6408.967955160224, 6485.481161507074, 6224.470919971808, 6238.59449135807, 6256.405641464065, 6298.6535740534255, 6305.117283580291, 5760.452756988079, 5863.882722345551, 5927.792527261547, 5928.881422371572, 5933.614315069528, 1275.5580990813896, 5878.529717622601, 5954.761809527614, 5981.312149102865, 5992.2809262888295, 5375.919361209585, 5667.801626943058, 5689.345725241588, 5898.115282707586, 5906.527477801766, 5820.912686309666, 5831.562632802556, 5861.6483011019045, 5915.497182739472, 5923.289205295349, 5742.052561327418, 5747.798827041033, 5806.59353845231, 5819.563532735062, 5829.47534721877, 6283.403076707706, 6343.777967771152, 6356.650384228866, 6396.904046439261, 6410.2628197757385, 6766.052752614638, 6836.213835408942, 6861.897071543881, 6864.519483636147, 6880.518363714542, 6607.174103237096, 6644.534882558174, 6813.557118787263, 6899.551529150589, 6903.896441553381, 6248.937510624881, 6308.526860485436, 6408.551401401857, 6421.999999999954, 6423.0, 6989.755358562527, 7005.879059350479, 7066.505344625827, 7093.184283807428, 7130.92869071313, 6578.605283682994, 6654.73381064752, 6688.264290927994, 6720.697568609425, 6726.630035348005, 6613.702383392759, 6699.095622091053, 6712.42944349726, 6716.194056713226, 6733.730650773914, 6614.536982411185, 6622.072909792633, 6637.568558043712, 6656.900146497806, 6669.633170175687, 6555.934440655627, 6669.63317017559, 6683.43190828785, 6773.390394864486, 6894.172699276119, 5330.546903513167, 5350.0904846176245, 5368.812091576854, 5371.274877891513, 5376.946230537723, 4565.954340456619, 4630.467496237909, 4671.182543054952, 4672.0, 4689.390379250675, 5731.627444216113, 5783.971080144573, 5851.32709738377, 5883.0, 5893.233879595625, 6692.86614267712, 6772.8984065239065, 6792.388685018372, 6833.487488438387, 6881.449484041264, 5868.67722275279, 5902.144189092557, 5915.290165180206, 5933.465988061009, 5945.40545945402, 5861.970690146607, 5875.471207591338, 5930.080837470199, 5949.286085669747, 5953.791617293374, 6257.186565746515, 6350.015747559136, 6422.8715425691225, 6536.150300460909, 6624.006399040086, 6665.400113989765, 6710.563813352116, 6716.29478904708, 6723.630200339028, 6742.797716068526, 6361.300256971637, 6470.902936456051, 6487.026945958144, 6496.317886622026, 6503.2846386898345, 6351.96824015877, 6579.276279609144, 6596.8350791230605, 6606.10817539626, 6650.235222949423, 5805.303363596396, 6865.862682746417, 6873.140857392826, 6906.827329316808, 6946.0622815919205, 6501.707423166064, 6542.247641521096, 6671.332866713484, 6671.499637527302, 6703.229128650072, 6408.58344207625, 6483.610983341015, 6579.769708060195, 6587.077809106633, 6683.064370987969, 6429.32492088324, 6460.0, 6476.546641735222, 6486.772962946275, 6496.70764815575, 6580.618070205119, 6584.176977877765, 6599.472042236705, 6624.56940298879, 6746.291639377795, 6464.612123272619, 6496.090547323284, 6497.4477169441125, 6551.672416379257, 6558.344165583403], "value": 6128.703909540635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.3870821071146, 890.4123278636098, 891.9108089191086, 897.6544030548237, 899.9685011024616, 37286.81356593216, 41743.0, 41840.163196736125, 41844.79077604615, 41883.162336753245, 37402.438963415574, 37437.0, 37674.24651506968, 37745.62254377455, 37919.431208531896, 7114.075170227876, 7182.102237220348, 7184.928150718504, 7239.493235473519, 7242.239564845694, 7760.844783104335, 7876.842463150762, 7884.211578842127, 7899.88150177745, 7954.00574928134, 7903.960480197591, 7913.208679132098, 7960.681572737083, 7968.760937171865, 7977.122516523178, 7843.921560784376, 7903.762887113396, 7915.920840791576, 8125.512469251805, 8125.512469251864, 7831.569263690495, 7909.090454597737, 7921.801954951115, 7930.841383172305, 7952.562609056499, 36985.075373115884, 37038.44442333367, 37066.0, 37088.0, 37259.4411083834, 3559.75081744278, 3576.624454432299, 3579.821008949542, 3589.74871758977, 3596.1009747563107, 30658.69341306581, 30746.23134421635, 30830.69169308323, 31040.8447957761, 31092.844535777404, 5239.397469291042, 5248.186531087687, 5294.232336311252, 5311.654742441729, 5330.9733451332495, 190837.04581477144, 190841.0, 191879.0, 192581.0, 192772.0, 41399.58600413957, 42567.361489577685, 47960.28059579109, 47968.0, 48180.0, 50000.0, 50846.49153508492, 50866.0, 51060.744696276284, 51286.743566281926, 14945.17801520905, 15008.474703385547, 15130.697386052218, 15160.696786064216, 15181.772273415907, 12089.57686480969, 12157.148999569945, 12168.81746773799, 12177.817332740016, 12203.45084471201, 13840.23878686682, 13968.161910285415, 14076.648083797987, 14106.294685265695, 14250.85749142516, 5530.86172845674, 5586.413426590231, 5617.32592088952, 5739.62692424991, 5742.109972954116, 1004.3421558878946, 1010.9848352274722, 1020.1125021231428, 1020.6733845169474, 1022.1260821997234, 22372.776272237068, 22386.0, 22399.88800056022, 22662.66006009911, 22689.0, 1106.690126764507, 1117.5585643670704, 1123.084685980923, 1127.5715228213226, 1134.0983917785381, 12191.695207619881, 12287.0, 12321.0, 12346.259224446561, 12380.690482738004, 223255.0, 223588.0, 223775.0, 225129.0, 225684.0, 51865.2220216697, 51873.0, 51919.48080519222, 52024.73987630037, 52081.0, 1399.216438794258, 1448.9492867749789, 1458.3874772595536, 1465.7874608181753, 1468.7356275870445, 22197.88901055549, 22614.886925565268, 22621.88689056544, 22905.427364316027, 23041.423964401023, 36765.26469470649, 36799.63200367962, 36825.07937301589, 36937.44593831148, 36951.8152409247, 197794.0, 198826.0, 199194.0, 199927.0, 200102.0, 29983.05110167832, 31046.22384440407, 32633.836830815693, 32839.0, 33044.504332435514, 41400.37899431451, 41446.0, 41928.371074434515, 42433.0, 42492.0, 30640.84679576677, 30880.227994300323, 30984.0, 31073.378532429677, 31920.52119218167, 30868.845655771576, 30874.69125308718, 31084.0, 31135.68864311328, 31461.0, 34015.0, 34918.30163396768, 35068.0, 35222.47166292457, 35241.64758352384, 30599.54100688447, 30784.846075769477, 30798.384032319675, 30881.382372351978, 30914.0, 22358.329250122522, 22646.320610381714, 22715.432114197276, 22792.658110128028, 22815.88592057029], "value": 16878.72695729946, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.4555058817654, 574.8562859285179, 575.847400438884, 576.4293349583908, 587.6209844650201, 22012.88993555032, 23155.884220578915, 23169.0, 23186.768132318673, 23241.418964525918, 23516.88241558794, 24112.156074537394, 24515.387115322126, 24696.75303246967, 25067.24798256055, 6436.581622194554, 6554.901676474857, 6610.3720146586, 6633.170853643294, 6644.202695676526, 6573.605583664971, 6641.568298060611, 6663.933360666404, 6688.799336019927, 6691.966540167292, 6328.462080723121, 6556.14770079889, 6571.3757193066585, 6623.271440141581, 6633.402993730563, 6583.275839657634, 6608.735650573995, 6641.800745977628, 6647.368499992517, 6657.567258128206, 5872.588918775645, 6119.969400152971, 6123.6938153092615, 6162.106494558308, 6191.907121393183, 29159.562606560918, 29767.25581860449, 29798.404031919457, 29799.851000744857, 29804.850975744983, 2062.2060506704875, 2078.594674038563, 2086.634838903201, 2091.6757902524982, 2096.3815674376096, 17869.0, 17945.641087178185, 18148.0, 18283.817161828476, 18284.17721202536, 2371.205646108556, 2469.753024697534, 2473.9257822265363, 2474.5298393305393, 2480.8635525046116, 117439.0, 121473.39263303627, 128491.0, 131708.0, 135559.0, 14622.568751648274, 14745.189014604086, 14831.546018769199, 15149.683549046265, 15314.157721325435, 23305.650415243785, 23346.53306933852, 23401.180958666366, 23430.414239644146, 23486.7651323488, 9543.139087877937, 9705.563249653782, 9749.220062394992, 9785.951070244746, 9837.163841073445, 8751.168638979287, 8786.60460279289, 8834.469931804113, 8857.11428857109, 8883.111688831064, 9057.780843693337, 9089.22741566961, 9180.265578753684, 9193.598368603525, 9195.90804091964, 2587.275562842407, 2612.529744645982, 2632.7235640257495, 2694.5553983592486, 2743.5157350165177, 940.5297351324338, 959.194276807485, 969.8205831920976, 973.8149751547184, 975.331897650112, 19082.809171908382, 19443.319483818283, 20083.899580502297, 20176.798232017492, 20306.0, 1021.6219998600566, 1021.7905329407454, 1028.7222449938474, 1037.4397825174321, 1042.3276986343917, 11033.0, 11083.889161108447, 11093.611723589636, 11230.382328971822, 11351.205415620827, 487455.0, 494242.0, 494590.0, 506100.0, 514272.0, 107356.46321768341, 109455.45272273588, 109929.0, 109948.4502577498, 111432.0, 1044.6552637629563, 1127.7913585986619, 1139.5783560082823, 1184.1651635596884, 1197.5150064224176, 20677.58644827125, 20981.580368392242, 20987.370378888656, 21082.262120825697, 21192.83439410847, 51775.0, 54940.17589736237, 55316.170257446975, 55907.72046139743, 57693.0, 70930.0, 71505.6424717873, 71626.0, 71923.28076719165, 71927.64036179785, 14783.630409239855, 14926.328315226057, 14929.552113436614, 15005.849941500883, 15307.693846123238, 23021.769782301963, 23542.293731188092, 23852.284431467084, 23868.88065559661, 24152.75847241505, 18546.072696365398, 18711.906440467712, 18911.148998295386, 18916.905415472833, 19096.0, 16839.494815155565, 16954.660906782043, 16970.0, 17282.65434691324, 17488.125593720008, 19027.0, 19160.0, 19434.8056519433, 19671.901640491706, 19691.40925772229, 14796.704065918837, 14903.254837258311, 14908.850911490747, 14964.40142394292, 15003.724683401597, 18388.816111839245, 18452.261909524004, 18838.3406580769, 18852.34016809405, 18944.52638684044], "value": 11978.392843247328, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.2612137203166, 1410.5909286306971, 1416.1290806154211, 1421.6374824419784, 1423.7294913966346, 14442.638934026641, 15230.39078436864, 15318.923405382986, 15356.0, 15394.692106157898, 15071.095734255925, 15181.240937953113, 15202.315895784688, 15203.847961520381, 15214.0, 2690.0853709738685, 2726.6864310604237, 2760.834349939, 2761.972380276202, 2776.1255204610484, 2614.0720044384257, 2677.170077276041, 2685.704572497024, 2701.3651791828906, 2710.6747190337187, 2570.7043689975703, 2660.6940201876837, 2733.3576609496754, 2746.931326716828, 2747.8900843966317, 2685.6642919635046, 2686.7984901132395, 2713.091114476653, 2713.430179662273, 2717.1576811188397, 2683.6242925990377, 2715.5383584790634, 2716.0765339784566, 2719.945601087967, 2725.4004119093966, 14720.116792992347, 15053.774193387108, 15064.849351506455, 15073.0, 15073.924630376887, 7469.663865126083, 7703.1526532081425, 7759.65081571325, 7792.220777922219, 7801.0, 5408.513233808976, 5490.1883559957605, 5580.497755202051, 5686.289213848269, 5734.254546908917, 1960.6666866632706, 1993.5016245938516, 2014.0634604908787, 2018.8788672679539, 2040.897955102239, 26556.86721566399, 26621.73378266212, 26762.063327783435, 26852.597211041655, 26861.925522979058, 7287.744928927462, 7361.190269070398, 7491.138519070268, 7618.809529761689, 7684.269994350528, 17540.122993850255, 17542.21060052301, 17729.379471718687, 17756.733648995276, 17761.644767104586, 7963.442559020813, 8138.796530086795, 8151.918480815235, 8159.95920020408, 8165.183481651906, 7471.215522370181, 7491.325780679765, 7517.361024312885, 7533.096028476618, 7631.923680763232, 5256.763445644955, 5408.783648654088, 5429.239906413105, 5449.754761035763, 5470.343558772973, 1406.8874490040773, 1551.697419003306, 1555.1213564336115, 1565.827758946515, 1580.8103027636757, 768.4352001279055, 889.4352086425166, 894.181823631383, 907.0340087806596, 911.8465141595887, 8035.517868927883, 8041.195880412029, 8070.717524886718, 8159.857619933214, 8167.241120935136, 1012.3875055591409, 1018.2363227579316, 1023.0637175627627, 1027.6814187601867, 1045.7019749371545, 5361.544268737123, 5385.111456609694, 5425.330529596581, 5433.864153396196, 5464.12573988168, 21484.24805131813, 21827.345179644635, 22303.888480557816, 22510.21214257526, 22518.32445026652, 20807.68788468174, 21833.235836745636, 21861.781382185975, 22114.668279975813, 22194.88902555509, 10512.0, 10709.143268538499, 11101.500432480558, 11190.944045279884, 11214.719632009102, 8772.736817895473, 8942.50816205115, 8985.730428087169, 9025.097490250922, 9038.864417033617, 18623.06884655789, 18798.718019229447, 18881.527961801065, 18917.0, 19259.22963081461, 19099.8090019098, 19263.74785638929, 19595.412137635893, 19774.70337944961, 19943.301984430476, 12222.75554488923, 12291.32397718134, 12337.444814983526, 12439.067069969607, 12512.74974500523, 13758.243296618783, 13957.162570245819, 14018.719625607635, 14026.579202623938, 14065.085769424955, 11281.71795705114, 11305.547778088785, 11354.716132096764, 11438.714032149262, 11599.072074233873, 11009.449527523751, 11129.16531260175, 11208.775824483628, 11220.438978051228, 11369.772604548029, 9635.662751803653, 9702.078302561245, 9748.171405430334, 9781.706548803548, 9782.41305521671, 7054.894176587458, 7096.183938847099, 7112.253213412517, 7147.463940204401, 7214.675339609835, 6907.481938854707, 6958.652067396712, 6987.301269872972, 7104.502684812221, 7186.820329491805], "value": 6769.299299784939, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.3683663890386, 485.7037207303544, 508.03726937453513, 509.4803300633352, 518.8573142385843, 6222.160008398865, 6294.748210071597, 6316.936830631692, 6318.494520438366, 6368.363163683629, 6145.846353841156, 6166.6300021998595, 6199.44205021548, 6202.472789812871, 6266.62400255985, 5101.132807422729, 5105.489451054883, 5144.717040562768, 5167.586593072545, 5191.896162076756, 5174.2238664200295, 5176.741162941857, 5193.45468725784, 5202.271681964528, 5238.371395432553, 4754.215554433515, 4944.629152813535, 5023.321851550048, 5034.848954531351, 5088.974555127219, 4949.3813273340475, 4954.7027178369235, 4962.6774259673, 4971.577415919651, 5008.323876276692, 4289.978550107261, 4433.379326894205, 4451.198784218839, 4461.910761784746, 4469.977650111761, 6050.515958723336, 6057.363976782419, 6085.574009819315, 6099.48154406876, 6118.816435506942, 5665.405132461074, 5673.574481913873, 5692.5161361284345, 5702.800401985952, 5715.3998830122655, 6492.415682588542, 6510.967445162792, 6517.543771935966, 6558.311377305362, 6579.473642108667, 4606.170889239936, 4807.326974223612, 4861.659683822134, 4902.681325713817, 4906.803727850882, 6682.820813869242, 6765.93234067658, 6888.96665500179, 6910.239873613999, 6953.860922781516, 4882.7314497702255, 4911.45973942866, 4936.950630493649, 4943.2585112233455, 4985.875353116201, 4973.477784832613, 5030.798768049311, 5031.6729412588065, 5045.823396181116, 5053.140966035783, 5582.218489411485, 5609.298837645294, 5622.088489913449, 5684.204211410406, 5707.6290041147195, 6542.738290468423, 6564.606123632598, 6590.340965903467, 6624.205095388585, 6702.296258892844, 1730.1003478191521, 1732.6794543009585, 1734.540346808097, 1748.0, 1759.322660775585, 1122.7810576937582, 1169.5555988354376, 1189.4647408666135, 1189.7858385490522, 1203.1157099531838, 5635.380108188096, 5705.4579814917515, 5718.370979192286, 5745.454181852718, 5750.453706897838, 6445.6169804533365, 6468.353164683588, 6602.73589056442, 6674.199096108498, 6695.296993815677, 5680.715964201773, 5685.77256909719, 5712.285964254468, 5731.885362292731, 5774.0, 3524.22467057247, 3539.415996360623, 3547.94678079829, 3548.8643634037376, 3555.928881422357, 6251.687415629201, 6338.334474880164, 6393.8721225576155, 6436.324185960407, 6484.448821850196, 6707.6981535831, 6808.319168083152, 6838.897416538756, 6845.349691779273, 6896.069030680894, 6351.855831363505, 6372.330905254974, 6426.8714625707225, 6439.356064393617, 6495.902561461582, 6500.8547179429725, 6558.1802274715665, 6597.80206593803, 6652.900206497004, 6666.600003999775, 5977.850553736192, 6425.036244563166, 6457.740740555547, 6531.791618550584, 6617.544140289128, 6256.937430625818, 6261.592996455216, 6329.746810127727, 6368.203974503187, 6392.9041064385, 4847.5394837490385, 4867.926981095357, 4907.55831975124, 4908.993656300521, 4947.876303092451, 6396.552241343062, 6562.639054852029, 6566.80299591013, 6735.360140786617, 6764.627945463047, 6363.681815909279, 6401.207661854688, 6432.839179020375, 6434.227892652912, 6506.219253689398, 6398.232212134573, 6459.935400646122, 6502.382273683992, 6536.673166341759, 6536.738530458919, 6375.808725738235, 6462.5153113515735, 6466.644334561644, 6476.319986401549, 6511.73953041873, 6488.740450381932, 6511.479081673549, 6546.312637173029, 6548.639824809681, 6669.533132680665, 6380.776672816429, 6391.0, 6398.776042838478, 6403.807885763435, 6476.6114033158165], "value": 5018.558753582985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.895936967249, 913.7669894176984, 943.5706753427191, 943.6414162618204, 945.5461378538297, 19353.0, 20140.89929550352, 20163.39509814704, 20244.0, 20358.694619580718, 18124.90937545314, 18363.72454413185, 18702.064896755175, 18864.245430182775, 18931.148098335572, 965.4352203960691, 965.8647789309503, 970.2771435280725, 970.6748239339829, 977.4135518688765, 990.9752256193581, 997.7505623594102, 999.6201443451479, 1000.3747657713928, 1002.6139936124608, 1001.1190152665644, 1006.5369929832286, 1007.7581380468671, 1027.398971601614, 1057.7144171073805, 994.5623925472769, 999.3803841618243, 1002.5288114586169, 1006.6929586476195, 1051.2588625019382, 710.1691021504852, 721.8917162425626, 735.3492159438881, 750.8648443280207, 755.958422286774, 20220.49448763778, 20475.38573842787, 20552.0, 20586.691199632016, 20645.380638580868, 21209.469763256042, 21431.46421339479, 22298.331050068526, 22354.552908941892, 22354.66468002981, 14561.563153105424, 15441.691166176613, 15513.146776927264, 15620.297086631128, 15630.45293414725, 3704.203596226824, 3730.8880733578035, 3764.7929363884973, 3769.0577355661085, 3771.283456143324, 138473.0, 138605.3069734645, 141568.0, 142750.0, 142762.99999999895, 16861.325546978227, 17212.827871721373, 17260.74108888368, 17509.824901751075, 17612.0, 31890.362192756016, 32320.515192272134, 32480.675193248237, 32649.347013059607, 32895.177620559676, 9085.091490850995, 9200.769980750534, 9204.815903682023, 9206.355555111211, 9210.263178945668, 4228.5982831630945, 4244.72409293395, 4309.827606895752, 4322.6325762309925, 4355.4337936068105, 5601.719914004365, 5654.97172514143, 5660.85847853807, 5684.8010319638615, 5698.373178950312, 923.2291036984059, 934.5887809363858, 956.3974695941512, 956.9856452153223, 960.4237457525569, 653.6208998780696, 680.6426626021379, 682.7200847652439, 692.4529621598881, 694.2883544366963, 11406.48670809799, 11761.823572646417, 11901.761964760657, 12009.159358844972, 12378.0, 686.2348481443155, 691.7336825322186, 693.7433149734529, 705.4708968273794, 715.9427245820322, 5328.946710532922, 5343.412224655285, 5398.217258497496, 5400.459954004568, 5456.236126942231, 114858.0, 121821.39089304497, 122862.38568807277, 122868.38565807114, 125508.0, 104735.0, 107883.46058269659, 110552.0, 110653.0, 112689.0, 85832.14167858366, 87888.5605571968, 88194.55902720445, 88738.55630721805, 90423.54788226017, 10064.194864410683, 10117.747056323651, 10118.08937195656, 10191.993361958388, 10220.0, 43414.0, 43990.0, 44290.77854610706, 45666.08667826691, 46021.0, 57387.139192912975, 58007.12989305248, 58063.70968145132, 58143.4185658138, 58800.70599646975, 15765.605859853595, 15822.68354632924, 16166.515004549883, 16269.67460650804, 16285.918570407071, 16484.587885302964, 16603.833961660228, 16751.994880307222, 16856.747148793023, 17111.0, 16083.517494475185, 16119.597010074842, 16192.352305907632, 16246.512604621881, 16639.50081497557, 15919.8408015923, 16069.758953615472, 16118.0, 16190.919045404698, 16398.590035249214, 15480.303386347416, 15587.895634089706, 15656.4520241791, 15740.370385184464, 15843.524694259191, 10787.6224332148, 10835.404052777172, 11147.442627868411, 11183.888161118284, 11274.718132046437, 11736.823947640964, 12109.81835272454, 12113.0, 12156.0, 12312.199707019015], "value": 8904.87635435231, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1462.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 110.0, 108.0, 117.0, 115.0, 107.0, 109.0, 114.0, 111.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 119.0, 120.0, 123.0, 146.0, 113.0, 121.0, 120.0, 120.0, 128.0], "value": 122.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 171.0, 164.0, 167.0, 181.0, 169.0, 170.0, 166.0, 171.0], "value": 168.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 93.0, 75.0, 83.0, 79.0, 78.0, 92.0, 75.0, 77.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 82.0, 78.0, 85.0, 87.0, 80.0, 87.0, 84.0, 79.0], "value": 83.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 120.0, 113.0, 116.0, 113.0, 116.0, 119.0, 115.0, 125.0, 114.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 150.0, 151.0, 148.0, 148.0, 149.0, 150.0, 150.0, 148.0, 147.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 99.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 58.0, 62.0, 57.0, 57.0, 63.0, 53.0, 54.0, 54.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 40.0, 40.0, 42.0, 47.0, 41.0, 48.0, 45.0, 38.0, 38.0], "value": 41.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 85.0, 85.0, 74.0, 84.0, 77.0, 75.0, 75.0, 82.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 110.0, 124.0, 118.0, 118.0, 117.0, 114.0, 128.0, 120.0], "value": 117.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 171.0, 175.0, 174.0, 175.0, 168.0, 169.0, 169.0, 169.0, 167.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 69.0, 65.0, 66.0, 67.0, 65.0, 66.0, 71.0], "value": 66.6, "unit": "score"}]}]} 06:35:36 INFO - Return code: 0 06:35:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:35:36 INFO - # TBPL SUCCESS # 06:35:36 INFO - Running post-action listener: _package_coverage_data 06:35:36 INFO - Running post-action listener: _resource_record_post_action 06:35:36 INFO - [mozharness: 2017-09-20 13:35:36.999340Z] Finished run-tests step (success) 06:35:36 INFO - Running post-run listener: _resource_record_post_run 06:35:37 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 340348928; Read time: 24; Write time: 374408 06:35:37 INFO - TinderboxPrint: CPU usage
13.3% 06:35:37 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 06:35:37 INFO - TinderboxPrint: I/O write bytes / time
340,348,928 / 374,408 06:35:37 INFO - TinderboxPrint: CPU idle
8,254.8 (86.7%) 06:35:37 INFO - TinderboxPrint: CPU user
1,201.3 (12.6%) 06:35:37 INFO - TinderboxPrint: Swap in / out
0 / 0 06:35:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13094912; Read time: 0; Write time: 4332 06:35:37 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:35:37 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326868992; Read time: 16; Write time: 370052 06:35:37 INFO - Running post-run listener: _upload_blobber_files 06:35:37 INFO - Blob upload gear active. 06:35:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:35:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:35:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:35:38 INFO - (blobuploader) - INFO - Open directory for files ... 06:35:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:35:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:35:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:39 INFO - (blobuploader) - INFO - Done attempting. 06:35:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:35:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:35:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:40 INFO - (blobuploader) - INFO - Done attempting. 06:35:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:35:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:35:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:41 INFO - (blobuploader) - INFO - Done attempting. 06:35:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:35:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:35:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:48 INFO - (blobuploader) - INFO - Done attempting. 06:35:48 INFO - (blobuploader) - INFO - Iteration through files over. 06:35:48 INFO - Return code: 0 06:35:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:35:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:35:48 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/924b050eda97ee8b450ae8cc721ae0e9de32085d788d27bc721396d8adbe76165926065282cf9f128dad4d361a79877000fcc758cfc84f9b1706046d978287dc", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a6c19ed36006c5aeac9228ccd16e657b062d7f09083a2b4a07e9942c63e744418c6cce8629358cf6d2ee4251f49a10ff95cb8bb9ce8624592e9c8eaf416176b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5bf79a47ce7099244b6c1040b2ed194b123c336dd6b00c455cf48581925f970def55a3f76356e44074ea69b3d3a7e39d12f1d6ead87421b7661acdb34cd6852", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce901af0946d67227fcffadb5c99fc52fd801056cf8ba05fa1a5b9e9671c1313145f9dbf448702679f09a6e16540f046d242a5b823b8c1e7a8869e660a17bbca"} 06:35:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:35:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:35:48 INFO - Contents: 06:35:48 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/924b050eda97ee8b450ae8cc721ae0e9de32085d788d27bc721396d8adbe76165926065282cf9f128dad4d361a79877000fcc758cfc84f9b1706046d978287dc", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a6c19ed36006c5aeac9228ccd16e657b062d7f09083a2b4a07e9942c63e744418c6cce8629358cf6d2ee4251f49a10ff95cb8bb9ce8624592e9c8eaf416176b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5bf79a47ce7099244b6c1040b2ed194b123c336dd6b00c455cf48581925f970def55a3f76356e44074ea69b3d3a7e39d12f1d6ead87421b7661acdb34cd6852", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce901af0946d67227fcffadb5c99fc52fd801056cf8ba05fa1a5b9e9671c1313145f9dbf448702679f09a6e16540f046d242a5b823b8c1e7a8869e660a17bbca"} 06:35:48 INFO - Running post-run listener: copy_logs_to_upload_dir 06:35:48 INFO - Copying logs to upload dir... 06:35:48 INFO - mkdir: /builds/slave/test/build/upload/logs 06:35:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.373233 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-20 06:35:48.408058) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 06:35:48.415373) ========= 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=ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460 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/924b050eda97ee8b450ae8cc721ae0e9de32085d788d27bc721396d8adbe76165926065282cf9f128dad4d361a79877000fcc758cfc84f9b1706046d978287dc", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a6c19ed36006c5aeac9228ccd16e657b062d7f09083a2b4a07e9942c63e744418c6cce8629358cf6d2ee4251f49a10ff95cb8bb9ce8624592e9c8eaf416176b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5bf79a47ce7099244b6c1040b2ed194b123c336dd6b00c455cf48581925f970def55a3f76356e44074ea69b3d3a7e39d12f1d6ead87421b7661acdb34cd6852", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce901af0946d67227fcffadb5c99fc52fd801056cf8ba05fa1a5b9e9671c1313145f9dbf448702679f09a6e16540f046d242a5b823b8c1e7a8869e660a17bbca"} build_url:https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/HBUujFfqTheR_yOD7KSOzg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/924b050eda97ee8b450ae8cc721ae0e9de32085d788d27bc721396d8adbe76165926065282cf9f128dad4d361a79877000fcc758cfc84f9b1706046d978287dc", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a6c19ed36006c5aeac9228ccd16e657b062d7f09083a2b4a07e9942c63e744418c6cce8629358cf6d2ee4251f49a10ff95cb8bb9ce8624592e9c8eaf416176b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5bf79a47ce7099244b6c1040b2ed194b123c336dd6b00c455cf48581925f970def55a3f76356e44074ea69b3d3a7e39d12f1d6ead87421b7661acdb34cd6852", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce901af0946d67227fcffadb5c99fc52fd801056cf8ba05fa1a5b9e9671c1313145f9dbf448702679f09a6e16540f046d242a5b823b8c1e7a8869e660a17bbca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 06:35:48.449522) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:35:48.449975) ========= 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=ba164b0a7b0ec7655860e956000001c1-1505910588.322154-640098460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:35:48.530908) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 06:35:48.531304) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 06:35:48.531844) ========= ========= Total master_lag: 0.43 =========