builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1506177779.98 results: success (0) revision: 3828e44f5b0a56e7933b817d430cf32d41b03fe6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 07:42:59.981093) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 07:42:59.981532) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 07:42:59.981803) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 07:43:00.000397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:43:00.000713) ========= 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=ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 07:43:00-- 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% 111M=0s 2017-09-23 07:43:00 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.212956 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:43:00.230808) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:43:00.234147) ========= 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=ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017055 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:43:00.283909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:43:00.284238) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3828e44f5b0a56e7933b817d430cf32d41b03fe6 --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 3828e44f5b0a56e7933b817d430cf32d41b03fe6 --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=ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 07:43:00,395 truncating revision to first 12 chars 2017-09-23 07:43:00,396 Setting DEBUG logging. 2017-09-23 07:43:00,396 attempt 1/10 2017-09-23 07:43:00,396 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3828e44f5b0a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-23 07:43:00,882 unpacking tar archive at: mozilla-central-3828e44f5b0a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.851887 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 07:43:01.155309) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 07:43:01.155611) ========= script_repo_revision: 3828e44f5b0a56e7933b817d430cf32d41b03fe6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 07:43:01.159025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 07:43:01.159321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 07:43:01.173324) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-23 07:43:01.173721) ========= /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=ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:43:01 INFO - MultiFileLogger online at 20170923 07:43:01 in /builds/slave/test 07:43:01 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 07:43:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:43:01 INFO - {'append_to_log': False, 07:43:01 INFO - 'base_work_dir': '/builds/slave/test', 07:43:01 INFO - 'blob_upload_branch': 'Firefox', 07:43:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:43:01 INFO - 'branch': 'Firefox', 07:43:01 INFO - 'buildbot_json_path': 'buildprops.json', 07:43:01 INFO - 'code_coverage': False, 07:43:01 INFO - 'config_files': ('talos/linux_config.py',), 07:43:01 INFO - 'default_actions': ('clobber', 07:43:01 INFO - 'read-buildbot-config', 07:43:01 INFO - 'download-and-extract', 07:43:01 INFO - 'populate-webroot', 07:43:01 INFO - 'create-virtualenv', 07:43:01 INFO - 'install', 07:43:01 INFO - 'setup-mitmproxy', 07:43:01 INFO - 'run-tests'), 07:43:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:43:01 INFO - 'disable_ccov_upload': False, 07:43:01 INFO - 'disable_stylo': False, 07:43:01 INFO - 'download_minidump_stackwalk': True, 07:43:01 INFO - 'download_symbols': 'ondemand', 07:43:01 INFO - 'enable_stylo': False, 07:43:01 INFO - 'enable_webrender': False, 07:43:01 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:43:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:43:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:43:01 INFO - 'gecko_profile': False, 07:43:01 INFO - 'gecko_profile_interval': 0, 07:43:01 INFO - 'installer_path': 'installer.exe', 07:43:01 INFO - 'log_level': 'info', 07:43:01 INFO - 'log_name': 'talos', 07:43:01 INFO - 'log_to_console': True, 07:43:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:43:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:43:01 INFO - 'opt_config_files': (), 07:43:01 INFO - 'pip_index': False, 07:43:01 INFO - 'suite': 'dromaeojs-e10s', 07:43:01 INFO - 'system_bits': '32', 07:43:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:43:01 INFO - 'title': 'talos-linux64-ix-035', 07:43:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:43:01 INFO - 'use_talos_json': True, 07:43:01 INFO - 'verify': 'False', 07:43:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:43:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:43:01 INFO - 'work_dir': 'build'} 07:43:01 INFO - [mozharness: 2017-09-23 14:43:01.549418Z] Running clobber step. 07:43:01 INFO - Running pre-action listener: _resource_record_pre_action 07:43:01 INFO - Running main action method: clobber 07:43:01 INFO - rmtree: /builds/slave/test/build 07:43:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:43:02 INFO - Running post-action listener: _resource_record_post_action 07:43:02 INFO - [mozharness: 2017-09-23 14:43:02.501912Z] Finished clobber step (success) 07:43:02 INFO - [mozharness: 2017-09-23 14:43:02.502072Z] Running read-buildbot-config step. 07:43:02 INFO - Running pre-action listener: _resource_record_pre_action 07:43:02 INFO - Running main action method: read_buildbot_config 07:43:02 INFO - Using buildbot properties: 07:43:02 INFO - { 07:43:02 INFO - "project": "", 07:43:02 INFO - "product": "firefox", 07:43:02 INFO - "who": "philringnalda@gmail.com", 07:43:02 INFO - "installer_path": "public/build/target.tar.bz2", 07:43:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:43:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:43:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:43:02 INFO - "stage_platform": "linux64-pgo", 07:43:02 INFO - "basedir": "/builds/slave/test", 07:43:02 INFO - "buildnumber": 201, 07:43:02 INFO - "platform": "ubuntu64_hw", 07:43:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:43:02 INFO - "slavebuilddir": "test", 07:43:02 INFO - "taskId": "GkVdkjRBRF2fawi9cuUjIQ", 07:43:02 INFO - "branch": "mozilla-central", 07:43:02 INFO - "script_repo_revision": "production", 07:43:02 INFO - "revision": "3828e44f5b0a56e7933b817d430cf32d41b03fe6", 07:43:02 INFO - "slavename": "talos-linux64-ix-035", 07:43:02 INFO - "repo_path": "mozilla-central" 07:43:02 INFO - } 07:43:02 INFO - Finding installer, test and symbols from parent task. 07:43:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GkVdkjRBRF2fawi9cuUjIQ'}, attempt #1 07:43:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GkVdkjRBRF2fawi9cuUjIQ'}, attempt #1 07:43:03 INFO - Task dependencies: SKQULHJBQqSQWGRwTREaVQ 07:43:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ'}, attempt #1 07:43:03 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.tar.bz2 07:43:03 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.test_packages.json 07:43:03 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.crashreporter-symbols.zip 07:43:03 INFO - Running post-action listener: _resource_record_post_action 07:43:03 INFO - [mozharness: 2017-09-23 14:43:03.830406Z] Finished read-buildbot-config step (success) 07:43:03 INFO - [mozharness: 2017-09-23 14:43:03.830634Z] Running download-and-extract step. 07:43:03 INFO - Running pre-action listener: _resource_record_pre_action 07:43:03 INFO - Running main action method: download_and_extract 07:43:03 INFO - mkdir: /builds/slave/test/build/tests 07:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:03 INFO - trying https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.test_packages.json 07:43:03 INFO - Downloading https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:43:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:43:04 INFO - Downloaded 989 bytes. 07:43:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:43:04 INFO - Using the following test package requirements: 07:43:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:43:04 INFO - u'common': [u'target.common.tests.zip'], 07:43:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:43:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:43:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:43:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:43:04 INFO - u'mozbase': [u'target.common.tests.zip'], 07:43:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:43:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:43:04 INFO - u'web-platform': [u'target.common.tests.zip', 07:43:04 INFO - u'target.web-platform.tests.tar.gz'], 07:43:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:43:04 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:43:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.common.tests.zip 07:43:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:43:04 INFO - Fetch https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.common.tests.zip into memory 07:43:05 INFO - Content-Length response header: 55344671 07:43:05 INFO - Bytes received: 55344671 07:43:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.talos.tests.zip 07:43:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:43:16 INFO - Fetch https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.talos.tests.zip into memory 07:43:17 INFO - Content-Length response header: 14513823 07:43:17 INFO - Bytes received: 14513823 07:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:17 INFO - trying https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.tar.bz2 07:43:17 INFO - Downloading https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:43:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:43:18 INFO - Downloaded 62348988 bytes. 07:43:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.tar.bz2 07:43:18 INFO - mkdir: /builds/slave/test/properties 07:43:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:43:18 INFO - Writing to file /builds/slave/test/properties/build_url 07:43:18 INFO - Contents: 07:43:18 INFO - build_url:https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.tar.bz2 07:43:18 INFO - Running post-action listener: _resource_record_post_action 07:43:18 INFO - Running post-action listener: find_tests_for_verification 07:43:18 INFO - Running post-action listener: set_extra_try_arguments 07:43:18 INFO - [mozharness: 2017-09-23 14:43:18.779365Z] Finished download-and-extract step (success) 07:43:18 INFO - [mozharness: 2017-09-23 14:43:18.779463Z] Running populate-webroot step. 07:43:18 INFO - Running pre-action listener: _resource_record_pre_action 07:43:18 INFO - Running main action method: populate_webroot 07:43:18 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:43:18 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:18 INFO - 'tests': ['tresize', 07:43:18 INFO - 'tcanvasmark']}, 07:43:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:43:18 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:18 INFO - 'tests': ['dromaeo_css', 07:43:18 INFO - 'kraken']}, 07:43:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:43:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:18 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:43:18 INFO - 'talos_options': ['--disable-stylo'], 07:43:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:43:18 INFO - 'tests': ['damp', 'tps']}, 07:43:18 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:43:18 INFO - 'talos_options': ['--disable-stylo'], 07:43:18 INFO - 'tests': ['damp', 'tps']}, 07:43:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:43:18 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:18 INFO - 'tests': ['dromaeo_dom']}, 07:43:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:43:18 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:18 INFO - 'tests': ['basic_compositor_video', 07:43:18 INFO - 'glvideo']}, 07:43:18 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:43:18 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:43:18 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:43:18 INFO - 'talos_options': ['--disable-stylo'], 07:43:18 INFO - 'tests': ['ts_paint_webext', 07:43:18 INFO - 'tp5o_webext']}, 07:43:18 INFO - 'other-e10s': {'tests': ['a11yr', 07:43:18 INFO - 'ts_paint', 07:43:18 INFO - 'tpaint', 07:43:18 INFO - 'sessionrestore', 07:43:18 INFO - 'sessionrestore_many_windows', 07:43:18 INFO - 'sessionrestore_no_auto_restore', 07:43:18 INFO - 'tabpaint']}, 07:43:18 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:18 INFO - 'tests': ['a11yr', 07:43:18 INFO - 'ts_paint', 07:43:18 INFO - 'tpaint', 07:43:18 INFO - 'sessionrestore', 07:43:18 INFO - 'sessionrestore_many_windows', 07:43:18 INFO - 'sessionrestore_no_auto_restore', 07:43:18 INFO - 'tabpaint']}, 07:43:18 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 07:43:18 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:43:18 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:18 INFO - 'tests': ['perf_reftest_singletons']}, 07:43:18 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:18 INFO - 'tests': ['perf_reftest']}, 07:43:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:43:18 INFO - 'tsvgr_opacity', 07:43:18 INFO - 'tart', 07:43:18 INFO - 'tscrollx', 07:43:18 INFO - 'tsvg_static']}, 07:43:18 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:18 INFO - 'tests': ['tsvgx', 07:43:18 INFO - 'tsvgr_opacity', 07:43:18 INFO - 'tart', 07:43:18 INFO - 'tscrollx', 07:43:18 INFO - 'tsvg_static']}, 07:43:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:43:18 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:43:18 INFO - 'talos_options': ['--disable-stylo'], 07:43:18 INFO - 'tests': ['tp5o']}, 07:43:18 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:43:18 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 07:43:18 INFO - 'talos_options': ['--mitmproxy', 07:43:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:43:18 INFO - '--firstNonBlankPaint'], 07:43:18 INFO - 'tests': ['tp6_google', 07:43:18 INFO - 'tp6_youtube', 07:43:18 INFO - 'tp6_amazon', 07:43:18 INFO - 'tp6_facebook']}, 07:43:18 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:43:18 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 07:43:18 INFO - 'talos_options': ['--disable-stylo', 07:43:18 INFO - '--mitmproxy', 07:43:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:43:18 INFO - '--firstNonBlankPaint'], 07:43:18 INFO - 'tests': ['tp6_google', 07:43:18 INFO - 'tp6_youtube', 07:43:18 INFO - 'tp6_amazon', 07:43:18 INFO - 'tp6_facebook']}, 07:43:18 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:43:18 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 07:43:18 INFO - 'talos_options': ['--stylo-threads=1', 07:43:18 INFO - '--mitmproxy', 07:43:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:43:18 INFO - '--firstNonBlankPaint'], 07:43:18 INFO - 'tests': ['tp6_google', 07:43:18 INFO - 'tp6_youtube', 07:43:18 INFO - 'tp6_amazon', 07:43:18 INFO - 'tp6_facebook']}, 07:43:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:43:18 INFO - 'talos_options': ['--xperf_path', 07:43:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:18 INFO - 'tests': ['tp5n']}, 07:43:18 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:43:18 INFO - 'talos_options': ['--disable-stylo', 07:43:18 INFO - '--xperf_path', 07:43:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:18 INFO - 'tests': ['tp5n']}}} 07:43:18 INFO - Running post-action listener: _resource_record_post_action 07:43:18 INFO - [mozharness: 2017-09-23 14:43:18.795030Z] Finished populate-webroot step (success) 07:43:18 INFO - [mozharness: 2017-09-23 14:43:18.795120Z] Running create-virtualenv step. 07:43:18 INFO - Running pre-action listener: _resource_record_pre_action 07:43:18 INFO - Running main action method: create_virtualenv 07:43:18 INFO - Creating virtualenv /builds/slave/test/build/venv 07:43:18 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:43:18 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:43:18 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:43:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:43:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:43:20 INFO - Installing distribute.............................................................................................................................................................................................done. 07:43:20 INFO - Installing pip...............done. 07:43:20 INFO - Return code: 0 07:43:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:43:20 INFO - Reading from file tmpfile_stdout 07:43:20 INFO - Output received: 07:43:20 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:43:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:43:20 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')]} 07:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:20 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')]} 07:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:20 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 0x123c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6d60>, '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 0x15a7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', '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 07:43:20 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 07:43:20 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 07:43:20 INFO - Using env: {'DISPLAY': ':0', 07:43:20 INFO - 'HOME': '/home/cltbld', 07:43:20 INFO - 'LANG': 'en_US.UTF-8', 07:43:20 INFO - 'LANGUAGE': 'en_US:en', 07:43:20 INFO - 'LOGNAME': 'cltbld', 07:43:20 INFO - 'MAIL': '/var/mail/cltbld', 07:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:20 INFO - 'MOZ_NO_REMOTE': '1', 07:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:20 INFO - 'NO_EM_RESTART': '1', 07:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:20 INFO - 'PWD': '/builds/slave/test', 07:43:20 INFO - 'SHELL': '/bin/bash', 07:43:20 INFO - 'SHLVL': '1', 07:43:20 INFO - 'TERM': 'linux', 07:43:20 INFO - 'TMOUT': '86400', 07:43:20 INFO - 'USER': 'cltbld', 07:43:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', 07:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:20 INFO - '_': '/tools/buildbot/bin/python'} 07:43:22 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:43:22 INFO - Downloading/unpacking pip>=1.5 07:43:22 INFO - Running setup.py egg_info for package pip 07:43:22 INFO - warning: no files found matching 'pip/cacert.pem' 07:43:22 INFO - warning: no files found matching '*.html' under directory 'docs' 07:43:22 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:43:22 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:43:22 INFO - Installing collected packages: pip 07:43:22 INFO - Found existing installation: pip 1.1 07:43:22 INFO - Uninstalling pip: 07:43:22 INFO - Successfully uninstalled pip 07:43:22 INFO - Running setup.py install for pip 07:43:22 INFO - warning: no files found matching 'pip/cacert.pem' 07:43:22 INFO - warning: no files found matching '*.html' under directory 'docs' 07:43:22 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:43:22 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:43:22 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:43:22 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:43:22 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:43:22 INFO - Successfully installed pip 07:43:22 INFO - Cleaning up... 07:43:22 INFO - Return code: 0 07:43:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:43:22 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')]} 07:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:22 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')]} 07:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:22 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 0x123c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6d60>, '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 0x15a7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', '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 07:43:22 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 07:43:22 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 07:43:22 INFO - Using env: {'DISPLAY': ':0', 07:43:22 INFO - 'HOME': '/home/cltbld', 07:43:22 INFO - 'LANG': 'en_US.UTF-8', 07:43:22 INFO - 'LANGUAGE': 'en_US:en', 07:43:22 INFO - 'LOGNAME': 'cltbld', 07:43:22 INFO - 'MAIL': '/var/mail/cltbld', 07:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:22 INFO - 'MOZ_NO_REMOTE': '1', 07:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:22 INFO - 'NO_EM_RESTART': '1', 07:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:22 INFO - 'PWD': '/builds/slave/test', 07:43:22 INFO - 'SHELL': '/bin/bash', 07:43:22 INFO - 'SHLVL': '1', 07:43:22 INFO - 'TERM': 'linux', 07:43:22 INFO - 'TMOUT': '86400', 07:43:22 INFO - 'USER': 'cltbld', 07:43:22 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', 07:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:22 INFO - '_': '/tools/buildbot/bin/python'} 07:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:22 INFO - Downloading/unpacking psutil>=3.1.1 07:43:22 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 07:43:22 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 07:43:22 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 07:43:22 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 07:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:43:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:43:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:43:23 INFO - Installing collected packages: psutil 07:43:23 INFO - Running setup.py install for psutil 07:43:23 INFO - building 'psutil._psutil_linux' extension 07:43:23 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 07:43:24 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 07:43:24 INFO - building 'psutil._psutil_posix' extension 07:43:24 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 07:43:25 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 07:43:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:43:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:43:25 INFO - Successfully installed psutil 07:43:25 INFO - Cleaning up... 07:43:25 INFO - Return code: 0 07:43:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:43:25 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')]} 07:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:25 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')]} 07:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:25 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 0x123c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6d60>, '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 0x15a7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', '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 07:43:25 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 07:43:25 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 07:43:25 INFO - Using env: {'DISPLAY': ':0', 07:43:25 INFO - 'HOME': '/home/cltbld', 07:43:25 INFO - 'LANG': 'en_US.UTF-8', 07:43:25 INFO - 'LANGUAGE': 'en_US:en', 07:43:25 INFO - 'LOGNAME': 'cltbld', 07:43:25 INFO - 'MAIL': '/var/mail/cltbld', 07:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:25 INFO - 'MOZ_NO_REMOTE': '1', 07:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:25 INFO - 'NO_EM_RESTART': '1', 07:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:25 INFO - 'PWD': '/builds/slave/test', 07:43:25 INFO - 'SHELL': '/bin/bash', 07:43:25 INFO - 'SHLVL': '1', 07:43:25 INFO - 'TERM': 'linux', 07:43:25 INFO - 'TMOUT': '86400', 07:43:25 INFO - 'USER': 'cltbld', 07:43:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', 07:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:25 INFO - '_': '/tools/buildbot/bin/python'} 07:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:43:25 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 07:43:25 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 07:43:25 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 07:43:25 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 07:43:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:43:26 INFO - Installing collected packages: mozsystemmonitor 07:43:26 INFO - Running setup.py install for mozsystemmonitor 07:43:26 INFO - Successfully installed mozsystemmonitor 07:43:26 INFO - Cleaning up... 07:43:26 INFO - Return code: 0 07:43:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:43: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')]} 07:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43: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')]} 07:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43: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 0x123c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6d60>, '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 0x15a7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', '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 07:43: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 07:43: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 07:43:26 INFO - Using env: {'DISPLAY': ':0', 07:43:26 INFO - 'HOME': '/home/cltbld', 07:43:26 INFO - 'LANG': 'en_US.UTF-8', 07:43:26 INFO - 'LANGUAGE': 'en_US:en', 07:43:26 INFO - 'LOGNAME': 'cltbld', 07:43:26 INFO - 'MAIL': '/var/mail/cltbld', 07:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:26 INFO - 'MOZ_NO_REMOTE': '1', 07:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:26 INFO - 'NO_EM_RESTART': '1', 07:43:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:26 INFO - 'PWD': '/builds/slave/test', 07:43:26 INFO - 'SHELL': '/bin/bash', 07:43:26 INFO - 'SHLVL': '1', 07:43:26 INFO - 'TERM': 'linux', 07:43:26 INFO - 'TMOUT': '86400', 07:43:26 INFO - 'USER': 'cltbld', 07:43:26 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', 07:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:26 INFO - '_': '/tools/buildbot/bin/python'} 07:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:27 INFO - Downloading/unpacking jsonschema==2.5.1 07:43:27 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 07:43:27 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 07:43:27 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 07:43:27 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 07:43:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:43:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:43:28 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 07:43:28 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 07:43:28 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 07:43:28 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 07:43:28 INFO - Downloading functools32-3.2.3-2.tar.gz 07:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:43:28 INFO - warning: no files found matching '*.txt' 07:43:28 INFO - no previously-included directories found matching 'build' 07:43:28 INFO - no previously-included directories found matching 'dist' 07:43:28 INFO - no previously-included directories found matching '.git*' 07:43:28 INFO - Installing collected packages: jsonschema, functools32 07:43:28 INFO - Running setup.py install for functools32 07:43:28 INFO - warning: no files found matching '*.txt' 07:43:28 INFO - no previously-included directories found matching 'build' 07:43:28 INFO - no previously-included directories found matching 'dist' 07:43:28 INFO - no previously-included directories found matching '.git*' 07:43:28 INFO - Successfully installed jsonschema functools32 07:43:28 INFO - Cleaning up... 07:43:28 INFO - Return code: 0 07:43:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:43:28 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')]} 07:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:28 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')]} 07:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:28 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 0x123c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6d60>, '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 0x15a7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', '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 07:43:28 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 07:43:28 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 07:43:28 INFO - Using env: {'DISPLAY': ':0', 07:43:28 INFO - 'HOME': '/home/cltbld', 07:43:28 INFO - 'LANG': 'en_US.UTF-8', 07:43:28 INFO - 'LANGUAGE': 'en_US:en', 07:43:28 INFO - 'LOGNAME': 'cltbld', 07:43:28 INFO - 'MAIL': '/var/mail/cltbld', 07:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:28 INFO - 'MOZ_NO_REMOTE': '1', 07:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:28 INFO - 'NO_EM_RESTART': '1', 07:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:28 INFO - 'PWD': '/builds/slave/test', 07:43:28 INFO - 'SHELL': '/bin/bash', 07:43:28 INFO - 'SHLVL': '1', 07:43:28 INFO - 'TERM': 'linux', 07:43:28 INFO - 'TMOUT': '86400', 07:43:28 INFO - 'USER': 'cltbld', 07:43:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', 07:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:28 INFO - '_': '/tools/buildbot/bin/python'} 07:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:43:28 INFO - Cleaning up... 07:43:28 INFO - Return code: 0 07:43:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:43:28 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')]} 07:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:28 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')]} 07:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:28 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 0x123c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6d60>, '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 0x15a7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', '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 07:43:28 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 07:43:28 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 07:43:28 INFO - Using env: {'DISPLAY': ':0', 07:43:28 INFO - 'HOME': '/home/cltbld', 07:43:28 INFO - 'LANG': 'en_US.UTF-8', 07:43:28 INFO - 'LANGUAGE': 'en_US:en', 07:43:28 INFO - 'LOGNAME': 'cltbld', 07:43:28 INFO - 'MAIL': '/var/mail/cltbld', 07:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:28 INFO - 'MOZ_NO_REMOTE': '1', 07:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:28 INFO - 'NO_EM_RESTART': '1', 07:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:28 INFO - 'PWD': '/builds/slave/test', 07:43:28 INFO - 'SHELL': '/bin/bash', 07:43:28 INFO - 'SHLVL': '1', 07:43:28 INFO - 'TERM': 'linux', 07:43:28 INFO - 'TMOUT': '86400', 07:43:28 INFO - 'USER': 'cltbld', 07:43:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', 07:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:28 INFO - '_': '/tools/buildbot/bin/python'} 07:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:28 INFO - Downloading/unpacking blobuploader==1.2.4 07:43:28 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 07:43:28 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 07:43:28 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 07:43:28 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 07:43:30 INFO - Downloading blobuploader-1.2.4.tar.gz 07:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:43:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:43: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 07:43: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 07:43: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 07:43: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 07:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:43:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:43: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 07:43: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 07:43: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 07:43: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 07:43:30 INFO - Downloading docopt-0.6.1.tar.gz 07:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:43:30 INFO - Installing collected packages: blobuploader, requests, docopt 07:43:30 INFO - Running setup.py install for blobuploader 07:43:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:43:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:43:30 INFO - Running setup.py install for requests 07:43:31 INFO - Running setup.py install for docopt 07:43:31 INFO - Successfully installed blobuploader requests docopt 07:43:31 INFO - Cleaning up... 07:43:31 INFO - Return code: 0 07:43:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:31 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')]} 07:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:31 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')]} 07:43:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:31 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 0x123c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6d60>, '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 0x15a7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', '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 07:43:31 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 07:43:31 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 07:43:31 INFO - Using env: {'DISPLAY': ':0', 07:43:31 INFO - 'HOME': '/home/cltbld', 07:43:31 INFO - 'LANG': 'en_US.UTF-8', 07:43:31 INFO - 'LANGUAGE': 'en_US:en', 07:43:31 INFO - 'LOGNAME': 'cltbld', 07:43:31 INFO - 'MAIL': '/var/mail/cltbld', 07:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:31 INFO - 'MOZ_NO_REMOTE': '1', 07:43:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:31 INFO - 'NO_EM_RESTART': '1', 07:43:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:31 INFO - 'PWD': '/builds/slave/test', 07:43:31 INFO - 'SHELL': '/bin/bash', 07:43:31 INFO - 'SHLVL': '1', 07:43:31 INFO - 'TERM': 'linux', 07:43:31 INFO - 'TMOUT': '86400', 07:43:31 INFO - 'USER': 'cltbld', 07:43:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', 07:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:31 INFO - '_': '/tools/buildbot/bin/python'} 07:43:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:32 INFO - Running setup.py (path:/tmp/pip-tGWbZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:32 INFO - Running setup.py (path:/tmp/pip-1IU_Qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:32 INFO - Running setup.py (path:/tmp/pip-YZwcGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:32 INFO - Running setup.py (path:/tmp/pip-uQuWYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:32 INFO - Running setup.py (path:/tmp/pip-cvNKp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:32 INFO - Running setup.py (path:/tmp/pip-47aFy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:32 INFO - Running setup.py (path:/tmp/pip-rqp7p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:32 INFO - Running setup.py (path:/tmp/pip-ayR7ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:32 INFO - Running setup.py (path:/tmp/pip-QNMH3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:32 INFO - Running setup.py (path:/tmp/pip-UJGqUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:32 INFO - Running setup.py (path:/tmp/pip-mMeGZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:32 INFO - Running setup.py (path:/tmp/pip-HYX2ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:32 INFO - Running setup.py (path:/tmp/pip-BuOwdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:32 INFO - Running setup.py (path:/tmp/pip-TD1cZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:32 INFO - Running setup.py (path:/tmp/pip-ozPt2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:33 INFO - Running setup.py (path:/tmp/pip-TeGNEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:33 INFO - Running setup.py (path:/tmp/pip-M4Ctkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:43:33 INFO - Running setup.py install for manifestparser 07:43:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:43:33 INFO - Running setup.py install for mozcrash 07:43:33 INFO - Running setup.py install for mozdebug 07:43:33 INFO - Running setup.py install for mozdevice 07:43:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:43:33 INFO - Running setup.py install for mozfile 07:43:33 INFO - Running setup.py install for mozhttpd 07:43:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:43:33 INFO - Running setup.py install for mozinfo 07:43:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:43:33 INFO - Running setup.py install for mozInstall 07:43:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:43:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:43:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:43:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:43:33 INFO - Running setup.py install for mozleak 07:43:34 INFO - Running setup.py install for mozlog 07:43:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:43:34 INFO - Running setup.py install for moznetwork 07:43:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:43:34 INFO - Running setup.py install for mozprocess 07:43:34 INFO - Running setup.py install for mozprofile 07:43:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:43:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:43:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:43:34 INFO - Running setup.py install for mozrunner 07:43:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:43:34 INFO - Running setup.py install for mozscreenshot 07:43:34 INFO - Running setup.py install for moztest 07:43:34 INFO - Running setup.py install for mozversion 07:43:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:43:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:43:34 INFO - Cleaning up... 07:43:34 INFO - Return code: 0 07:43:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:34 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')]} 07:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:34 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')]} 07:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:34 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 0x123c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6d60>, '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 0x15a7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', '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 07:43:34 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 07:43:34 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 07:43:34 INFO - Using env: {'DISPLAY': ':0', 07:43:34 INFO - 'HOME': '/home/cltbld', 07:43:34 INFO - 'LANG': 'en_US.UTF-8', 07:43:34 INFO - 'LANGUAGE': 'en_US:en', 07:43:34 INFO - 'LOGNAME': 'cltbld', 07:43:34 INFO - 'MAIL': '/var/mail/cltbld', 07:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:34 INFO - 'MOZ_NO_REMOTE': '1', 07:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:34 INFO - 'NO_EM_RESTART': '1', 07:43:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:34 INFO - 'PWD': '/builds/slave/test', 07:43:34 INFO - 'SHELL': '/bin/bash', 07:43:34 INFO - 'SHLVL': '1', 07:43:34 INFO - 'TERM': 'linux', 07:43:34 INFO - 'TMOUT': '86400', 07:43:34 INFO - 'USER': 'cltbld', 07:43:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', 07:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:34 INFO - '_': '/tools/buildbot/bin/python'} 07:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:35 INFO - Running setup.py (path:/tmp/pip-HmWOIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:35 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)) 07:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:35 INFO - Running setup.py (path:/tmp/pip-iGhSew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:35 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)) 07:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:35 INFO - Running setup.py (path:/tmp/pip-oKHOI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:35 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)) 07:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:35 INFO - Running setup.py (path:/tmp/pip-lfzfZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:35 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)) 07:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:35 INFO - Running setup.py (path:/tmp/pip-Rl5aiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:35 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)) 07:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:35 INFO - Running setup.py (path:/tmp/pip-BVxezH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:35 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)) 07:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:35 INFO - Running setup.py (path:/tmp/pip-XY14Vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:35 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)) 07:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:35 INFO - Running setup.py (path:/tmp/pip-7vmcCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:35 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)) 07:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:35 INFO - Running setup.py (path:/tmp/pip-X6_3VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:35 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)) 07:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:35 INFO - Running setup.py (path:/tmp/pip-88aPxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:35 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)) 07:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:35 INFO - Running setup.py (path:/tmp/pip-mY1h6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:35 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)) 07:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:35 INFO - Running setup.py (path:/tmp/pip-G9iF1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:35 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)) 07:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:35 INFO - Running setup.py (path:/tmp/pip-nQTZKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:36 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)) 07:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:36 INFO - Running setup.py (path:/tmp/pip-Vy9WQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:36 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)) 07:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:36 INFO - Running setup.py (path:/tmp/pip-VwMQbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:36 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)) 07:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:36 INFO - Running setup.py (path:/tmp/pip-Q77QHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:36 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)) 07:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:36 INFO - Running setup.py (path:/tmp/pip-ATt70c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:36 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)) 07:43:36 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)) 07:43:36 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)) 07:43:36 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)) 07:43:36 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)) 07:43:36 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)) 07:43:36 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)) 07:43:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:43:36 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 07:43:36 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 07:43:36 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 07:43:36 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 07:43:37 INFO - Downloading blessings-1.6.tar.gz 07:43:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:43:37 INFO - Installing collected packages: blessings 07:43:37 INFO - Running setup.py install for blessings 07:43:37 INFO - Successfully installed blessings 07:43:37 INFO - Cleaning up... 07:43:37 INFO - Return code: 0 07:43:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:43:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:37 INFO - Reading from file tmpfile_stdout 07:43:37 INFO - Current package versions: 07:43:37 INFO - argparse == 1.2.1 07:43:37 INFO - blessings == 1.6 07:43:37 INFO - blobuploader == 1.2.4 07:43:37 INFO - docopt == 0.6.1 07:43:37 INFO - functools32 == 3.2.3-2 07:43:37 INFO - jsonschema == 2.5.1 07:43:37 INFO - manifestparser == 1.1 07:43:37 INFO - mozInstall == 1.13 07:43:37 INFO - mozcrash == 1.0 07:43:37 INFO - mozdebug == 0.1 07:43:37 INFO - mozdevice == 0.51 07:43:37 INFO - mozfile == 1.2 07:43:37 INFO - mozhttpd == 0.7 07:43:37 INFO - mozinfo == 0.10 07:43:37 INFO - mozleak == 0.1 07:43:37 INFO - mozlog == 3.5 07:43:37 INFO - moznetwork == 0.27 07:43:37 INFO - mozprocess == 0.25 07:43:37 INFO - mozprofile == 0.28 07:43:37 INFO - mozrunner == 6.13 07:43:37 INFO - mozscreenshot == 0.1 07:43:37 INFO - mozsystemmonitor == 0.3 07:43:37 INFO - moztest == 0.8 07:43:37 INFO - mozversion == 1.4 07:43:37 INFO - psutil == 3.1.1 07:43:37 INFO - requests == 1.2.3 07:43:37 INFO - wsgiref == 0.1.2 07:43:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:37 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')]} 07:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:37 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')]} 07:43:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:37 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 0x123c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6d60>, '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 0x15a7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', '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 07:43:37 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 07:43:37 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 07:43:37 INFO - Using env: {'DISPLAY': ':0', 07:43:37 INFO - 'HOME': '/home/cltbld', 07:43:37 INFO - 'LANG': 'en_US.UTF-8', 07:43:37 INFO - 'LANGUAGE': 'en_US:en', 07:43:37 INFO - 'LOGNAME': 'cltbld', 07:43:37 INFO - 'MAIL': '/var/mail/cltbld', 07:43:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:37 INFO - 'MOZ_NO_REMOTE': '1', 07:43:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:37 INFO - 'NO_EM_RESTART': '1', 07:43:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:37 INFO - 'PWD': '/builds/slave/test', 07:43:37 INFO - 'SHELL': '/bin/bash', 07:43:37 INFO - 'SHLVL': '1', 07:43:37 INFO - 'TERM': 'linux', 07:43:37 INFO - 'TMOUT': '86400', 07:43:37 INFO - 'USER': 'cltbld', 07:43:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', 07:43:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:37 INFO - '_': '/tools/buildbot/bin/python'} 07:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:38 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)) 07:43:38 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)) 07:43:38 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)) 07:43:38 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)) 07:43:38 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)) 07:43:38 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)) 07:43:38 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)) 07:43:38 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)) 07:43:38 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)) 07:43:38 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:43:38 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 07:43:38 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 07:43:38 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 07:43:38 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 07:43:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:43:39 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)) 07:43:39 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)) 07:43:39 INFO - Installing collected packages: simplejson 07:43:39 INFO - Running setup.py install for simplejson 07:43:39 INFO - building 'simplejson._speedups' extension 07:43:39 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 07:43:40 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 07:43:40 INFO - Successfully installed simplejson 07:43:40 INFO - Cleaning up... 07:43:40 INFO - Return code: 0 07:43:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:43:40 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')]} 07:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:40 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')]} 07:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:40 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 0x123c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6d60>, '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 0x15a7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', '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 07:43:40 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 07:43:40 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 07:43:40 INFO - Using env: {'DISPLAY': ':0', 07:43:40 INFO - 'HOME': '/home/cltbld', 07:43:40 INFO - 'LANG': 'en_US.UTF-8', 07:43:40 INFO - 'LANGUAGE': 'en_US:en', 07:43:40 INFO - 'LOGNAME': 'cltbld', 07:43:40 INFO - 'MAIL': '/var/mail/cltbld', 07:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:40 INFO - 'MOZ_NO_REMOTE': '1', 07:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:40 INFO - 'NO_EM_RESTART': '1', 07:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:40 INFO - 'PWD': '/builds/slave/test', 07:43:40 INFO - 'SHELL': '/bin/bash', 07:43:40 INFO - 'SHLVL': '1', 07:43:40 INFO - 'TERM': 'linux', 07:43:40 INFO - 'TMOUT': '86400', 07:43:40 INFO - 'USER': 'cltbld', 07:43:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', 07:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:40 INFO - '_': '/tools/buildbot/bin/python'} 07:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:43:40 INFO - Cleaning up... 07:43:40 INFO - Return code: 0 07:43:40 INFO - Running post-action listener: _resource_record_post_action 07:43:40 INFO - Running post-action listener: _start_resource_monitoring 07:43:40 INFO - Starting resource monitoring. 07:43:40 INFO - [mozharness: 2017-09-23 14:43:40.649379Z] Finished create-virtualenv step (success) 07:43:40 INFO - [mozharness: 2017-09-23 14:43:40.650442Z] Running install step. 07:43:40 INFO - Running pre-action listener: _resource_record_pre_action 07:43:40 INFO - Running main action method: install 07:43:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:40 INFO - Reading from file tmpfile_stdout 07:43:40 INFO - Detecting whether we're running mozinstall >=1.0... 07:43:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:43:41 INFO - Reading from file tmpfile_stdout 07:43:41 INFO - Output received: 07:43:41 INFO - Usage: mozinstall [options] installer 07:43:41 INFO - Options: 07:43:41 INFO - -h, --help show this help message and exit 07:43:41 INFO - -d DEST, --destination=DEST 07:43:41 INFO - Directory to install application into. [default: 07:43:41 INFO - "/builds/slave/test"] 07:43:41 INFO - --app=APP Application being installed. [default: firefox] 07:43:41 INFO - mkdir: /builds/slave/test/build/application 07:43:41 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'] 07:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:43:58 INFO - Reading from file tmpfile_stdout 07:43:58 INFO - Output received: 07:43:58 INFO - /builds/slave/test/build/application/firefox/firefox 07:43:58 INFO - Running post-action listener: _resource_record_post_action 07:43:58 INFO - [mozharness: 2017-09-23 14:43:58.618535Z] Finished install step (success) 07:43:58 INFO - [mozharness: 2017-09-23 14:43:58.618789Z] Running setup-mitmproxy step. 07:43:58 INFO - Running pre-action listener: _resource_record_pre_action 07:43:58 INFO - Running main action method: setup_mitmproxy 07:43:58 INFO - Skipping: mitmproxy is not required 07:43:58 INFO - Running post-action listener: _resource_record_post_action 07:43:58 INFO - [mozharness: 2017-09-23 14:43:58.619919Z] Finished setup-mitmproxy step (success) 07:43:58 INFO - [mozharness: 2017-09-23 14:43:58.620138Z] Running run-tests step. 07:43:58 INFO - Running pre-action listener: _resource_record_pre_action 07:43:58 INFO - Running pre-action listener: _set_gcov_prefix 07:43:58 INFO - Running main action method: run_tests 07:43:58 WARNING - Try message not found. 07:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:43:58 INFO - Python 2.7.3 07:43:58 INFO - Return code: 0 07:43:58 INFO - grabbing minidump binary from tooltool 07:43:58 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')]} 07:43:58 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 0x15a6d60>, '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 0x15a7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:43:58 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 07:43:58 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 07:43:58 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 07:43:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:43:58 INFO - Return code: 0 07:43:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:43:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:43:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:43:58 INFO - ENV: RUST_BACKTRACE is now full 07:43:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:43:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:43:58 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/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 07:43:58 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/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 07:43:58 INFO - Using env: {'DISPLAY': ':0', 07:43:58 INFO - 'HOME': '/home/cltbld', 07:43:58 INFO - 'LANG': 'en_US.UTF-8', 07:43:58 INFO - 'LANGUAGE': 'en_US:en', 07:43:58 INFO - 'LOGNAME': 'cltbld', 07:43:58 INFO - 'MAIL': '/var/mail/cltbld', 07:43:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:43:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:58 INFO - 'MOZ_NO_REMOTE': '1', 07:43:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:58 INFO - 'NO_EM_RESTART': '1', 07:43:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:58 INFO - 'PWD': '/builds/slave/test', 07:43:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:43:58 INFO - 'RUST_BACKTRACE': 'full', 07:43:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:43:58 INFO - 'SHELL': '/bin/bash', 07:43:58 INFO - 'SHLVL': '1', 07:43:58 INFO - 'TERM': 'linux', 07:43:58 INFO - 'TMOUT': '86400', 07:43:58 INFO - 'USER': 'cltbld', 07:43:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', 07:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:58 INFO - '_': '/tools/buildbot/bin/python'} 07:43:58 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/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 07:43:59 INFO - mozversion application_buildid: 20170923131849 07:43:59 INFO - mozversion application_changeset: 3828e44f5b0a56e7933b817d430cf32d41b03fe6 07:43:59 INFO - mozversion application_display_name: Nightly 07:43:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:43:59 INFO - mozversion application_name: Firefox 07:43:59 INFO - mozversion application_remotingname: firefox 07:43:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:43:59 INFO - mozversion application_vendor: Mozilla 07:43:59 INFO - mozversion application_version: 58.0a1 07:43:59 INFO - mozversion platform_buildid: 20170923131849 07:43:59 INFO - mozversion platform_changeset: 3828e44f5b0a56e7933b817d430cf32d41b03fe6 07:43:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:43:59 INFO - mozversion platform_version: 58.0a1 07:43:59 INFO - using testdate: 1506177839 07:43:59 INFO - actual date: 1506177839 07:43:59 INFO - starting webserver on 'localhost:33811' 07:43:59 INFO - SUITE-START | Running 2 tests 07:43:59 INFO - TEST-START | dromaeo_css 07:43:59 INFO - Initialising browser for dromaeo_css test... 07:43:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33811/getInfo.html -profile /tmp/tmpLkfroy/profile 07:43:59 INFO - TEST-INFO | started process 3564 (/builds/slave/test/build/application/firefox/firefox http://localhost:33811/getInfo.html) 07:44:07 INFO - TEST-INFO | 3564: exit 0 07:44:07 INFO - Browser initialized. 07:44:07 INFO - Running cycle 1/1 for dromaeo_css test... 07:44:07 INFO - Using env: {'DISPLAY': ':0', 07:44:07 INFO - 'HOME': '/home/cltbld', 07:44:07 INFO - 'JSGC_DISABLE_POISONING': '1', 07:44:07 INFO - 'LANG': 'en_US.UTF-8', 07:44:07 INFO - 'LANGUAGE': 'en_US:en', 07:44:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:44:07 INFO - 'LOGNAME': 'cltbld', 07:44:07 INFO - 'MAIL': '/var/mail/cltbld', 07:44:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:44:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:44:07 INFO - 'MOZ_CRASHREPORTER': '1', 07:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:44:07 INFO - 'MOZ_NO_REMOTE': '1', 07:44:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:07 INFO - 'NO_EM_RESTART': '1', 07:44:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:07 INFO - 'PWD': '/builds/slave/test', 07:44:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:44:07 INFO - 'RUST_BACKTRACE': 'full', 07:44:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:44:07 INFO - 'SHELL': '/bin/bash', 07:44:07 INFO - 'SHLVL': '1', 07:44:07 INFO - 'TERM': 'linux', 07:44:07 INFO - 'TMOUT': '86400', 07:44:07 INFO - 'USER': 'cltbld', 07:44:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', 07:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:07 INFO - '_': '/tools/buildbot/bin/python'} 07:44:07 INFO - TEST-INFO | started process 3801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLkfroy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:08 INFO - PID 3801 | 07:44:08 INFO - PID 3801 | (/builds/slave/test/build/application/firefox/firefox:3851): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:44:08 INFO - PID 3801 | 07:44:18 INFO - PID 3801 | RSS: Main: 145240064 07:44:18 INFO - PID 3801 | 07:47:15 INFO - PID 3801 | Cycle 1(1): loaded http://localhost:33811/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33811/tests/dromaeo/cssquery-ext.html) 07:47:16 INFO - PID 3801 | RSS: Main: 146677760 07:47:16 INFO - PID 3801 | 07:50:17 INFO - PID 3801 | Cycle 1(1): loaded http://localhost:33811/tests/dromaeo/cssquery-ext.html (next: http://localhost:33811/tests/dromaeo/cssquery-jquery.html) 07:50:18 INFO - PID 3801 | RSS: Main: 145203200 07:50:18 INFO - PID 3801 | 07:53:20 INFO - PID 3801 | Cycle 1(1): loaded http://localhost:33811/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33811/tests/dromaeo/cssquery-mootools.html) 07:53:20 INFO - PID 3801 | RSS: Main: 148664320 07:53:20 INFO - PID 3801 | 07:56:22 INFO - PID 3801 | Cycle 1(1): loaded http://localhost:33811/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33811/tests/dromaeo/cssquery-prototype.html) 07:56:22 INFO - PID 3801 | RSS: Main: 147464192 07:56:22 INFO - PID 3801 | 07:59:25 INFO - PID 3801 | Cycle 1(1): loaded http://localhost:33811/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33811/tests/dromaeo/cssquery-yui.html) 07:59:26 INFO - PID 3801 | RSS: Main: 148856832 07:59:26 INFO - PID 3801 | 08:02:27 INFO - PID 3801 | Cycle 1(1): loaded http://localhost:33811/tests/dromaeo/cssquery-yui.html (next: http://localhost:33811/tests/dromaeo/cssquery-dojo.html) 08:02:28 INFO - PID 3801 | RSS: Main: 150679552 08:02:28 INFO - PID 3801 | 08:02:28 INFO - PID 3801 | __start_tp_report 08:02:28 INFO - PID 3801 | _x_x_mozilla_page_load 08:02:28 INFO - PID 3801 | _x_x_mozilla_page_load_details 08:02:28 INFO - PID 3801 | |i|pagename|runs| 08:02:28 INFO - PID 3801 | |0;dojo.html;3862.2468618619364;3921.725479216456;3935.3506671399223;3935.7048221383393;3935.724499285049;6284.434400903918;6301.401366870152;6372.1716176897;6376.776812811552;6466.676666166696;6343.524235682331;6351.301356850743;6367.235931688192;6476.935230647692;6492.5779824311385;5671.546276297907;5710.685912274823;5723.170140329649;5758.280214973129;5778.191053252548;169.83481686428232;5362.23781616285;5762.855928601797;5773.220615216934;5796.420357964191;5645.096784514479;5682.26130603021;5692.032354499704;5706.971465142668;5723.627964182315;5689.715514224272;5717.056685646863;5775;5784.68184249866;5792.247007888989;5701.942980570183;5766.163906233614;5779.393163717833;5781.624194427349;5795.478406943395;6326.65203413812;6330.778422755227;6356.2054743157105;6390.584612000205;6432.388923052303;6816.386525212705;6900.171979362509;6909.965450172767;6924.688389022455;6953.89569156463;6859.862802743967;6885.827854303632;6972.51192416531;6973.721051157948;6976.930230697679;6325.841853953688;6358.904616430757;6362.936370636281;6441.227052753653;6452.612843229421;7127.7148914042855;7179.389751871045;7186.532875363085;7190.640467976685;7197.280271972761;6809.250982391933;6809.93190068093;6828.692708828015;6866.793996180123;6920.930790692129;6850.520463567602;6934.687939042755;6964;6966.233714291424;7033.437325013987;6811.931880681229;6876.965615171992;6907;6907.998340240738;6911.447084233249;6820.897686534706;6863.245043045261;6864.759733409307;6935.965320173367;6942.965285173542;4945.7774400152075;4979.800807967641;4990.30135780991;5054.7472626368535;5062.848114556569;4493.977530112394;4529.365888775574;4553.726776393427;4607.262837945913;4620.0990806793025;6246;6294.968525157345;6318.7472501100365;6328.17733694626;6334.366563343721;6891.104156459628;6891.620960847101;6894.586324820527;6908.6545672716165;6989.161300643854;6181.752729890754;6202.813915582449;6252.531060170505;6296.401841825019;6301.180846490019;5499.120140777536;5547.057000309957;5565.109582466866;5587.580931430159;5604.187392828017;6951.131108611424;7043;7126.501144919909;7134.857302853914;7155.713771449188;6766.729330826712;6857.897131543131;6859.725610975505;6948.27043160471;6955.8608827822145;7027.472939529658;7044.964775176091;7048.929510705032;7053.294670532906;7064.434845212268;6810.9318906810295;6850.9314906850295;6888.380045795902;6892.104026476526;6905.723771049102;6914.654267286716;6916.896246556205;6928.7228510859;6990.685419156049;7019.508634395544;6617.900731489128;6681.866362672622;6685.699143538455;6753.729850806109;6784.76253331131;6689.76585819494;6702.530822842549;6712.6979285931275;6714.429273511806;6742.258351581224;6502.219733631805;6593.736250549924;6680.164979377578;6681.732730690718;6684.532082754161;6523.608583484816;6580.177477815273;6648.9002664961035;6655.467562594884;6699.129113215251;6545.967270163619;6572;6588.967055164693;6595.142631457879;6601.306862779339 08:02:28 INFO - PID 3801 | |1;ext.html;948.6869333120067;952.8189643967647;979.6767066867932;1004.4073996342162;1009.0766948242359;42401.575984240146;43455.13089738207;43579;43944.34083488742;44316.3352549712;44669.55330446694;44680.3297950531;44829;44955.550444495544;45042.77478612602;8342.791430214247;8438.873416898752;8452.915470845275;8463.619137138812;8477.279431248351;7964.362850971937;7994.360451163922;8003.239692229258;8005.159458256887;8010.1589333120055;8035.196480351977;8047.678092876278;8057.194280571955;8057.597120143999;8065.0321961364425;7982.042154941415;8015.358771298283;8017.478863873829;8054.194580541957;8063.395245356622;8349.081601023883;8442.873356899652;8461.57692115398;8467.872981905277;8477.491350518989;39417;39626.20747585032;39795.40306895399;40102.59897401018;40153.79923100395;3754.1740817020213;3799.1072098056934;3800.0309920969976;3800.6009369016133;3802.4676545283405;32472.512912306334;32476;32513.83743081293;32600.83699581487;32609;5235.842924712265;5403.135498320289;5446.83659490212;5466.371367292772;5483.890322193533;221714;222204;222704;222981;223942.99999999837;50929.490705092474;51370.743146284774;51528;51528.48471515312;51529.742351288005;53208.73395632997;55872.72063639656;56307;56940;56991.715041424526;16178.59553511148;16246.350145994027;16298.918505407397;16304.266308016167;16309.83690163107;13068.673283167996;13135.868641313657;13155.013373996988;13157.539486118132;13162;14605.78091328631;14714.852851471349;14852.777208341884;14901.850981490263;15011.174385408907;5622.212890195376;5627.831165065055;5686.2039314496005;5693.4875861172695;5803.970980145073;1099.9450027498592;1104.2325583719398;1109.2512554026162;1115.4311301236428;1124.3366413815888;25596.616050759254;25676.48647027049;25754.613680794802;25955.870220649154;26031.869840651056;1196.7726132034886;1209.8729633388543;1213.5509861351356;1217.573849152807;1218.8110842819376;13497.730045399234;13525.256110913797;13633.454661813616;13707.794383084261;13718.725625487634;290167;291313;292310;306821;310295;62620;62744.372556273855;63197.36802631915;63356.683216583624;63416.68291658512;1453.6801903581195;1518;1524.1921781455846;1525.7024880148265;1528.3198976455592;30935.69064309328;31149.221269468446;31297.217569560944;31393.8430307847;31931.840340798146;39339.409908851965;39699.40450893297;39736.40395394129;39805.20389592134;39829.2034159321;229234;229279;229353;230068;231134;36473.817630911675;36878.078048049014;36959;37070.25859482849;37146.62853371432;44413.55586444094;45686;45704.31443528416;46066.078678426915;46429;34042.65957340494;34293.48559771655;34353.312933740686;34483.65516344804;34985.25073746251;34389.65610343865;34421;34650.65349346474;34711.13222169466;34969.65030349664;39206.80396597999;40380.798096009334;40384.79807600943;40520.79739601401;40718.59281407267;33501.66498334985;33679.15802104967;33691;33981.15047123842;34155.82922085374;24929.501409971337;25815.838287277493;25993.480130397664;26380.472390552466;26522.204333870013 08:02:28 INFO - PID 3801 | |2;jquery.html;623.9594426362286;626.8714913442744;627.5199472403611;639.5203597302024;641.8138739765468;23447.882760586195;24055.759442405593;24128.879355603196;24255.151069712563;24483.387915302126;26582.33544161397;26804.59793103105;26882.865585672043;27026.864865675692;27029.324266893338;6608.867822643556;6752.696128674222;6764.188297404318;6808.7276508939585;6819.045333653293;6605.306442823507;6668.399844014038;6906.965465172667;6934.895976560356;6960.30396960305;6849.41779948705;6890.655467226644;6895.241523432418;6898.896516552256;6912.06687097243;6679.8330041749105;6850.212225594046;6852.862942741117;6858.142732158481;6897.137857767729;6381.202349706286;6439.83900402489;6465.288818229991;6482.448991835699;6492.675366231717;30999.845000775076;31506.52740208899;31538.684613153804;31672.208194795083;31723.36553268922;2318.629019356895;2336.5210131922913;2341.1454818991115;2345.5074434368803;2350.941226469352;20274.898625506925;21500.354989350344;21595.352139435843;21595.46011349713;21602.459938501506;2530.367408147963;2550.444229020296;2599.974000259992;2627.1855724725397;2630.7237740037212;140657;145981;149584;156892;157601;15422.46021389246;16669.24988375526;16840.83159168417;16852.57868553296;17104.80266381366;26349.868250658623;26502.33744156373;26513.867430663107;26534;26608.733912661013;10396.740081497872;10483.947580262049;10498.370097794004;10655.360678359324;10804.459777011118;9609.375390599589;9734.221262299;9765.365251258645;9814.705558833246;9902.108810207115;9891.802163956681;9998.200143988464;10266.691999240034;10343.741406464747;10380.740481488023;2939.691332410066;3003.489406800849;3023.7732170087334;3052.5115981442864;3104.6584875663657;1048.4757621189406;1052.9789404211872;1058.090042563395;1062.2086545523634;1072.1958531101673;21437.892810535846;22015.779842201693;22061.896905154677;22106.22628208005;22181.889090554767;1098.9560417583207;1106.3736307627773;1110.4836251143256;1112.7385064509833;1113.6881673131536;12161.209521381083;12416.192947458387;12502.687432814253;12508.437120329607;12547;560515;567876;575937;583546;597571;118976.40511797559;120155;121174.3941280288;124466;126666;1230.8153776933352;1237.0845574274972;1254.5985284708988;1255.1527718789598;1280.0335746511325;19020.524486887938;19157.904210479417;19310.8068919309;19446.222151113798;19509.39992924523;58088.83822323615;58588.9999999983;58927.410725892194;59963.40036599578;60297.09554356776;75334.24665753273;75630.62184689041;75686.62156689401;76087.61956190184;76366;15923.920380398024;15944.840551594336;15973.760393594337;16157.919210403872;16203.43287984962;24587.13945011916;24860.875695621406;25273;25607.743922560538;25752.871235643703;19956.800431995493;20064.899675502114;20129.6980545289;20180.697289540374;20376.18495260232;17476.475705728848;17479.300827966737;17907;17954.281828726704;17991.73012404789;20601.793982059986;20750.896245518677;20778;21087.367378978655;21087.8945605271;15208.695826083638;15902.363905443653;15915.681686365977;15985.520434386986;15995.360185592912;19663.60672786565;19745.70381444308;19838.50403739918;20180;20233.494162646053 08:02:28 INFO - PID 3801 | |3;mootools.html;1415.50457339931;1467.2003757951923;1479.7706355514886;1490.9030912990654;1494.1248732840288;14410.495632652859;14963.92518037411;17205.741913871287;17688.46934591961;17732.556686082855;17314.48056558302;17558.912205438988;17571.472855814314;17578.560535986606;17584;2843.8293702377923;2859.4852926473227;2898.4058268055105;2910.9417811643752;2926.648802143746;2866.913992580226;2903.3177203357195;2903.477374072666;2908.1711712162037;2912.7087291270914;2812.9718702813016;2857.0857325655797;2865.340971576539;2873.6264285642837;2875.2668069642214;2744.108164846423;2745.052956729935;2755.0908200293857;2760.4203117345382;2772.639556857616;2723.22388119387;2726.5910113482937;2742.067696983035;2744.053301610941;2744.40995186036;16706.164691765363;16896.239669214916;17007;17016.404425845038;17033.063181525136;8295.502269863828;8615.22462978335;8647;8652.307815374756;8655.221030107321;5597.44025597441;5752.539796816286;5809.419058094199;5851.356350801409;5873.383294754032;2024.7165396844453;2060.6702927531674;2113.17586141405;2154.2998525479125;2159.157928407922;31913.84043079793;32173;32173.51739723906;32200.355992880246;32266.83866580652;7563.7352692655495;7639.923600763921;7643.885341719879;7719.343855772322;7749.961250193825;20144.798552014294;20245.696314555295;20271.695924561143;20281.49296267605;20307.59384812325;7992.240737129963;8349;8352.707655232038;8353.415260931677;8360.122187170382;6320.5575609706875;7098.254683258287;7492.400607951351;7501.399888008947;7884;5476.3702174250475;5703.629264097904;5709.200711900337;5715.399883012307;5787;1696.8557672597722;1737.7914650241798;1744.546417931347;1745.991270043667;1752.6319472910577;964.8504481805331;969.2924165359186;971.7570607348163;984.837501812193;989.8861630912393;8573.09982451846;8659.437136586102;8678.739637810875;8760.474371537728;8787.648494060166;772.7372693284198;802.1136644008403;806.8830019647119;812.9471584346999;827.3670641958906;5299.761510732026;5949.8215053548465;5995.130706047598;6126.509879209652;6149.96925015372;24886.751132488804;26122.216333510027;26171.869140654177;26263.343416414744;26308;24366;25657.48685026289;25660;25713.614295785577;25819.35451613687;11766.58816941403;11814.881851181379;11830.290182589073;11875.346855922835;11893.643190704293;9566.56950437218;9776.315657903879;9799.363041402286;9817.410955342702;9860.211183105192;20962.790372096082;21009.264675736886;21131.26040588572;21225.044872981063;21369.14523419046;22149.1140354384;22243.555128897657;22378.77621223767;22391;22581.209657661904;12183.75632487363;12414.875851241371;12486.562970295996;12502.312372819219;12513.374331283218;15637.296321665324;15661.921690391931;15824.050556966618;15840.28718707638;15840.841591583936;12702.936485317514;12882.291473968648;13002.414891329723;13015.088943773844;13203.669908251986;12396.566120186111;12459.563915262923;12880.291583962597;12946.67633309137;13013.154144980546;10832.566697332019;10981.670549883516;11053;11104.111671066457;11156;8202.671893124209;8326.791830204293;8391.244787969112;8408.87386689188;8462.576871156294;8103.716369927024;8291.253787159185;8305.169483051646;8314.83370332578;8369.707060252862 08:02:28 INFO - PID 3801 | |4;prototype.html;543.6167501911153;560.8738033942362;580.474670423267;581.2501872584361;586.7183751799137;6073.939260607398;6119.3574674659185;6208.813735587928;6258.2490101187805;6327.240731112267;6148.784792532262;6202.224721909762;6245.687715614213;6267.717952692128;6292;5086.287919691246;5135.871603209922;5144.3826740791155;5146.536811686948;5148.665336753099;4871.415430148387;4960.379952505937;4987.226979818134;4988.700677959316;4998.975005124988;4893.11923853708;4926.507349265081;4927.926081108786;4969.279454479099;4977.900441991158;4930.753462326905;4933.827316043939;4961.875953101183;4980.078685443204;4987.102321582114;4522.773861306921;4541.659375546814;4553.203189441868;4553.590176884097;4556.498785133633;6129.50618147656;6279.905801412982;6292.402221788922;6298.4646305064125;6306.369363063703;5821.53427725781;5843.211166492554;5849.327327357366;5871.530277577784;5890.793822216245;6711.56374835639;6744.763933262312;6749.19009718832;6764.154480689914;6776.525643204977;5019.29729837823;5083.822066227664;5101.183810590288;5115.8745076083205;5117.130087885069;6882.520258144473;6887.449004079662;6933.618650974195;6936.549124306904;6948.845857784103;5192;5217.017533337307;5248.9737551312;5250.081235783722;5265;5283.947160528345;5325.4940780625775;5332.92000619991;5340.279062326536;5343.5457986071615;5802.21670074543;5804.158397032406;5806.9419305806405;5847.736851841592;5856.414358564195;6507.3167317431935;6673.699683514254;6787.898181527281;6791.490638202055;6794.995476334493;1767.2400867626786;1777.5822681669797;1805.4132406967788;1808.1953530678984;1816.5640246340784;1294.6116165150418;1299.9935000324938;1306.7974463957912;1307.9542216022585;1317.5915466205506;6089.604175728564;6090.847728806815;6118.388161183846;6120.571559990847;6121.826751503152;6672.866542669217;6834.384905358442;6835.418989385858;6841.726330946806;6845.14435695538;6107.175531303306;6137.465633591602;6190.102435146879;6203.441690247809;6232.532560058014;3570.107473131717;3594.1130906273893;3600;3619.9276014479565;3629.8366573504254;6955.234924158339;6975.476839237078;6995.825104372431;7029.332213439715;7034.261402552761;7038.120234970629;7039.19049309336;7061.788146355618;7063.223045464994;7100.822479438056;6816.931830681629;6817.5909445433435;6843.8973415399805;6910.827229319308;6940.340667636668;6732.225794033749;6740.494462915203;6798.966005169942;6810.591364517946;6827.590344579341;6698.2631910488835;6734.629595372302;6770.255271919987;6813.182418109858;6846.897296540656;7003.29967003316;7026.543274687129;7031.437485001085;7032.5077244592385;7069.505134640526;5167.914737905082;5174.896502069862;5197.688138711689;5199.324087868553;5199.584033277404;6483.870322593616;6673.866522669617;6705.2959439258175;6809.489288303298;6853.143357080365;6301.653409062362;6515.837104072247;6522.28254891952;6550.672466376757;6595.373439523238;6440.935590644033;6495.2855185928565;6506.3493650634555;6508.707108180238;6544.803655890331;6351.4756458450565;6446.387593178641;6457.935420645734;6464.41820236181;6465.838354041187;6583.934160658332;6652.968789837583;6659.900101498578;6686.765963191265;6704.631245281361;6426.325235850355;6447.387498187664;6480.740770369132;6507.446867016357;6525.834970039432 08:02:28 INFO - PID 3801 | |5;yui.html;953.7234202081397;956.6651671914826;987.4766373821873;991.72231775103;1001.49424540607;20983;21441.356759297225;21659;21698.457538561543;21723.456913577167;19514.219431222733;19792.10935507902;20617.896910515425;20720.171193152295;20723.378298651027;1057.9153667706564;1081.7674200046988;1081.7944590527775;1082.247837752762;1084.295208114724;1049.8110340138771;1065.3075500924422;1068.1561566362602;1068.40169505077;1092.9617463388784;1148.041385443156;1152.1877076660976;1152.8443660105863;1152.9481173347178;1153.0429743313073;1084;1142.2974870454693;1144.994275028628;1150.2293463379556;1150.4362862197547;813.8738495533202;817.4196320612373;817.5094943034192;821.0188824354898;821.8972628421448;20743.688844667344;21184.470388240265;21221.89389053045;21244.5751084979;21269.680954785537;22783.08867645292;23314.88342558293;23625.88187059071;23788;23839.284821455385;17129.828701712948;17348.219330130047;17533.824661753348;17569.648607027917;17620.118994050375;3927.8625248116464;3943.881683549498;3982.522097348337;3994.201159768058;3994.9201015979806;159871;160690;161058.19470902687;161588;165251;17067.658646827244;17101.230444630022;17106;17224.741628875578;17441.127943603024;34263.314733705185;34323.828380857936;34462.65537344645;34473.482897756556;34946.30107397889;9431.434113953048;9436;9456.05439456049;9488.478133702574;9537.761555961157;4664.696794708333;4790.808367665254;4792.329073929653;4832.9275060874115;4833.975830120898;6147.907781383283;6209.0996805462955;6226.968865155645;6229.1590635264565;6244.843878902973;1036.7149034015706;1062.4315990944808;1062.4740753327153;1078.379931539368;1081.086481922774;722.9096362954631;751.2975368030909;754.4831790223715;768;769.8575763483661;12526.68683282907;13294.933525332504;13395;13514.256715880721;13520.256385898674;698.3923986132097;698.9196242432083;702.8875379939287;710.435204012811;716.7706333973078;6110.663913484712;6122.6326420414025;6177.135201071854;6253.312135665074;6260.530460215502;147406;149863;152855;154767;155592;131477;132678.33660831634;133733;133856;136688;111397.44301278442;111444.44277778559;112206.43896780627;112516;114583.42708286406;11592.594259200887;11593.60876694802;11603.5358585659;11881.22772019816;11925.463354149259;57519.42480575308;58257.70871145617;58576.12135818051;58607.4139258619;58802.11796823137;72285.6385718068;72568.27431725615;72613;73098.63450682712;73526;16618.50144495667;17000.064996425317;17297.56756081108;17325.393611223546;17434.738478922573;17664.82335176683;17712.645747085244;17844.19701113427;17916.820831792036;17944.820551794313;18061.90969045199;18128.81871181324;18181.45455636333;18190.727139092658;18337.624678148924;16821.07484088387;17019.914900425418;17084.417887778996;17191.914040429718;17308.307667693654;16955.91522042382;17048.914755426144;17155.485335439957;17219.052952087757;17385.217665204844;11640.94179529097;11997.700057498632;11998.880011199777;12056.336901470504;12299.262044277371;12944.546940857024;13125.54060607874;13175.07774455779;13219.074664773374;13228.867711322764 08:02:28 INFO - PID 3801 | __end_tp_report 08:02:28 INFO - PID 3801 | __start_cc_report 08:02:28 INFO - PID 3801 | _x_x_mozilla_cycle_collect,292 08:02:28 INFO - PID 3801 | __end_cc_report 08:02:28 INFO - PID 3801 | __startTimestamp1506178948226__endTimestamp 08:02:28 INFO - PID 3801 | 08:02:28 INFO - PID 3801 | ------- Summary: start ------- 08:02:28 INFO - PID 3801 | Number of tests: 6 08:02:28 INFO - PID 3801 | 08:02:28 INFO - PID 3801 | [#0] dojo.html Cycles:165 Average:6309.05 Median:6595.14 stddev:896.30 (13.6%) stddev-sans-first:878.25 08:02:28 INFO - PID 3801 | Values: 3862.2 3921.7 3935.4 3935.7 3935.7 6284.4 6301.4 6372.2 6376.8 6466.7 6343.5 6351.3 6367.2 6476.9 6492.6 5671.5 5710.7 5723.2 5758.3 5778.2 169.8 5362.2 5762.9 5773.2 5796.4 5645.1 5682.3 5692.0 5707.0 5723.6 5689.7 5717.1 5775.0 5784.7 5792.2 5701.9 5766.2 5779.4 5781.6 5795.5 6326.7 6330.8 6356.2 6390.6 6432.4 6816.4 6900.2 6910.0 6924.7 6953.9 6859.9 6885.8 6972.5 6973.7 6976.9 6325.8 6358.9 6362.9 6441.2 6452.6 7127.7 7179.4 7186.5 7190.6 7197.3 6809.3 6809.9 6828.7 6866.8 6920.9 6850.5 6934.7 6964.0 6966.2 7033.4 6811.9 6877.0 6907.0 6908.0 6911.4 6820.9 6863.2 6864.8 6936.0 6943.0 4945.8 4979.8 4990.3 5054.7 5062.8 4494.0 4529.4 4553.7 4607.3 4620.1 6246.0 6295.0 6318.7 6328.2 6334.4 6891.1 6891.6 6894.6 6908.7 6989.2 6181.8 6202.8 6252.5 6296.4 6301.2 5499.1 5547.1 5565.1 5587.6 5604.2 6951.1 7043.0 7126.5 7134.9 7155.7 6766.7 6857.9 6859.7 6948.3 6955.9 7027.5 7045.0 7048.9 7053.3 7064.4 6810.9 6850.9 6888.4 6892.1 6905.7 6914.7 6916.9 6928.7 6990.7 7019.5 6617.9 6681.9 6685.7 6753.7 6784.8 6689.8 6702.5 6712.7 6714.4 6742.3 6502.2 6593.7 6680.2 6681.7 6684.5 6523.6 6580.2 6648.9 6655.5 6699.1 6546.0 6572.0 6589.0 6595.1 6601.3 08:02:28 INFO - PID 3801 | 08:02:28 INFO - PID 3801 | [#1] ext.html Cycles:180 Average:43017.99 Median:37108.44 stddev:65761.68 (177.2%) stddev-sans-first:65870.29 08:02:28 INFO - PID 3801 | Values: 948.7 952.8 979.7 1004.4 1009.1 42401.6 43455.1 43579.0 43944.3 44316.3 44669.6 44680.3 44829.0 44955.6 45042.8 8342.8 8438.9 8452.9 8463.6 8477.3 7964.4 7994.4 8003.2 8005.2 8010.2 8035.2 8047.7 8057.2 8057.6 8065.0 7982.0 8015.4 8017.5 8054.2 8063.4 8349.1 8442.9 8461.6 8467.9 8477.5 39417.0 39626.2 39795.4 40102.6 40153.8 3754.2 3799.1 3800.0 3800.6 3802.5 32472.5 32476.0 32513.8 32600.8 32609.0 5235.8 5403.1 5446.8 5466.4 5483.9 221714.0 222204.0 222704.0 222981.0 223943.0 50929.5 51370.7 51528.0 51528.5 51529.7 53208.7 55872.7 56307.0 56940.0 56991.7 16178.6 16246.4 16298.9 16304.3 16309.8 13068.7 13135.9 13155.0 13157.5 13162.0 14605.8 14714.9 14852.8 14901.9 15011.2 5622.2 5627.8 5686.2 5693.5 5804.0 1099.9 1104.2 1109.3 1115.4 1124.3 25596.6 25676.5 25754.6 25955.9 26031.9 1196.8 1209.9 1213.6 1217.6 1218.8 13497.7 13525.3 13633.5 13707.8 13718.7 290167.0 291313.0 292310.0 306821.0 310295.0 62620.0 62744.4 63197.4 63356.7 63416.7 1453.7 1518.0 1524.2 1525.7 1528.3 30935.7 31149.2 31297.2 31393.8 31931.8 39339.4 39699.4 39736.4 39805.2 39829.2 229234.0 229279.0 229353.0 230068.0 231134.0 36473.8 36878.1 36959.0 37070.3 37146.6 44413.6 45686.0 45704.3 46066.1 46429.0 34042.7 34293.5 34353.3 34483.7 34985.3 34389.7 34421.0 34650.7 34711.1 34969.7 39206.8 40380.8 40384.8 40520.8 40718.6 33501.7 33679.2 33691.0 33981.2 34155.8 24929.5 25815.8 25993.5 26380.5 26522.2 08:02:28 INFO - PID 3801 | 08:02:28 INFO - PID 3801 | [#2] jquery.html Cycles:180 Average:38805.92 Median:12894.51 stddev:96557.64 (748.8%) stddev-sans-first:96785.96 08:02:28 INFO - PID 3801 | Values: 624.0 626.9 627.5 639.5 641.8 23447.9 24055.8 24128.9 24255.2 24483.4 26582.3 26804.6 26882.9 27026.9 27029.3 6608.9 6752.7 6764.2 6808.7 6819.0 6605.3 6668.4 6907.0 6934.9 6960.3 6849.4 6890.7 6895.2 6898.9 6912.1 6679.8 6850.2 6852.9 6858.1 6897.1 6381.2 6439.8 6465.3 6482.4 6492.7 30999.8 31506.5 31538.7 31672.2 31723.4 2318.6 2336.5 2341.1 2345.5 2350.9 20274.9 21500.4 21595.4 21595.5 21602.5 2530.4 2550.4 2600.0 2627.2 2630.7 140657.0 145981.0 149584.0 156892.0 157601.0 15422.5 16669.2 16840.8 16852.6 17104.8 26349.9 26502.3 26513.9 26534.0 26608.7 10396.7 10483.9 10498.4 10655.4 10804.5 9609.4 9734.2 9765.4 9814.7 9902.1 9891.8 9998.2 10266.7 10343.7 10380.7 2939.7 3003.5 3023.8 3052.5 3104.7 1048.5 1053.0 1058.1 1062.2 1072.2 21437.9 22015.8 22061.9 22106.2 22181.9 1099.0 1106.4 1110.5 1112.7 1113.7 12161.2 12416.2 12502.7 12508.4 12547.0 560515.0 567876.0 575937.0 583546.0 597571.0 118976.4 120155.0 121174.4 124466.0 126666.0 1230.8 1237.1 1254.6 1255.2 1280.0 19020.5 19157.9 19310.8 19446.2 19509.4 58088.8 58589.0 58927.4 59963.4 60297.1 75334.2 75630.6 75686.6 76087.6 76366.0 15923.9 15944.8 15973.8 16157.9 16203.4 24587.1 24860.9 25273.0 25607.7 25752.9 19956.8 20064.9 20129.7 20180.7 20376.2 17476.5 17479.3 17907.0 17954.3 17991.7 20601.8 20750.9 20778.0 21087.4 21087.9 15208.7 15902.4 15915.7 15985.5 15995.4 19663.6 19745.7 19838.5 20180.0 20233.5 08:02:28 INFO - PID 3801 | 08:02:28 INFO - PID 3801 | [#3] mootools.html Cycles:180 Average:10564.60 Median:2744.73 stddev:7958.57 (290.0%) stddev-sans-first:7951.21 08:02:28 INFO - PID 3801 | Values: 1415.5 1467.2 1479.8 1490.9 1494.1 14410.5 14963.9 17205.7 17688.5 17732.6 17314.5 17558.9 17571.5 17578.6 17584.0 2843.8 2859.5 2898.4 2910.9 2926.6 2866.9 2903.3 2903.5 2908.2 2912.7 2813.0 2857.1 2865.3 2873.6 2875.3 2744.1 2745.1 2755.1 2760.4 2772.6 2723.2 2726.6 2742.1 2744.1 2744.4 16706.2 16896.2 17007.0 17016.4 17033.1 8295.5 8615.2 8647.0 8652.3 8655.2 5597.4 5752.5 5809.4 5851.4 5873.4 2024.7 2060.7 2113.2 2154.3 2159.2 31913.8 32173.0 32173.5 32200.4 32266.8 7563.7 7639.9 7643.9 7719.3 7750.0 20144.8 20245.7 20271.7 20281.5 20307.6 7992.2 8349.0 8352.7 8353.4 8360.1 6320.6 7098.3 7492.4 7501.4 7884.0 5476.4 5703.6 5709.2 5715.4 5787.0 1696.9 1737.8 1744.5 1746.0 1752.6 964.9 969.3 971.8 984.8 989.9 8573.1 8659.4 8678.7 8760.5 8787.6 772.7 802.1 806.9 812.9 827.4 5299.8 5949.8 5995.1 6126.5 6150.0 24886.8 26122.2 26171.9 26263.3 26308.0 24366.0 25657.5 25660.0 25713.6 25819.4 11766.6 11814.9 11830.3 11875.3 11893.6 9566.6 9776.3 9799.4 9817.4 9860.2 20962.8 21009.3 21131.3 21225.0 21369.1 22149.1 22243.6 22378.8 22391.0 22581.2 12183.8 12414.9 12486.6 12502.3 12513.4 15637.3 15661.9 15824.1 15840.3 15840.8 12702.9 12882.3 13002.4 13015.1 13203.7 12396.6 12459.6 12880.3 12946.7 13013.2 10832.6 10981.7 11053.0 11104.1 11156.0 8202.7 8326.8 8391.2 8408.9 8462.6 8103.7 8291.3 8305.2 8314.8 8369.7 08:02:28 INFO - PID 3801 | 08:02:28 INFO - PID 3801 | [#4] prototype.html Cycles:180 Average:5646.30 Median:6239.11 stddev:1576.94 (25.3%) stddev-sans-first:1534.15 08:02:28 INFO - PID 3801 | Values: 543.6 560.9 580.5 581.3 586.7 6073.9 6119.4 6208.8 6258.2 6327.2 6148.8 6202.2 6245.7 6267.7 6292.0 5086.3 5135.9 5144.4 5146.5 5148.7 4871.4 4960.4 4987.2 4988.7 4999.0 4893.1 4926.5 4927.9 4969.3 4977.9 4930.8 4933.8 4961.9 4980.1 4987.1 4522.8 4541.7 4553.2 4553.6 4556.5 6129.5 6279.9 6292.4 6298.5 6306.4 5821.5 5843.2 5849.3 5871.5 5890.8 6711.6 6744.8 6749.2 6764.2 6776.5 5019.3 5083.8 5101.2 5115.9 5117.1 6882.5 6887.4 6933.6 6936.5 6948.8 5192.0 5217.0 5249.0 5250.1 5265.0 5283.9 5325.5 5332.9 5340.3 5343.5 5802.2 5804.2 5806.9 5847.7 5856.4 6507.3 6673.7 6787.9 6791.5 6795.0 1767.2 1777.6 1805.4 1808.2 1816.6 1294.6 1300.0 1306.8 1308.0 1317.6 6089.6 6090.8 6118.4 6120.6 6121.8 6672.9 6834.4 6835.4 6841.7 6845.1 6107.2 6137.5 6190.1 6203.4 6232.5 3570.1 3594.1 3600.0 3619.9 3629.8 6955.2 6975.5 6995.8 7029.3 7034.3 7038.1 7039.2 7061.8 7063.2 7100.8 6816.9 6817.6 6843.9 6910.8 6940.3 6732.2 6740.5 6799.0 6810.6 6827.6 6698.3 6734.6 6770.3 6813.2 6846.9 7003.3 7026.5 7031.4 7032.5 7069.5 5167.9 5174.9 5197.7 5199.3 5199.6 6483.9 6673.9 6705.3 6809.5 6853.1 6301.7 6515.8 6522.3 6550.7 6595.4 6440.9 6495.3 6506.3 6508.7 6544.8 6351.5 6446.4 6457.9 6464.4 6465.8 6583.9 6653.0 6659.9 6686.8 6704.6 6426.3 6447.4 6480.7 6507.4 6525.8 08:02:28 INFO - PID 3801 | 08:02:28 INFO - PID 3801 | [#5] yui.html Cycles:180 Average:28428.40 Median:17642.47 stddev:42758.64 (242.4%) stddev-sans-first:42828.83 08:02:28 INFO - PID 3801 | Values: 953.7 956.7 987.5 991.7 1001.5 20983.0 21441.4 21659.0 21698.5 21723.5 19514.2 19792.1 20617.9 20720.2 20723.4 1057.9 1081.8 1081.8 1082.2 1084.3 1049.8 1065.3 1068.2 1068.4 1093.0 1148.0 1152.2 1152.8 1152.9 1153.0 1084.0 1142.3 1145.0 1150.2 1150.4 813.9 817.4 817.5 821.0 821.9 20743.7 21184.5 21221.9 21244.6 21269.7 22783.1 23314.9 23625.9 23788.0 23839.3 17129.8 17348.2 17533.8 17569.6 17620.1 3927.9 3943.9 3982.5 3994.2 3994.9 159871.0 160690.0 161058.2 161588.0 165251.0 17067.7 17101.2 17106.0 17224.7 17441.1 34263.3 34323.8 34462.7 34473.5 34946.3 9431.4 9436.0 9456.1 9488.5 9537.8 4664.7 4790.8 4792.3 4832.9 4834.0 6147.9 6209.1 6227.0 6229.2 6244.8 1036.7 1062.4 1062.5 1078.4 1081.1 722.9 751.3 754.5 768.0 769.9 12526.7 13294.9 13395.0 13514.3 13520.3 698.4 698.9 702.9 710.4 716.8 6110.7 6122.6 6177.1 6253.3 6260.5 147406.0 149863.0 152855.0 154767.0 155592.0 131477.0 132678.3 133733.0 133856.0 136688.0 111397.4 111444.4 112206.4 112516.0 114583.4 11592.6 11593.6 11603.5 11881.2 11925.5 57519.4 58257.7 58576.1 58607.4 58802.1 72285.6 72568.3 72613.0 73098.6 73526.0 16618.5 17000.1 17297.6 17325.4 17434.7 17664.8 17712.6 17844.2 17916.8 17944.8 18061.9 18128.8 18181.5 18190.7 18337.6 16821.1 17019.9 17084.4 17191.9 17308.3 16955.9 17048.9 17155.5 17219.1 17385.2 11640.9 11997.7 11998.9 12056.3 12299.3 12944.5 13125.5 13175.1 13219.1 13228.9 08:02:28 INFO - PID 3801 | -------- Summary: end -------- 08:02:28 INFO - PID 3801 | 08:02:28 INFO - TEST-INFO | 3801: exit 0 08:02:28 INFO - TEST-OK | dromaeo_css | took 1109783ms 08:02:28 INFO - TEST-START | kraken 08:02:28 INFO - Initialising browser for kraken test... 08:02:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33811/getInfo.html -profile /tmp/tmpKPAku2/profile 08:02:28 INFO - TEST-INFO | started process 4176 (/builds/slave/test/build/application/firefox/firefox http://localhost:33811/getInfo.html) 08:02:33 INFO - TEST-INFO | 4176: exit 0 08:02:33 INFO - Browser initialized. 08:02:33 INFO - Running cycle 1/1 for kraken test... 08:02:33 INFO - Using env: {'DISPLAY': ':0', 08:02:33 INFO - 'HOME': '/home/cltbld', 08:02:33 INFO - 'JSGC_DISABLE_POISONING': '1', 08:02:34 INFO - 'LANG': 'en_US.UTF-8', 08:02:34 INFO - 'LANGUAGE': 'en_US:en', 08:02:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:02:34 INFO - 'LOGNAME': 'cltbld', 08:02:34 INFO - 'MAIL': '/var/mail/cltbld', 08:02:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:02:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:02:34 INFO - 'MOZ_CRASHREPORTER': '1', 08:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:02:34 INFO - 'MOZ_NO_REMOTE': '1', 08:02:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:34 INFO - 'NO_EM_RESTART': '1', 08:02:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:34 INFO - 'PWD': '/builds/slave/test', 08:02:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:02:34 INFO - 'RUST_BACKTRACE': 'full', 08:02:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:02:34 INFO - 'SHELL': '/bin/bash', 08:02:34 INFO - 'SHLVL': '1', 08:02:34 INFO - 'TERM': 'linux', 08:02:34 INFO - 'TMOUT': '86400', 08:02:34 INFO - 'USER': 'cltbld', 08:02:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779', 08:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:34 INFO - '_': '/tools/buildbot/bin/python'} 08:02:34 INFO - TEST-INFO | started process 4415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKPAku2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:34 INFO - PID 4415 | 08:02:34 INFO - PID 4415 | (/builds/slave/test/build/application/firefox/firefox:4464): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:02:34 INFO - PID 4415 | 08:02:45 INFO - PID 4415 | RSS: Main: 144822272 08:02:45 INFO - PID 4415 | 08:02:47 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33811/tests/kraken/driver.html?testName=audio-beat-detection) 08:02:48 INFO - PID 4415 | RSS: Main: 151396352 08:02:48 INFO - PID 4415 | 08:02:51 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33811/tests/kraken/driver.html?testName=audio-dft) 08:02:51 INFO - PID 4415 | RSS: Main: 151560192 08:02:51 INFO - PID 4415 | 08:02:54 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33811/tests/kraken/driver.html?testName=audio-fft) 08:02:55 INFO - PID 4415 | RSS: Main: 147869696 08:02:55 INFO - PID 4415 | 08:02:57 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33811/tests/kraken/driver.html?testName=audio-oscillator) 08:02:57 INFO - PID 4415 | RSS: Main: 149471232 08:02:57 INFO - PID 4415 | 08:02:59 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33811/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:03:00 INFO - PID 4415 | RSS: Main: 149258240 08:03:00 INFO - PID 4415 | 08:03:03 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33811/tests/kraken/driver.html?testName=imaging-darkroom) 08:03:04 INFO - PID 4415 | RSS: Main: 149082112 08:03:04 INFO - PID 4415 | 08:03:07 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33811/tests/kraken/driver.html?testName=imaging-desaturate) 08:03:08 INFO - PID 4415 | RSS: Main: 149590016 08:03:08 INFO - PID 4415 | 08:03:11 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33811/tests/kraken/driver.html?testName=json-parse-financial) 08:03:11 INFO - PID 4415 | RSS: Main: 151523328 08:03:11 INFO - PID 4415 | 08:03:13 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33811/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:03:13 INFO - PID 4415 | RSS: Main: 151400448 08:03:13 INFO - PID 4415 | 08:03:15 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:03:16 INFO - PID 4415 | RSS: Main: 151273472 08:03:16 INFO - PID 4415 | 08:03:18 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:03:18 INFO - PID 4415 | RSS: Main: 148447232 08:03:18 INFO - PID 4415 | 08:03:21 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:03:21 INFO - PID 4415 | RSS: Main: 147984384 08:03:21 INFO - PID 4415 | 08:03:24 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:03:25 INFO - PID 4415 | RSS: Main: 149024768 08:03:25 INFO - PID 4415 | 08:03:26 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33811/tests/kraken/driver.html?testName=ai-astar) 08:03:27 INFO - PID 4415 | RSS: Main: 150515712 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | __start_tp_report 08:03:27 INFO - PID 4415 | _x_x_mozilla_page_load 08:03:27 INFO - PID 4415 | _x_x_mozilla_page_load_details 08:03:27 INFO - PID 4415 | |i|pagename|runs| 08:03:27 INFO - PID 4415 | |0;ai-astar;106;104;105;105;105;99;108;104;104;106 08:03:27 INFO - PID 4415 | |1;audio-beat-detection;114;112;113;115;116;112;115;114;111;112 08:03:27 INFO - PID 4415 | |2;audio-dft;163;163;163;162;163;162;162;162;164;166 08:03:27 INFO - PID 4415 | |3;audio-fft;73;74;73;73;85;81;73;74;76;74 08:03:27 INFO - PID 4415 | |4;audio-oscillator;80;86;79;78;78;76;77;78;128;78 08:03:27 INFO - PID 4415 | |5;imaging-gaussian-blur;115;115;114;114;116;114;110;115;114;116 08:03:27 INFO - PID 4415 | |6;imaging-darkroom;149;149;149;150;149;150;149;148;149;149 08:03:27 INFO - PID 4415 | |7;imaging-desaturate;99;95;94;94;98;94;95;94;95;95 08:03:27 INFO - PID 4415 | |8;json-parse-financial;44;44;44;44;45;43;44;46;47;43 08:03:27 INFO - PID 4415 | |9;json-stringify-tinderbox;40;39;39;40;40;39;40;39;39;40 08:03:27 INFO - PID 4415 | |10;stanford-crypto-aes;71;70;76;72;73;76;70;70;69;71 08:03:27 INFO - PID 4415 | |11;stanford-crypto-ccm;106;105;106;111;110;109;108;106;115;111 08:03:27 INFO - PID 4415 | |12;stanford-crypto-pbkdf2;153;150;149;151;157;163;148;152;153;151 08:03:27 INFO - PID 4415 | |13;stanford-crypto-sha256-iterative;67;64;57;61;62;61;59;66;60;58 08:03:27 INFO - PID 4415 | __end_tp_report 08:03:27 INFO - PID 4415 | __start_cc_report 08:03:27 INFO - PID 4415 | _x_x_mozilla_cycle_collect,712 08:03:27 INFO - PID 4415 | __end_cc_report 08:03:27 INFO - PID 4415 | __startTimestamp1506179007194__endTimestamp 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | ------- Summary: start ------- 08:03:27 INFO - PID 4415 | Number of tests: 14 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#0] ai-astar Cycles:10 Average:104.60 Median:105.50 stddev:2.32 (2.2%) stddev-sans-first:2.40 08:03:27 INFO - PID 4415 | Values: 106.0 104.0 105.0 105.0 105.0 99.0 108.0 104.0 104.0 106.0 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#1] audio-beat-detection Cycles:10 Average:113.40 Median:114.00 stddev:1.65 (1.4%) stddev-sans-first:1.73 08:03:27 INFO - PID 4415 | Values: 114.0 112.0 113.0 115.0 116.0 112.0 115.0 114.0 111.0 112.0 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 08:03:27 INFO - PID 4415 | Values: 163.0 163.0 163.0 162.0 163.0 162.0 162.0 162.0 164.0 166.0 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#3] audio-fft Cycles:10 Average:75.60 Median:74.00 stddev:4.12 (5.6%) stddev-sans-first:4.26 08:03:27 INFO - PID 4415 | Values: 73.0 74.0 73.0 73.0 85.0 81.0 73.0 74.0 76.0 74.0 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#4] audio-oscillator Cycles:10 Average:83.80 Median:78.00 stddev:15.77 (20.2%) stddev-sans-first:16.66 08:03:27 INFO - PID 4415 | Values: 80.0 86.0 79.0 78.0 78.0 76.0 77.0 78.0 128.0 78.0 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:115.00 stddev:1.70 (1.5%) stddev-sans-first:1.79 08:03:27 INFO - PID 4415 | Values: 115.0 115.0 114.0 114.0 116.0 114.0 110.0 115.0 114.0 116.0 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:03:27 INFO - PID 4415 | Values: 149.0 149.0 149.0 150.0 149.0 150.0 149.0 148.0 149.0 149.0 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.77 (1.9%) stddev-sans-first:1.27 08:03:27 INFO - PID 4415 | Values: 99.0 95.0 94.0 94.0 98.0 94.0 95.0 94.0 95.0 95.0 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#8] json-parse-financial Cycles:10 Average:44.40 Median:44.00 stddev:1.26 (2.9%) stddev-sans-first:1.33 08:03:27 INFO - PID 4415 | Values: 44.0 44.0 44.0 44.0 45.0 43.0 44.0 46.0 47.0 43.0 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#9] json-stringify-tinderbox Cycles:10 Average:39.50 Median:40.00 stddev:0.53 (1.3%) stddev-sans-first:0.53 08:03:27 INFO - PID 4415 | Values: 40.0 39.0 39.0 40.0 40.0 39.0 40.0 39.0 39.0 40.0 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#10] stanford-crypto-aes Cycles:10 Average:71.80 Median:71.50 stddev:2.49 (3.5%) stddev-sans-first:2.62 08:03:27 INFO - PID 4415 | Values: 71.0 70.0 76.0 72.0 73.0 76.0 70.0 70.0 69.0 71.0 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#11] stanford-crypto-ccm Cycles:10 Average:108.70 Median:109.50 stddev:3.13 (2.9%) stddev-sans-first:3.16 08:03:27 INFO - PID 4415 | Values: 106.0 105.0 106.0 111.0 110.0 109.0 108.0 106.0 115.0 111.0 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.70 Median:152.50 stddev:4.40 (2.9%) stddev-sans-first:4.66 08:03:27 INFO - PID 4415 | Values: 153.0 150.0 149.0 151.0 157.0 163.0 148.0 152.0 153.0 151.0 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.50 stddev:3.31 (5.4%) stddev-sans-first:2.85 08:03:27 INFO - PID 4415 | Values: 67.0 64.0 57.0 61.0 62.0 61.0 59.0 66.0 60.0 58.0 08:03:27 INFO - PID 4415 | -------- Summary: end -------- 08:03:27 INFO - PID 4415 | 08:03:27 INFO - PID 4415 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:03:27 INFO - TEST-INFO | 4415: exit 0 08:03:27 INFO - TEST-OK | kraken | took 59001ms 08:03:27 INFO - SUITE-END | took 1168s 08:03:28 INFO - Completed test suite (00:19:29) 08:03:28 INFO - javascript benchmark 08:03:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9105.516437505357, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3862.2468618619364, 3921.725479216456, 3935.3506671399223, 3935.7048221383393, 3935.724499285049, 6284.434400903918, 6301.401366870152, 6372.1716176897, 6376.776812811552, 6466.676666166696, 6343.524235682331, 6351.301356850743, 6367.235931688192, 6476.935230647692, 6492.5779824311385, 5671.546276297907, 5710.685912274823, 5723.170140329649, 5758.280214973129, 5778.191053252548, 169.83481686428232, 5362.23781616285, 5762.855928601797, 5773.220615216934, 5796.420357964191, 5645.096784514479, 5682.26130603021, 5692.032354499704, 5706.971465142668, 5723.627964182315, 5689.715514224272, 5717.056685646863, 5775.0, 5784.68184249866, 5792.247007888989, 5701.942980570183, 5766.163906233614, 5779.393163717833, 5781.624194427349, 5795.478406943395, 6326.65203413812, 6330.778422755227, 6356.2054743157105, 6390.584612000205, 6432.388923052303, 6816.386525212705, 6900.171979362509, 6909.965450172767, 6924.688389022455, 6953.89569156463, 6859.862802743967, 6885.827854303632, 6972.51192416531, 6973.721051157948, 6976.930230697679, 6325.841853953688, 6358.904616430757, 6362.936370636281, 6441.227052753653, 6452.612843229421, 7127.7148914042855, 7179.389751871045, 7186.532875363085, 7190.640467976685, 7197.280271972761, 6809.250982391933, 6809.93190068093, 6828.692708828015, 6866.793996180123, 6920.930790692129, 6850.520463567602, 6934.687939042755, 6964.0, 6966.233714291424, 7033.437325013987, 6811.931880681229, 6876.965615171992, 6907.0, 6907.998340240738, 6911.447084233249, 6820.897686534706, 6863.245043045261, 6864.759733409307, 6935.965320173367, 6942.965285173542, 4945.7774400152075, 4979.800807967641, 4990.30135780991, 5054.7472626368535, 5062.848114556569, 4493.977530112394, 4529.365888775574, 4553.726776393427, 4607.262837945913, 4620.0990806793025, 6246.0, 6294.968525157345, 6318.7472501100365, 6328.17733694626, 6334.366563343721, 6891.104156459628, 6891.620960847101, 6894.586324820527, 6908.6545672716165, 6989.161300643854, 6181.752729890754, 6202.813915582449, 6252.531060170505, 6296.401841825019, 6301.180846490019, 5499.120140777536, 5547.057000309957, 5565.109582466866, 5587.580931430159, 5604.187392828017, 6951.131108611424, 7043.0, 7126.501144919909, 7134.857302853914, 7155.713771449188, 6766.729330826712, 6857.897131543131, 6859.725610975505, 6948.27043160471, 6955.8608827822145, 7027.472939529658, 7044.964775176091, 7048.929510705032, 7053.294670532906, 7064.434845212268, 6810.9318906810295, 6850.9314906850295, 6888.380045795902, 6892.104026476526, 6905.723771049102, 6914.654267286716, 6916.896246556205, 6928.7228510859, 6990.685419156049, 7019.508634395544, 6617.900731489128, 6681.866362672622, 6685.699143538455, 6753.729850806109, 6784.76253331131, 6689.76585819494, 6702.530822842549, 6712.6979285931275, 6714.429273511806, 6742.258351581224, 6502.219733631805, 6593.736250549924, 6680.164979377578, 6681.732730690718, 6684.532082754161, 6523.608583484816, 6580.177477815273, 6648.9002664961035, 6655.467562594884, 6699.129113215251, 6545.967270163619, 6572.0, 6588.967055164693, 6595.142631457879, 6601.306862779339], "value": 6249.553902771505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [948.6869333120067, 952.8189643967647, 979.6767066867932, 1004.4073996342162, 1009.0766948242359, 42401.575984240146, 43455.13089738207, 43579.0, 43944.34083488742, 44316.3352549712, 44669.55330446694, 44680.3297950531, 44829.0, 44955.550444495544, 45042.77478612602, 8342.791430214247, 8438.873416898752, 8452.915470845275, 8463.619137138812, 8477.279431248351, 7964.362850971937, 7994.360451163922, 8003.239692229258, 8005.159458256887, 8010.1589333120055, 8035.196480351977, 8047.678092876278, 8057.194280571955, 8057.597120143999, 8065.0321961364425, 7982.042154941415, 8015.358771298283, 8017.478863873829, 8054.194580541957, 8063.395245356622, 8349.081601023883, 8442.873356899652, 8461.57692115398, 8467.872981905277, 8477.491350518989, 39417.0, 39626.20747585032, 39795.40306895399, 40102.59897401018, 40153.79923100395, 3754.1740817020213, 3799.1072098056934, 3800.0309920969976, 3800.6009369016133, 3802.4676545283405, 32472.512912306334, 32476.0, 32513.83743081293, 32600.83699581487, 32609.0, 5235.842924712265, 5403.135498320289, 5446.83659490212, 5466.371367292772, 5483.890322193533, 221714.0, 222204.0, 222704.0, 222981.0, 223942.99999999837, 50929.490705092474, 51370.743146284774, 51528.0, 51528.48471515312, 51529.742351288005, 53208.73395632997, 55872.72063639656, 56307.0, 56940.0, 56991.715041424526, 16178.59553511148, 16246.350145994027, 16298.918505407397, 16304.266308016167, 16309.83690163107, 13068.673283167996, 13135.868641313657, 13155.013373996988, 13157.539486118132, 13162.0, 14605.78091328631, 14714.852851471349, 14852.777208341884, 14901.850981490263, 15011.174385408907, 5622.212890195376, 5627.831165065055, 5686.2039314496005, 5693.4875861172695, 5803.970980145073, 1099.9450027498592, 1104.2325583719398, 1109.2512554026162, 1115.4311301236428, 1124.3366413815888, 25596.616050759254, 25676.48647027049, 25754.613680794802, 25955.870220649154, 26031.869840651056, 1196.7726132034886, 1209.8729633388543, 1213.5509861351356, 1217.573849152807, 1218.8110842819376, 13497.730045399234, 13525.256110913797, 13633.454661813616, 13707.794383084261, 13718.725625487634, 290167.0, 291313.0, 292310.0, 306821.0, 310295.0, 62620.0, 62744.372556273855, 63197.36802631915, 63356.683216583624, 63416.68291658512, 1453.6801903581195, 1518.0, 1524.1921781455846, 1525.7024880148265, 1528.3198976455592, 30935.69064309328, 31149.221269468446, 31297.217569560944, 31393.8430307847, 31931.840340798146, 39339.409908851965, 39699.40450893297, 39736.40395394129, 39805.20389592134, 39829.2034159321, 229234.0, 229279.0, 229353.0, 230068.0, 231134.0, 36473.817630911675, 36878.078048049014, 36959.0, 37070.25859482849, 37146.62853371432, 44413.55586444094, 45686.0, 45704.31443528416, 46066.078678426915, 46429.0, 34042.65957340494, 34293.48559771655, 34353.312933740686, 34483.65516344804, 34985.25073746251, 34389.65610343865, 34421.0, 34650.65349346474, 34711.13222169466, 34969.65030349664, 39206.80396597999, 40380.798096009334, 40384.79807600943, 40520.79739601401, 40718.59281407267, 33501.66498334985, 33679.15802104967, 33691.0, 33981.15047123842, 34155.82922085374, 24929.501409971337, 25815.838287277493, 25993.480130397664, 26380.472390552466, 26522.204333870013], "value": 18678.19178890623, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.9594426362286, 626.8714913442744, 627.5199472403611, 639.5203597302024, 641.8138739765468, 23447.882760586195, 24055.759442405593, 24128.879355603196, 24255.151069712563, 24483.387915302126, 26582.33544161397, 26804.59793103105, 26882.865585672043, 27026.864865675692, 27029.324266893338, 6608.867822643556, 6752.696128674222, 6764.188297404318, 6808.7276508939585, 6819.045333653293, 6605.306442823507, 6668.399844014038, 6906.965465172667, 6934.895976560356, 6960.30396960305, 6849.41779948705, 6890.655467226644, 6895.241523432418, 6898.896516552256, 6912.06687097243, 6679.8330041749105, 6850.212225594046, 6852.862942741117, 6858.142732158481, 6897.137857767729, 6381.202349706286, 6439.83900402489, 6465.288818229991, 6482.448991835699, 6492.675366231717, 30999.845000775076, 31506.52740208899, 31538.684613153804, 31672.208194795083, 31723.36553268922, 2318.629019356895, 2336.5210131922913, 2341.1454818991115, 2345.5074434368803, 2350.941226469352, 20274.898625506925, 21500.354989350344, 21595.352139435843, 21595.46011349713, 21602.459938501506, 2530.367408147963, 2550.444229020296, 2599.974000259992, 2627.1855724725397, 2630.7237740037212, 140657.0, 145981.0, 149584.0, 156892.0, 157601.0, 15422.46021389246, 16669.24988375526, 16840.83159168417, 16852.57868553296, 17104.80266381366, 26349.868250658623, 26502.33744156373, 26513.867430663107, 26534.0, 26608.733912661013, 10396.740081497872, 10483.947580262049, 10498.370097794004, 10655.360678359324, 10804.459777011118, 9609.375390599589, 9734.221262299, 9765.365251258645, 9814.705558833246, 9902.108810207115, 9891.802163956681, 9998.200143988464, 10266.691999240034, 10343.741406464747, 10380.740481488023, 2939.691332410066, 3003.489406800849, 3023.7732170087334, 3052.5115981442864, 3104.6584875663657, 1048.4757621189406, 1052.9789404211872, 1058.090042563395, 1062.2086545523634, 1072.1958531101673, 21437.892810535846, 22015.779842201693, 22061.896905154677, 22106.22628208005, 22181.889090554767, 1098.9560417583207, 1106.3736307627773, 1110.4836251143256, 1112.7385064509833, 1113.6881673131536, 12161.209521381083, 12416.192947458387, 12502.687432814253, 12508.437120329607, 12547.0, 560515.0, 567876.0, 575937.0, 583546.0, 597571.0, 118976.40511797559, 120155.0, 121174.3941280288, 124466.0, 126666.0, 1230.8153776933352, 1237.0845574274972, 1254.5985284708988, 1255.1527718789598, 1280.0335746511325, 19020.524486887938, 19157.904210479417, 19310.8068919309, 19446.222151113798, 19509.39992924523, 58088.83822323615, 58588.9999999983, 58927.410725892194, 59963.40036599578, 60297.09554356776, 75334.24665753273, 75630.62184689041, 75686.62156689401, 76087.61956190184, 76366.0, 15923.920380398024, 15944.840551594336, 15973.760393594337, 16157.919210403872, 16203.43287984962, 24587.13945011916, 24860.875695621406, 25273.0, 25607.743922560538, 25752.871235643703, 19956.800431995493, 20064.899675502114, 20129.6980545289, 20180.697289540374, 20376.18495260232, 17476.475705728848, 17479.300827966737, 17907.0, 17954.281828726704, 17991.73012404789, 20601.793982059986, 20750.896245518677, 20778.0, 21087.367378978655, 21087.8945605271, 15208.695826083638, 15902.363905443653, 15915.681686365977, 15985.520434386986, 15995.360185592912, 19663.60672786565, 19745.70381444308, 19838.50403739918, 20180.0, 20233.494162646053], "value": 12961.173112659082, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.50457339931, 1467.2003757951923, 1479.7706355514886, 1490.9030912990654, 1494.1248732840288, 14410.495632652859, 14963.92518037411, 17205.741913871287, 17688.46934591961, 17732.556686082855, 17314.48056558302, 17558.912205438988, 17571.472855814314, 17578.560535986606, 17584.0, 2843.8293702377923, 2859.4852926473227, 2898.4058268055105, 2910.9417811643752, 2926.648802143746, 2866.913992580226, 2903.3177203357195, 2903.477374072666, 2908.1711712162037, 2912.7087291270914, 2812.9718702813016, 2857.0857325655797, 2865.340971576539, 2873.6264285642837, 2875.2668069642214, 2744.108164846423, 2745.052956729935, 2755.0908200293857, 2760.4203117345382, 2772.639556857616, 2723.22388119387, 2726.5910113482937, 2742.067696983035, 2744.053301610941, 2744.40995186036, 16706.164691765363, 16896.239669214916, 17007.0, 17016.404425845038, 17033.063181525136, 8295.502269863828, 8615.22462978335, 8647.0, 8652.307815374756, 8655.221030107321, 5597.44025597441, 5752.539796816286, 5809.419058094199, 5851.356350801409, 5873.383294754032, 2024.7165396844453, 2060.6702927531674, 2113.17586141405, 2154.2998525479125, 2159.157928407922, 31913.84043079793, 32173.0, 32173.51739723906, 32200.355992880246, 32266.83866580652, 7563.7352692655495, 7639.923600763921, 7643.885341719879, 7719.343855772322, 7749.961250193825, 20144.798552014294, 20245.696314555295, 20271.695924561143, 20281.49296267605, 20307.59384812325, 7992.240737129963, 8349.0, 8352.707655232038, 8353.415260931677, 8360.122187170382, 6320.5575609706875, 7098.254683258287, 7492.400607951351, 7501.399888008947, 7884.0, 5476.3702174250475, 5703.629264097904, 5709.200711900337, 5715.399883012307, 5787.0, 1696.8557672597722, 1737.7914650241798, 1744.546417931347, 1745.991270043667, 1752.6319472910577, 964.8504481805331, 969.2924165359186, 971.7570607348163, 984.837501812193, 989.8861630912393, 8573.09982451846, 8659.437136586102, 8678.739637810875, 8760.474371537728, 8787.648494060166, 772.7372693284198, 802.1136644008403, 806.8830019647119, 812.9471584346999, 827.3670641958906, 5299.761510732026, 5949.8215053548465, 5995.130706047598, 6126.509879209652, 6149.96925015372, 24886.751132488804, 26122.216333510027, 26171.869140654177, 26263.343416414744, 26308.0, 24366.0, 25657.48685026289, 25660.0, 25713.614295785577, 25819.35451613687, 11766.58816941403, 11814.881851181379, 11830.290182589073, 11875.346855922835, 11893.643190704293, 9566.56950437218, 9776.315657903879, 9799.363041402286, 9817.410955342702, 9860.211183105192, 20962.790372096082, 21009.264675736886, 21131.26040588572, 21225.044872981063, 21369.14523419046, 22149.1140354384, 22243.555128897657, 22378.77621223767, 22391.0, 22581.209657661904, 12183.75632487363, 12414.875851241371, 12486.562970295996, 12502.312372819219, 12513.374331283218, 15637.296321665324, 15661.921690391931, 15824.050556966618, 15840.28718707638, 15840.841591583936, 12702.936485317514, 12882.291473968648, 13002.414891329723, 13015.088943773844, 13203.669908251986, 12396.566120186111, 12459.563915262923, 12880.291583962597, 12946.67633309137, 13013.154144980546, 10832.566697332019, 10981.670549883516, 11053.0, 11104.111671066457, 11156.0, 8202.671893124209, 8326.791830204293, 8391.244787969112, 8408.87386689188, 8462.576871156294, 8103.716369927024, 8291.253787159185, 8305.169483051646, 8314.83370332578, 8369.707060252862], "value": 7334.789740492772, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.6167501911153, 560.8738033942362, 580.474670423267, 581.2501872584361, 586.7183751799137, 6073.939260607398, 6119.3574674659185, 6208.813735587928, 6258.2490101187805, 6327.240731112267, 6148.784792532262, 6202.224721909762, 6245.687715614213, 6267.717952692128, 6292.0, 5086.287919691246, 5135.871603209922, 5144.3826740791155, 5146.536811686948, 5148.665336753099, 4871.415430148387, 4960.379952505937, 4987.226979818134, 4988.700677959316, 4998.975005124988, 4893.11923853708, 4926.507349265081, 4927.926081108786, 4969.279454479099, 4977.900441991158, 4930.753462326905, 4933.827316043939, 4961.875953101183, 4980.078685443204, 4987.102321582114, 4522.773861306921, 4541.659375546814, 4553.203189441868, 4553.590176884097, 4556.498785133633, 6129.50618147656, 6279.905801412982, 6292.402221788922, 6298.4646305064125, 6306.369363063703, 5821.53427725781, 5843.211166492554, 5849.327327357366, 5871.530277577784, 5890.793822216245, 6711.56374835639, 6744.763933262312, 6749.19009718832, 6764.154480689914, 6776.525643204977, 5019.29729837823, 5083.822066227664, 5101.183810590288, 5115.8745076083205, 5117.130087885069, 6882.520258144473, 6887.449004079662, 6933.618650974195, 6936.549124306904, 6948.845857784103, 5192.0, 5217.017533337307, 5248.9737551312, 5250.081235783722, 5265.0, 5283.947160528345, 5325.4940780625775, 5332.92000619991, 5340.279062326536, 5343.5457986071615, 5802.21670074543, 5804.158397032406, 5806.9419305806405, 5847.736851841592, 5856.414358564195, 6507.3167317431935, 6673.699683514254, 6787.898181527281, 6791.490638202055, 6794.995476334493, 1767.2400867626786, 1777.5822681669797, 1805.4132406967788, 1808.1953530678984, 1816.5640246340784, 1294.6116165150418, 1299.9935000324938, 1306.7974463957912, 1307.9542216022585, 1317.5915466205506, 6089.604175728564, 6090.847728806815, 6118.388161183846, 6120.571559990847, 6121.826751503152, 6672.866542669217, 6834.384905358442, 6835.418989385858, 6841.726330946806, 6845.14435695538, 6107.175531303306, 6137.465633591602, 6190.102435146879, 6203.441690247809, 6232.532560058014, 3570.107473131717, 3594.1130906273893, 3600.0, 3619.9276014479565, 3629.8366573504254, 6955.234924158339, 6975.476839237078, 6995.825104372431, 7029.332213439715, 7034.261402552761, 7038.120234970629, 7039.19049309336, 7061.788146355618, 7063.223045464994, 7100.822479438056, 6816.931830681629, 6817.5909445433435, 6843.8973415399805, 6910.827229319308, 6940.340667636668, 6732.225794033749, 6740.494462915203, 6798.966005169942, 6810.591364517946, 6827.590344579341, 6698.2631910488835, 6734.629595372302, 6770.255271919987, 6813.182418109858, 6846.897296540656, 7003.29967003316, 7026.543274687129, 7031.437485001085, 7032.5077244592385, 7069.505134640526, 5167.914737905082, 5174.896502069862, 5197.688138711689, 5199.324087868553, 5199.584033277404, 6483.870322593616, 6673.866522669617, 6705.2959439258175, 6809.489288303298, 6853.143357080365, 6301.653409062362, 6515.837104072247, 6522.28254891952, 6550.672466376757, 6595.373439523238, 6440.935590644033, 6495.2855185928565, 6506.3493650634555, 6508.707108180238, 6544.803655890331, 6351.4756458450565, 6446.387593178641, 6457.935420645734, 6464.41820236181, 6465.838354041187, 6583.934160658332, 6652.968789837583, 6659.900101498578, 6686.765963191265, 6704.631245281361, 6426.325235850355, 6447.387498187664, 6480.740770369132, 6507.446867016357, 6525.834970039432], "value": 5194.4746870591225, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [953.7234202081397, 956.6651671914826, 987.4766373821873, 991.72231775103, 1001.49424540607, 20983.0, 21441.356759297225, 21659.0, 21698.457538561543, 21723.456913577167, 19514.219431222733, 19792.10935507902, 20617.896910515425, 20720.171193152295, 20723.378298651027, 1057.9153667706564, 1081.7674200046988, 1081.7944590527775, 1082.247837752762, 1084.295208114724, 1049.8110340138771, 1065.3075500924422, 1068.1561566362602, 1068.40169505077, 1092.9617463388784, 1148.041385443156, 1152.1877076660976, 1152.8443660105863, 1152.9481173347178, 1153.0429743313073, 1084.0, 1142.2974870454693, 1144.994275028628, 1150.2293463379556, 1150.4362862197547, 813.8738495533202, 817.4196320612373, 817.5094943034192, 821.0188824354898, 821.8972628421448, 20743.688844667344, 21184.470388240265, 21221.89389053045, 21244.5751084979, 21269.680954785537, 22783.08867645292, 23314.88342558293, 23625.88187059071, 23788.0, 23839.284821455385, 17129.828701712948, 17348.219330130047, 17533.824661753348, 17569.648607027917, 17620.118994050375, 3927.8625248116464, 3943.881683549498, 3982.522097348337, 3994.201159768058, 3994.9201015979806, 159871.0, 160690.0, 161058.19470902687, 161588.0, 165251.0, 17067.658646827244, 17101.230444630022, 17106.0, 17224.741628875578, 17441.127943603024, 34263.314733705185, 34323.828380857936, 34462.65537344645, 34473.482897756556, 34946.30107397889, 9431.434113953048, 9436.0, 9456.05439456049, 9488.478133702574, 9537.761555961157, 4664.696794708333, 4790.808367665254, 4792.329073929653, 4832.9275060874115, 4833.975830120898, 6147.907781383283, 6209.0996805462955, 6226.968865155645, 6229.1590635264565, 6244.843878902973, 1036.7149034015706, 1062.4315990944808, 1062.4740753327153, 1078.379931539368, 1081.086481922774, 722.9096362954631, 751.2975368030909, 754.4831790223715, 768.0, 769.8575763483661, 12526.68683282907, 13294.933525332504, 13395.0, 13514.256715880721, 13520.256385898674, 698.3923986132097, 698.9196242432083, 702.8875379939287, 710.435204012811, 716.7706333973078, 6110.663913484712, 6122.6326420414025, 6177.135201071854, 6253.312135665074, 6260.530460215502, 147406.0, 149863.0, 152855.0, 154767.0, 155592.0, 131477.0, 132678.33660831634, 133733.0, 133856.0, 136688.0, 111397.44301278442, 111444.44277778559, 112206.43896780627, 112516.0, 114583.42708286406, 11592.594259200887, 11593.60876694802, 11603.5358585659, 11881.22772019816, 11925.463354149259, 57519.42480575308, 58257.70871145617, 58576.12135818051, 58607.4139258619, 58802.11796823137, 72285.6385718068, 72568.27431725615, 72613.0, 73098.63450682712, 73526.0, 16618.50144495667, 17000.064996425317, 17297.56756081108, 17325.393611223546, 17434.738478922573, 17664.82335176683, 17712.645747085244, 17844.19701113427, 17916.820831792036, 17944.820551794313, 18061.90969045199, 18128.81871181324, 18181.45455636333, 18190.727139092658, 18337.624678148924, 16821.07484088387, 17019.914900425418, 17084.417887778996, 17191.914040429718, 17308.307667693654, 16955.91522042382, 17048.914755426144, 17155.485335439957, 17219.052952087757, 17385.217665204844, 11640.94179529097, 11997.700057498632, 11998.880011199777, 12056.336901470504, 12299.262044277371, 12944.546940857024, 13125.54060607874, 13175.07774455779, 13219.074664773374, 13228.867711322764], "value": 9886.514731065423, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1377.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 105.0, 105.0, 105.0, 99.0, 108.0, 104.0, 104.0, 106.0], "value": 104.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 113.0, 115.0, 116.0, 112.0, 115.0, 114.0, 111.0, 112.0], "value": 113.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 163.0, 162.0, 162.0, 162.0, 164.0, 166.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 73.0, 85.0, 81.0, 73.0, 74.0, 76.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 79.0, 78.0, 78.0, 76.0, 77.0, 78.0, 128.0, 78.0], "value": 83.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 116.0, 114.0, 110.0, 115.0, 114.0, 116.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 150.0, 149.0, 150.0, 149.0, 148.0, 149.0, 149.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 94.0, 94.0, 98.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 44.0, 44.0, 45.0, 43.0, 44.0, 46.0, 47.0, 43.0], "value": 44.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 39.0, 39.0, 40.0, 40.0, 39.0, 40.0, 39.0, 39.0, 40.0], "value": 39.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 76.0, 72.0, 73.0, 76.0, 70.0, 70.0, 69.0, 71.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 106.0, 111.0, 110.0, 109.0, 108.0, 106.0, 115.0, 111.0], "value": 108.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 149.0, 151.0, 157.0, 163.0, 148.0, 152.0, 153.0, 151.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 57.0, 61.0, 62.0, 61.0, 59.0, 66.0, 60.0, 58.0], "value": 61.5, "unit": "score"}]}]} 08:03:28 INFO - Return code: 0 08:03:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:03:28 INFO - # TBPL SUCCESS # 08:03:28 INFO - Running post-action listener: _package_coverage_data 08:03:28 INFO - Running post-action listener: _resource_record_post_action 08:03:28 INFO - [mozharness: 2017-09-23 15:03:28.496501Z] Finished run-tests step (success) 08:03:28 INFO - Running post-run listener: _resource_record_post_run 08:03:28 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8949760; Write bytes: 521113600; Read time: 2920; Write time: 429800 08:03:28 INFO - TinderboxPrint: CPU usage
13.1% 08:03:28 INFO - TinderboxPrint: I/O read bytes / time
8,949,760 / 2,920 08:03:28 INFO - TinderboxPrint: I/O write bytes / time
521,113,600 / 429,800 08:03:28 INFO - TinderboxPrint: CPU idle
8,225.3 (86.9%) 08:03:28 INFO - TinderboxPrint: CPU user
1,186.4 (12.5%) 08:03:28 INFO - TinderboxPrint: Swap in / out
0 / 0 08:03:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 74993664; Read time: 0; Write time: 39888 08:03:28 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:03:28 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 8949760; Write bytes: 446119936; Read time: 2920; Write time: 389912 08:03:29 INFO - Running post-run listener: _upload_blobber_files 08:03:29 INFO - Blob upload gear active. 08:03:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:03:29 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 08:03:29 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'] 08:03:29 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 08:03:29 INFO - (blobuploader) - INFO - Open directory for files ... 08:03:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:03:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:03:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:30 INFO - (blobuploader) - INFO - Done attempting. 08:03:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:03:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:03:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:37 INFO - (blobuploader) - INFO - Done attempting. 08:03:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:03:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:03:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:38 INFO - (blobuploader) - INFO - Done attempting. 08:03:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:03:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:03:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:39 INFO - (blobuploader) - INFO - Done attempting. 08:03:39 INFO - (blobuploader) - INFO - Iteration through files over. 08:03:39 INFO - Return code: 0 08:03:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:03:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:03:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd72f386690dc7a8c7c566b22b7e8d38d3bb62018d7683e5a9450bc67a21bb16ade9e54ac6cea02f777d4bf82f47b3e553067e042a23c4d426ce54ef2f60f6cf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05cc36e4e2cbee26e5ab22c0c1f272e50273a5b07bd5089c5b5b16c66b8b0d33f516365bdb210b7d46bad070d2afbff6544d381547a9bf596757727ed4dbfd56", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1228a8f4de624573e3331cd34a3a3ed1b655c419578fd672a979508f9276f586ff1359d287b769e8aa8fe546ff141743ee5ca09e2f2566f896d1a3a5172f32e", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a763b0e652804cecfc44821c59a959211be71a8937c581f6c8598e431ba0d47ee72727bc7a14c6724779ca9c66a9d0605dd86e1d819420211d5979bf39f535a3"} 08:03:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:03:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:03:39 INFO - Contents: 08:03:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd72f386690dc7a8c7c566b22b7e8d38d3bb62018d7683e5a9450bc67a21bb16ade9e54ac6cea02f777d4bf82f47b3e553067e042a23c4d426ce54ef2f60f6cf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05cc36e4e2cbee26e5ab22c0c1f272e50273a5b07bd5089c5b5b16c66b8b0d33f516365bdb210b7d46bad070d2afbff6544d381547a9bf596757727ed4dbfd56", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1228a8f4de624573e3331cd34a3a3ed1b655c419578fd672a979508f9276f586ff1359d287b769e8aa8fe546ff141743ee5ca09e2f2566f896d1a3a5172f32e", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a763b0e652804cecfc44821c59a959211be71a8937c581f6c8598e431ba0d47ee72727bc7a14c6724779ca9c66a9d0605dd86e1d819420211d5979bf39f535a3"} 08:03:39 INFO - Running post-run listener: copy_logs_to_upload_dir 08:03:39 INFO - Copying logs to upload dir... 08:03:39 INFO - mkdir: /builds/slave/test/build/upload/logs 08:03:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.368520 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-23 08:03:39.661053) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 08:03:39.675388) ========= 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=ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd72f386690dc7a8c7c566b22b7e8d38d3bb62018d7683e5a9450bc67a21bb16ade9e54ac6cea02f777d4bf82f47b3e553067e042a23c4d426ce54ef2f60f6cf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05cc36e4e2cbee26e5ab22c0c1f272e50273a5b07bd5089c5b5b16c66b8b0d33f516365bdb210b7d46bad070d2afbff6544d381547a9bf596757727ed4dbfd56", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1228a8f4de624573e3331cd34a3a3ed1b655c419578fd672a979508f9276f586ff1359d287b769e8aa8fe546ff141743ee5ca09e2f2566f896d1a3a5172f32e", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a763b0e652804cecfc44821c59a959211be71a8937c581f6c8598e431ba0d47ee72727bc7a14c6724779ca9c66a9d0605dd86e1d819420211d5979bf39f535a3"} build_url:https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/SKQULHJBQqSQWGRwTREaVQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd72f386690dc7a8c7c566b22b7e8d38d3bb62018d7683e5a9450bc67a21bb16ade9e54ac6cea02f777d4bf82f47b3e553067e042a23c4d426ce54ef2f60f6cf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05cc36e4e2cbee26e5ab22c0c1f272e50273a5b07bd5089c5b5b16c66b8b0d33f516365bdb210b7d46bad070d2afbff6544d381547a9bf596757727ed4dbfd56", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1228a8f4de624573e3331cd34a3a3ed1b655c419578fd672a979508f9276f586ff1359d287b769e8aa8fe546ff141743ee5ca09e2f2566f896d1a3a5172f32e", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a763b0e652804cecfc44821c59a959211be71a8937c581f6c8598e431ba0d47ee72727bc7a14c6724779ca9c66a9d0605dd86e1d819420211d5979bf39f535a3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 08:03:39.714566) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 08:03:39.715058) ========= 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=ed14279e38b05397cf4aa391000001a4-1506177778.377174-1102326779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 08:03:39.764847) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 08:03:39.765168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 08:03:39.765477) ========= ========= Total master_lag: 0.26 =========