builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1505377455.21 results: success (0) revision: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:15.207851) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:15.208312) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:15.208580) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:15.291951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:15.292208) ========= 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=ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 01:24:15-- 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% 207M=0s 2017-09-14 01:24:15 (207 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106569 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:15.425004) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:15.425340) ========= 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=ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016734 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:15.490063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:15.490410) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4702042aa919d5ae49dfe3ac5ee86507839b3c83 --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 4702042aa919d5ae49dfe3ac5ee86507839b3c83 --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=ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 01:24:15,392 truncating revision to first 12 chars 2017-09-14 01:24:15,392 Setting DEBUG logging. 2017-09-14 01:24:15,392 attempt 1/10 2017-09-14 01:24:15,392 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4702042aa919?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 01:24:15,776 unpacking tar archive at: mozilla-central-4702042aa919/testing/mozharness/ program finished with exit code 0 elapsedTime=0.693546 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:16.216761) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:16.217038) ========= script_repo_revision: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:16.217418) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:16.217675) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 01:24:16.230513) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 39 secs) (at 2017-09-14 01:24:16.230772) ========= /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=ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:24:16 INFO - MultiFileLogger online at 20170914 01:24:16 in /builds/slave/test 01:24:16 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 01:24:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:24:16 INFO - {'append_to_log': False, 01:24:16 INFO - 'base_work_dir': '/builds/slave/test', 01:24:16 INFO - 'blob_upload_branch': 'Firefox', 01:24:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:24:16 INFO - 'branch': 'Firefox', 01:24:16 INFO - 'buildbot_json_path': 'buildprops.json', 01:24:16 INFO - 'code_coverage': False, 01:24:16 INFO - 'config_files': ('talos/linux_config.py',), 01:24:16 INFO - 'default_actions': ('clobber', 01:24:16 INFO - 'read-buildbot-config', 01:24:16 INFO - 'download-and-extract', 01:24:16 INFO - 'populate-webroot', 01:24:16 INFO - 'create-virtualenv', 01:24:16 INFO - 'install', 01:24:16 INFO - 'setup-mitmproxy', 01:24:16 INFO - 'run-tests'), 01:24:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:24:16 INFO - 'disable_ccov_upload': False, 01:24:16 INFO - 'disable_stylo': False, 01:24:16 INFO - 'download_minidump_stackwalk': True, 01:24:16 INFO - 'download_symbols': 'ondemand', 01:24:16 INFO - 'enable_stylo': False, 01:24:16 INFO - 'enable_webrender': False, 01:24:16 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 01:24:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:24:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:24:16 INFO - 'gecko_profile': False, 01:24:16 INFO - 'gecko_profile_interval': 0, 01:24:16 INFO - 'installer_path': 'installer.exe', 01:24:16 INFO - 'log_level': 'info', 01:24:16 INFO - 'log_name': 'talos', 01:24:16 INFO - 'log_to_console': True, 01:24:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:24:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:24:16 INFO - 'opt_config_files': (), 01:24:16 INFO - 'pip_index': False, 01:24:16 INFO - 'suite': 'dromaeojs-e10s', 01:24:16 INFO - 'system_bits': '32', 01:24:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:24:16 INFO - 'title': 'talos-linux64-ix-033', 01:24:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:24:16 INFO - 'use_talos_json': True, 01:24:16 INFO - 'verify': 'False', 01:24:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:24:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:24:16 INFO - 'work_dir': 'build'} 01:24:16 INFO - [mozharness: 2017-09-14 08:24:16.260641Z] Running clobber step. 01:24:16 INFO - Running pre-action listener: _resource_record_pre_action 01:24:16 INFO - Running main action method: clobber 01:24:16 INFO - rmtree: /builds/slave/test/build 01:24:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:24:17 INFO - Running post-action listener: _resource_record_post_action 01:24:17 INFO - [mozharness: 2017-09-14 08:24:17.267911Z] Finished clobber step (success) 01:24:17 INFO - [mozharness: 2017-09-14 08:24:17.268009Z] Running read-buildbot-config step. 01:24:17 INFO - Running pre-action listener: _resource_record_pre_action 01:24:17 INFO - Running main action method: read_buildbot_config 01:24:17 INFO - Using buildbot properties: 01:24:17 INFO - { 01:24:17 INFO - "project": "", 01:24:17 INFO - "product": "firefox", 01:24:17 INFO - "who": "kwierso@gmail.com", 01:24:17 INFO - "installer_path": "public/build/target.tar.bz2", 01:24:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 01:24:17 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 01:24:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 01:24:17 INFO - "stage_platform": "linux64-pgo", 01:24:17 INFO - "basedir": "/builds/slave/test", 01:24:17 INFO - "buildnumber": 184, 01:24:17 INFO - "platform": "ubuntu64_hw", 01:24:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:24:17 INFO - "slavebuilddir": "test", 01:24:17 INFO - "taskId": "N-y4wGk3R2iSiEJ3xxCF7A", 01:24:17 INFO - "branch": "mozilla-central", 01:24:17 INFO - "script_repo_revision": "production", 01:24:17 INFO - "revision": "4702042aa919d5ae49dfe3ac5ee86507839b3c83", 01:24:17 INFO - "slavename": "talos-linux64-ix-033", 01:24:17 INFO - "repo_path": "mozilla-central" 01:24:17 INFO - } 01:24:17 INFO - Finding installer, test and symbols from parent task. 01:24:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N-y4wGk3R2iSiEJ3xxCF7A'}, attempt #1 01:24:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N-y4wGk3R2iSiEJ3xxCF7A'}, attempt #1 01:24:18 INFO - Task dependencies: Wiwdja74QTmS_gMgcPIgNA 01:24:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA'}, attempt #1 01:24:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.tar.bz2 01:24:18 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.test_packages.json 01:24:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.crashreporter-symbols.zip 01:24:18 INFO - Running post-action listener: _resource_record_post_action 01:24:18 INFO - [mozharness: 2017-09-14 08:24:18.764952Z] Finished read-buildbot-config step (success) 01:24:18 INFO - [mozharness: 2017-09-14 08:24:18.765169Z] Running download-and-extract step. 01:24:18 INFO - Running pre-action listener: _resource_record_pre_action 01:24:18 INFO - Running main action method: download_and_extract 01:24:18 INFO - mkdir: /builds/slave/test/build/tests 01:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:18 INFO - trying https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.test_packages.json 01:24:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:24:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:24:19 INFO - Downloaded 989 bytes. 01:24:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:24:19 INFO - Using the following test package requirements: 01:24:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 01:24:19 INFO - u'common': [u'target.common.tests.zip'], 01:24:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:24:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:24:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:24:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:24:19 INFO - u'mozbase': [u'target.common.tests.zip'], 01:24:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:24:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:24:19 INFO - u'web-platform': [u'target.common.tests.zip', 01:24:19 INFO - u'target.web-platform.tests.tar.gz'], 01:24:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:24:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 01:24:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.common.tests.zip 01:24:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:24:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.common.tests.zip into memory 01:24:21 INFO - Content-Length response header: 55141180 01:24:22 INFO - Bytes received: 55141180 01:24:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.talos.tests.zip 01:24:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:24:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.talos.tests.zip into memory 01:24:35 INFO - Content-Length response header: 14500356 01:24:35 INFO - Bytes received: 14500356 01:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:36 INFO - trying https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.tar.bz2 01:24:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:24:37 INFO - Downloaded 62110692 bytes. 01:24:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.tar.bz2 01:24:37 INFO - mkdir: /builds/slave/test/properties 01:24:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:24:37 INFO - Writing to file /builds/slave/test/properties/build_url 01:24:37 INFO - Contents: 01:24:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.tar.bz2 01:24:37 INFO - Running post-action listener: _resource_record_post_action 01:24:37 INFO - Running post-action listener: find_tests_for_verification 01:24:37 INFO - Running post-action listener: set_extra_try_arguments 01:24:37 INFO - [mozharness: 2017-09-14 08:24:37.485417Z] Finished download-and-extract step (success) 01:24:37 INFO - [mozharness: 2017-09-14 08:24:37.485516Z] Running populate-webroot step. 01:24:37 INFO - Running pre-action listener: _resource_record_pre_action 01:24:37 INFO - Running main action method: populate_webroot 01:24:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:24:37 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:24:37 INFO - 'tests': ['tresize', 01:24:37 INFO - 'tcanvasmark']}, 01:24:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:24:37 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:24:37 INFO - 'tests': ['dromaeo_css', 01:24:37 INFO - 'kraken']}, 01:24:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:24:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:37 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:24:37 INFO - 'talos_options': ['--disable-stylo'], 01:24:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:24:37 INFO - 'tests': ['damp', 'tps']}, 01:24:37 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:24:37 INFO - 'talos_options': ['--disable-stylo'], 01:24:37 INFO - 'tests': ['damp', 'tps']}, 01:24:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:24:37 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:24:37 INFO - 'tests': ['dromaeo_dom']}, 01:24:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 01:24:37 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:24:37 INFO - 'tests': ['basic_compositor_video', 01:24:37 INFO - 'glvideo']}, 01:24:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 01:24:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 01:24:37 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:24:37 INFO - 'talos_options': ['--disable-stylo'], 01:24:37 INFO - 'tests': ['ts_paint_webext', 01:24:37 INFO - 'tp5o_webext']}, 01:24:37 INFO - 'other-e10s': {'tests': ['a11yr', 01:24:37 INFO - 'ts_paint', 01:24:37 INFO - 'tpaint', 01:24:37 INFO - 'sessionrestore', 01:24:37 INFO - 'sessionrestore_many_windows', 01:24:37 INFO - 'sessionrestore_no_auto_restore', 01:24:37 INFO - 'tabpaint']}, 01:24:37 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:24:37 INFO - 'tests': ['a11yr', 01:24:37 INFO - 'ts_paint', 01:24:37 INFO - 'tpaint', 01:24:37 INFO - 'sessionrestore', 01:24:37 INFO - 'sessionrestore_many_windows', 01:24:37 INFO - 'sessionrestore_no_auto_restore', 01:24:37 INFO - 'tabpaint']}, 01:24:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 01:24:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 01:24:37 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:24:37 INFO - 'tests': ['bloom_basic_singleton']}, 01:24:37 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:24:37 INFO - 'tests': ['bloom_basic']}, 01:24:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:24:37 INFO - 'tsvgr_opacity', 01:24:37 INFO - 'tart', 01:24:37 INFO - 'tscrollx', 01:24:37 INFO - 'tsvg_static']}, 01:24:37 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:24:37 INFO - 'tests': ['tsvgx', 01:24:37 INFO - 'tsvgr_opacity', 01:24:37 INFO - 'tart', 01:24:37 INFO - 'tscrollx', 01:24:37 INFO - 'tsvg_static']}, 01:24:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:24:37 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:24:37 INFO - 'talos_options': ['--disable-stylo'], 01:24:37 INFO - 'tests': ['tp5o']}, 01:24:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:24:37 INFO - 'talos_options': ['--mitmproxy', 01:24:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:24:37 INFO - '--firstNonBlankPaint'], 01:24:37 INFO - 'tests': ['tp6_google', 01:24:37 INFO - 'tp6_youtube', 01:24:37 INFO - 'tp6_amazon', 01:24:37 INFO - 'tp6_facebook']}, 01:24:37 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:24:37 INFO - 'talos_options': ['--disable-stylo', 01:24:37 INFO - '--mitmproxy', 01:24:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:24:37 INFO - '--firstNonBlankPaint'], 01:24:37 INFO - 'tests': ['tp6_google', 01:24:37 INFO - 'tp6_youtube', 01:24:37 INFO - 'tp6_amazon', 01:24:37 INFO - 'tp6_facebook']}, 01:24:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:24:37 INFO - 'talos_options': ['--stylo-threads=1', 01:24:37 INFO - '--mitmproxy', 01:24:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:24:37 INFO - '--firstNonBlankPaint'], 01:24:37 INFO - 'tests': ['tp6_google', 01:24:37 INFO - 'tp6_youtube', 01:24:37 INFO - 'tp6_amazon', 01:24:37 INFO - 'tp6_facebook']}, 01:24:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:24:37 INFO - 'talos_options': ['--xperf_path', 01:24:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:37 INFO - 'tests': ['tp5n']}, 01:24:37 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:24:37 INFO - 'talos_options': ['--disable-stylo', 01:24:37 INFO - '--xperf_path', 01:24:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:37 INFO - 'tests': ['tp5n']}}} 01:24:37 INFO - Running post-action listener: _resource_record_post_action 01:24:37 INFO - [mozharness: 2017-09-14 08:24:37.500558Z] Finished populate-webroot step (success) 01:24:37 INFO - [mozharness: 2017-09-14 08:24:37.500649Z] Running create-virtualenv step. 01:24:37 INFO - Running pre-action listener: _resource_record_pre_action 01:24:37 INFO - Running main action method: create_virtualenv 01:24:37 INFO - Creating virtualenv /builds/slave/test/build/venv 01:24:37 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:24:37 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 01:24:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 01:24:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:24:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:24:40 INFO - Installing distribute.............................................................................................................................................................................................done. 01:24:45 INFO - Installing pip...............done. 01:24:45 INFO - Return code: 0 01:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:24:45 INFO - Reading from file tmpfile_stdout 01:24:45 INFO - Output received: 01:24:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 01:24:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:45 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 0x1e2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f090>, '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 0x219fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2199f90>, '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': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', '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 01:24:45 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 01:24:45 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 01:24:45 INFO - Using env: {'DISPLAY': ':0', 01:24:45 INFO - 'HOME': '/home/cltbld', 01:24:45 INFO - 'LANG': 'en_US.UTF-8', 01:24:45 INFO - 'LANGUAGE': 'en_US:en', 01:24:45 INFO - 'LOGNAME': 'cltbld', 01:24:45 INFO - 'MAIL': '/var/mail/cltbld', 01:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:45 INFO - 'MOZ_NO_REMOTE': '1', 01:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:45 INFO - 'NO_EM_RESTART': '1', 01:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:45 INFO - 'PWD': '/builds/slave/test', 01:24:45 INFO - 'SHELL': '/bin/bash', 01:24:45 INFO - 'SHLVL': '1', 01:24:45 INFO - 'TERM': 'linux', 01:24:45 INFO - 'TMOUT': '86400', 01:24:45 INFO - 'USER': 'cltbld', 01:24:45 INFO - 'XDG_SESSION_COOKIE': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', 01:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:45 INFO - '_': '/tools/buildbot/bin/python'} 01:25:24 INFO - Ignoring indexes: http://pypi.python.org/simple/ 01:25:24 INFO - Downloading/unpacking pip>=1.5 01:25:24 INFO - Running setup.py egg_info for package pip 01:25:24 INFO - warning: no files found matching 'pip/cacert.pem' 01:25:24 INFO - warning: no files found matching '*.html' under directory 'docs' 01:25:24 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 01:25:24 INFO - no previously-included directories found matching 'docs/_build/_sources' 01:25:24 INFO - Installing collected packages: pip 01:25:24 INFO - Found existing installation: pip 1.1 01:25:24 INFO - Uninstalling pip: 01:25:24 INFO - Successfully uninstalled pip 01:25:24 INFO - Running setup.py install for pip 01:25:24 INFO - warning: no files found matching 'pip/cacert.pem' 01:25:24 INFO - warning: no files found matching '*.html' under directory 'docs' 01:25:24 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 01:25:24 INFO - no previously-included directories found matching 'docs/_build/_sources' 01:25:24 INFO - Installing pip script to /builds/slave/test/build/venv/bin 01:25:24 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 01:25:24 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 01:25:24 INFO - Successfully installed pip 01:25:24 INFO - Cleaning up... 01:25:24 INFO - Return code: 0 01:25:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:24 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 0x1e2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f090>, '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 0x219fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2199f90>, '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': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', '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 01:25:24 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 01:25:24 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 01:25:24 INFO - Using env: {'DISPLAY': ':0', 01:25:24 INFO - 'HOME': '/home/cltbld', 01:25:24 INFO - 'LANG': 'en_US.UTF-8', 01:25:24 INFO - 'LANGUAGE': 'en_US:en', 01:25:24 INFO - 'LOGNAME': 'cltbld', 01:25:24 INFO - 'MAIL': '/var/mail/cltbld', 01:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:24 INFO - 'MOZ_NO_REMOTE': '1', 01:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:24 INFO - 'NO_EM_RESTART': '1', 01:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:24 INFO - 'PWD': '/builds/slave/test', 01:25:24 INFO - 'SHELL': '/bin/bash', 01:25:24 INFO - 'SHLVL': '1', 01:25:24 INFO - 'TERM': 'linux', 01:25:24 INFO - 'TMOUT': '86400', 01:25:24 INFO - 'USER': 'cltbld', 01:25:24 INFO - 'XDG_SESSION_COOKIE': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', 01:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:24 INFO - '_': '/tools/buildbot/bin/python'} 01:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:24 INFO - Downloading/unpacking psutil>=3.1.1 01:25:24 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 01:25:24 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 01:25:24 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 01:25:24 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 01:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:25:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:25 INFO - Installing collected packages: psutil 01:25:25 INFO - Running setup.py install for psutil 01:25:25 INFO - building 'psutil._psutil_linux' extension 01:25:25 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 01:25:26 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 01:25:26 INFO - building 'psutil._psutil_posix' extension 01:25:26 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 01:25:26 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 01:25:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:41 INFO - Successfully installed psutil 01:25:41 INFO - Cleaning up... 01:26:19 INFO - Return code: 0 01:26:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26: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')]} 01:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f090>, '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 0x219fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2199f90>, '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': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', '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 01:26: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:26: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 mozsystemmonitor==0.3 01:26:28 INFO - Using env: {'DISPLAY': ':0', 01:26:28 INFO - 'HOME': '/home/cltbld', 01:26:28 INFO - 'LANG': 'en_US.UTF-8', 01:26:28 INFO - 'LANGUAGE': 'en_US:en', 01:26:28 INFO - 'LOGNAME': 'cltbld', 01:26:28 INFO - 'MAIL': '/var/mail/cltbld', 01:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:28 INFO - 'MOZ_NO_REMOTE': '1', 01:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:28 INFO - 'NO_EM_RESTART': '1', 01:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:28 INFO - 'PWD': '/builds/slave/test', 01:26:28 INFO - 'SHELL': '/bin/bash', 01:26:28 INFO - 'SHLVL': '1', 01:26:28 INFO - 'TERM': 'linux', 01:26:28 INFO - 'TMOUT': '86400', 01:26:28 INFO - 'USER': 'cltbld', 01:26:28 INFO - 'XDG_SESSION_COOKIE': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', 01:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:28 INFO - '_': '/tools/buildbot/bin/python'} 01:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:26: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 01:26: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 01:26: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 01:26: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 01:26:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:26:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:26:29 INFO - Installing collected packages: mozsystemmonitor 01:26:29 INFO - Running setup.py install for mozsystemmonitor 01:26:29 INFO - Successfully installed mozsystemmonitor 01:26:29 INFO - Cleaning up... 01:26:29 INFO - Return code: 0 01:26:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:29 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 0x1e2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f090>, '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 0x219fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2199f90>, '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': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', '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 01:26:29 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 01:26:29 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 01:26:29 INFO - Using env: {'DISPLAY': ':0', 01:26:29 INFO - 'HOME': '/home/cltbld', 01:26:29 INFO - 'LANG': 'en_US.UTF-8', 01:26:29 INFO - 'LANGUAGE': 'en_US:en', 01:26:29 INFO - 'LOGNAME': 'cltbld', 01:26:29 INFO - 'MAIL': '/var/mail/cltbld', 01:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:29 INFO - 'MOZ_NO_REMOTE': '1', 01:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:29 INFO - 'NO_EM_RESTART': '1', 01:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:29 INFO - 'PWD': '/builds/slave/test', 01:26:29 INFO - 'SHELL': '/bin/bash', 01:26:29 INFO - 'SHLVL': '1', 01:26:29 INFO - 'TERM': 'linux', 01:26:29 INFO - 'TMOUT': '86400', 01:26:29 INFO - 'USER': 'cltbld', 01:26:29 INFO - 'XDG_SESSION_COOKIE': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', 01:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:29 INFO - '_': '/tools/buildbot/bin/python'} 01:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:29 INFO - Downloading/unpacking jsonschema==2.5.1 01:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:26:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:26: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 01:26: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 01:26: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 01:26: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 01:26:30 INFO - Downloading functools32-3.2.3-2.tar.gz 01:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:26:31 INFO - warning: no files found matching '*.txt' 01:26:31 INFO - no previously-included directories found matching 'build' 01:26:31 INFO - no previously-included directories found matching 'dist' 01:26:31 INFO - no previously-included directories found matching '.git*' 01:26:31 INFO - Installing collected packages: jsonschema, functools32 01:26:31 INFO - Running setup.py install for functools32 01:26:31 INFO - warning: no files found matching '*.txt' 01:26:31 INFO - no previously-included directories found matching 'build' 01:26:31 INFO - no previously-included directories found matching 'dist' 01:26:31 INFO - no previously-included directories found matching '.git*' 01:26:31 INFO - Successfully installed jsonschema functools32 01:26:31 INFO - Cleaning up... 01:26:31 INFO - Return code: 0 01:26:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26: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')]} 01:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:31 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 0x1e2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f090>, '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 0x219fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2199f90>, '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': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', '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 01:26:31 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 01:26:31 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 01:26:31 INFO - Using env: {'DISPLAY': ':0', 01:26:31 INFO - 'HOME': '/home/cltbld', 01:26:31 INFO - 'LANG': 'en_US.UTF-8', 01:26:31 INFO - 'LANGUAGE': 'en_US:en', 01:26:31 INFO - 'LOGNAME': 'cltbld', 01:26:31 INFO - 'MAIL': '/var/mail/cltbld', 01:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:31 INFO - 'MOZ_NO_REMOTE': '1', 01:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:31 INFO - 'NO_EM_RESTART': '1', 01:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:31 INFO - 'PWD': '/builds/slave/test', 01:26:31 INFO - 'SHELL': '/bin/bash', 01:26:31 INFO - 'SHLVL': '1', 01:26:31 INFO - 'TERM': 'linux', 01:26:31 INFO - 'TMOUT': '86400', 01:26:31 INFO - 'USER': 'cltbld', 01:26:31 INFO - 'XDG_SESSION_COOKIE': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', 01:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:31 INFO - '_': '/tools/buildbot/bin/python'} 01:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:26:31 INFO - Cleaning up... 01:26:31 INFO - Return code: 0 01:26:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26: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')]} 01:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:31 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 0x1e2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f090>, '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 0x219fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2199f90>, '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': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', '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 01:26:31 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 01:26:31 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 01:26:31 INFO - Using env: {'DISPLAY': ':0', 01:26:31 INFO - 'HOME': '/home/cltbld', 01:26:31 INFO - 'LANG': 'en_US.UTF-8', 01:26:31 INFO - 'LANGUAGE': 'en_US:en', 01:26:31 INFO - 'LOGNAME': 'cltbld', 01:26:31 INFO - 'MAIL': '/var/mail/cltbld', 01:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:31 INFO - 'MOZ_NO_REMOTE': '1', 01:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:31 INFO - 'NO_EM_RESTART': '1', 01:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:31 INFO - 'PWD': '/builds/slave/test', 01:26:31 INFO - 'SHELL': '/bin/bash', 01:26:31 INFO - 'SHLVL': '1', 01:26:31 INFO - 'TERM': 'linux', 01:26:31 INFO - 'TMOUT': '86400', 01:26:31 INFO - 'USER': 'cltbld', 01:26:31 INFO - 'XDG_SESSION_COOKIE': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', 01:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:31 INFO - '_': '/tools/buildbot/bin/python'} 01:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:31 INFO - Downloading/unpacking blobuploader==1.2.4 01:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:32 INFO - Downloading blobuploader-1.2.4.tar.gz 01:26:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:26:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:26:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:26:33 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 01:26:33 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 01:26:33 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 01:26:33 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 01:26:33 INFO - Downloading docopt-0.6.1.tar.gz 01:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:26:33 INFO - Installing collected packages: blobuploader, requests, docopt 01:26:33 INFO - Running setup.py install for blobuploader 01:26:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:26:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:26:33 INFO - Running setup.py install for requests 01:26:33 INFO - Running setup.py install for docopt 01:26:33 INFO - Successfully installed blobuploader requests docopt 01:26:33 INFO - Cleaning up... 01:26:33 INFO - Return code: 0 01:26:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:33 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')]} 01:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:33 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')]} 01:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:33 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 0x1e2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f090>, '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 0x219fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2199f90>, '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': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', '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 01:26:33 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 01:26:33 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 01:26:33 INFO - Using env: {'DISPLAY': ':0', 01:26:33 INFO - 'HOME': '/home/cltbld', 01:26:33 INFO - 'LANG': 'en_US.UTF-8', 01:26:33 INFO - 'LANGUAGE': 'en_US:en', 01:26:33 INFO - 'LOGNAME': 'cltbld', 01:26:33 INFO - 'MAIL': '/var/mail/cltbld', 01:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:33 INFO - 'MOZ_NO_REMOTE': '1', 01:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:33 INFO - 'NO_EM_RESTART': '1', 01:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:33 INFO - 'PWD': '/builds/slave/test', 01:26:33 INFO - 'SHELL': '/bin/bash', 01:26:33 INFO - 'SHLVL': '1', 01:26:33 INFO - 'TERM': 'linux', 01:26:33 INFO - 'TMOUT': '86400', 01:26:33 INFO - 'USER': 'cltbld', 01:26:33 INFO - 'XDG_SESSION_COOKIE': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', 01:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:33 INFO - '_': '/tools/buildbot/bin/python'} 01:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:34 INFO - Running setup.py (path:/tmp/pip-Q6_twN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:34 INFO - Running setup.py (path:/tmp/pip-KywLCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:34 INFO - Running setup.py (path:/tmp/pip-hddukP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:34 INFO - Running setup.py (path:/tmp/pip-pYPKlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:34 INFO - Running setup.py (path:/tmp/pip-G0zOHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:34 INFO - Running setup.py (path:/tmp/pip-955mwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:34 INFO - Running setup.py (path:/tmp/pip-Cfi7bW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:34 INFO - Running setup.py (path:/tmp/pip-DhZvjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:34 INFO - Running setup.py (path:/tmp/pip-mreght-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:34 INFO - Running setup.py (path:/tmp/pip-ug21WY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:34 INFO - Running setup.py (path:/tmp/pip-87ADFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:34 INFO - Running setup.py (path:/tmp/pip-G5gT7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:34 INFO - Running setup.py (path:/tmp/pip-Ehzs7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:35 INFO - Running setup.py (path:/tmp/pip-FrAI9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:35 INFO - Running setup.py (path:/tmp/pip-tM8KCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:35 INFO - Running setup.py (path:/tmp/pip-e44RUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:35 INFO - Running setup.py (path:/tmp/pip-BmtIQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:26:35 INFO - Running setup.py install for manifestparser 01:26:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:26:35 INFO - Running setup.py install for mozcrash 01:26:35 INFO - Running setup.py install for mozdebug 01:26:35 INFO - Running setup.py install for mozdevice 01:26:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:26:35 INFO - Running setup.py install for mozfile 01:26:35 INFO - Running setup.py install for mozhttpd 01:26:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:26:35 INFO - Running setup.py install for mozinfo 01:26:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:26:35 INFO - Running setup.py install for mozInstall 01:26:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:26:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:26:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:26:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:26:36 INFO - Running setup.py install for mozleak 01:26:36 INFO - Running setup.py install for mozlog 01:26:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:26:36 INFO - Running setup.py install for moznetwork 01:26:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:26:36 INFO - Running setup.py install for mozprocess 01:26:36 INFO - Running setup.py install for mozprofile 01:26:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:26:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:26:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:26:36 INFO - Running setup.py install for mozrunner 01:26:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:26:36 INFO - Running setup.py install for mozscreenshot 01:26:36 INFO - Running setup.py install for moztest 01:26:36 INFO - Running setup.py install for mozversion 01:26:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:26:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:26:37 INFO - Cleaning up... 01:26:37 INFO - Return code: 0 01:26:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26: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')]} 01:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:37 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 0x1e2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f090>, '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 0x219fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2199f90>, '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': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', '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 01:26:37 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 01:26:37 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 01:26:37 INFO - Using env: {'DISPLAY': ':0', 01:26:37 INFO - 'HOME': '/home/cltbld', 01:26:37 INFO - 'LANG': 'en_US.UTF-8', 01:26:37 INFO - 'LANGUAGE': 'en_US:en', 01:26:37 INFO - 'LOGNAME': 'cltbld', 01:26:37 INFO - 'MAIL': '/var/mail/cltbld', 01:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:37 INFO - 'MOZ_NO_REMOTE': '1', 01:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:37 INFO - 'NO_EM_RESTART': '1', 01:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:37 INFO - 'PWD': '/builds/slave/test', 01:26:37 INFO - 'SHELL': '/bin/bash', 01:26:37 INFO - 'SHLVL': '1', 01:26:37 INFO - 'TERM': 'linux', 01:26:37 INFO - 'TMOUT': '86400', 01:26:37 INFO - 'USER': 'cltbld', 01:26:37 INFO - 'XDG_SESSION_COOKIE': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', 01:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:37 INFO - '_': '/tools/buildbot/bin/python'} 01:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:37 INFO - Running setup.py (path:/tmp/pip-o781P2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:37 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)) 01:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:37 INFO - Running setup.py (path:/tmp/pip-zjoFDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:37 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)) 01:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:37 INFO - Running setup.py (path:/tmp/pip-SY9Kq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:37 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)) 01:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:37 INFO - Running setup.py (path:/tmp/pip-s0iTEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:37 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)) 01:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:37 INFO - Running setup.py (path:/tmp/pip-N3CeLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:37 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)) 01:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:37 INFO - Running setup.py (path:/tmp/pip-xHRBtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:37 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)) 01:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:37 INFO - Running setup.py (path:/tmp/pip-qCykgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:37 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)) 01:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:37 INFO - Running setup.py (path:/tmp/pip-v6vB3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:37 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)) 01:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:37 INFO - Running setup.py (path:/tmp/pip-iRXhSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:37 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)) 01:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:37 INFO - Running setup.py (path:/tmp/pip-ShtMQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:37 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)) 01:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:37 INFO - Running setup.py (path:/tmp/pip-h01E44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:38 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)) 01:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:38 INFO - Running setup.py (path:/tmp/pip-WXY0k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:38 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)) 01:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:38 INFO - Running setup.py (path:/tmp/pip-cLh0yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:38 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)) 01:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:38 INFO - Running setup.py (path:/tmp/pip-4Iy0GT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:38 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)) 01:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:38 INFO - Running setup.py (path:/tmp/pip-weR_X7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:38 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)) 01:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:38 INFO - Running setup.py (path:/tmp/pip-j30Wg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:38 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)) 01:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:38 INFO - Running setup.py (path:/tmp/pip-TaMJcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:38 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)) 01:26:38 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)) 01:26:38 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)) 01:26:38 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)) 01:26:38 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)) 01:26:38 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)) 01:26:38 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)) 01:26:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:26: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 01:26: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 01:26: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 01:26: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 01:26:39 INFO - Downloading blessings-1.6.tar.gz 01:26:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:26:39 INFO - Installing collected packages: blessings 01:26:39 INFO - Running setup.py install for blessings 01:26:39 INFO - Successfully installed blessings 01:26:39 INFO - Cleaning up... 01:26:39 INFO - Return code: 0 01:26:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:26:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:40 INFO - Reading from file tmpfile_stdout 01:26:40 INFO - Current package versions: 01:26:40 INFO - argparse == 1.2.1 01:26:40 INFO - blessings == 1.6 01:26:40 INFO - blobuploader == 1.2.4 01:26:40 INFO - docopt == 0.6.1 01:26:40 INFO - functools32 == 3.2.3-2 01:26:40 INFO - jsonschema == 2.5.1 01:26:40 INFO - manifestparser == 1.1 01:26:40 INFO - mozInstall == 1.13 01:26:40 INFO - mozcrash == 1.0 01:26:40 INFO - mozdebug == 0.1 01:26:40 INFO - mozdevice == 0.51 01:26:40 INFO - mozfile == 1.2 01:26:40 INFO - mozhttpd == 0.7 01:26:40 INFO - mozinfo == 0.10 01:26:40 INFO - mozleak == 0.1 01:26:40 INFO - mozlog == 3.5 01:26:40 INFO - moznetwork == 0.27 01:26:40 INFO - mozprocess == 0.25 01:26:40 INFO - mozprofile == 0.28 01:26:40 INFO - mozrunner == 6.13 01:26:40 INFO - mozscreenshot == 0.1 01:26:40 INFO - mozsystemmonitor == 0.3 01:26:40 INFO - moztest == 0.8 01:26:40 INFO - mozversion == 1.4 01:26:40 INFO - psutil == 3.1.1 01:26:40 INFO - requests == 1.2.3 01:26:40 INFO - wsgiref == 0.1.2 01:26:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26: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')]} 01:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:40 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 0x1e2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f090>, '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 0x219fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2199f90>, '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': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', '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 01:26:40 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 01:26:40 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 01:26:40 INFO - Using env: {'DISPLAY': ':0', 01:26:40 INFO - 'HOME': '/home/cltbld', 01:26:40 INFO - 'LANG': 'en_US.UTF-8', 01:26:40 INFO - 'LANGUAGE': 'en_US:en', 01:26:40 INFO - 'LOGNAME': 'cltbld', 01:26:40 INFO - 'MAIL': '/var/mail/cltbld', 01:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:40 INFO - 'MOZ_NO_REMOTE': '1', 01:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:40 INFO - 'NO_EM_RESTART': '1', 01:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:40 INFO - 'PWD': '/builds/slave/test', 01:26:40 INFO - 'SHELL': '/bin/bash', 01:26:40 INFO - 'SHLVL': '1', 01:26:40 INFO - 'TERM': 'linux', 01:26:40 INFO - 'TMOUT': '86400', 01:26:40 INFO - 'USER': 'cltbld', 01:26:40 INFO - 'XDG_SESSION_COOKIE': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', 01:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:40 INFO - '_': '/tools/buildbot/bin/python'} 01:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:26:40 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 01:26:40 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 01:26:40 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 01:26:40 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 01:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 01:26:41 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)) 01:26:41 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)) 01:26:41 INFO - Installing collected packages: simplejson 01:26:41 INFO - Running setup.py install for simplejson 01:26:41 INFO - building 'simplejson._speedups' extension 01:26:41 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 01:26:42 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 01:26:42 INFO - Successfully installed simplejson 01:26:42 INFO - Cleaning up... 01:26:42 INFO - Return code: 0 01:26:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:26:42 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')]} 01:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:42 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')]} 01:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:42 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 0x1e2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f090>, '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 0x219fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2199f90>, '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': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', '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 01:26:42 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 01:26:42 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 01:26:42 INFO - Using env: {'DISPLAY': ':0', 01:26:42 INFO - 'HOME': '/home/cltbld', 01:26:42 INFO - 'LANG': 'en_US.UTF-8', 01:26:42 INFO - 'LANGUAGE': 'en_US:en', 01:26:42 INFO - 'LOGNAME': 'cltbld', 01:26:42 INFO - 'MAIL': '/var/mail/cltbld', 01:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:42 INFO - 'MOZ_NO_REMOTE': '1', 01:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:42 INFO - 'NO_EM_RESTART': '1', 01:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:42 INFO - 'PWD': '/builds/slave/test', 01:26:42 INFO - 'SHELL': '/bin/bash', 01:26:42 INFO - 'SHLVL': '1', 01:26:42 INFO - 'TERM': 'linux', 01:26:42 INFO - 'TMOUT': '86400', 01:26:42 INFO - 'USER': 'cltbld', 01:26:42 INFO - 'XDG_SESSION_COOKIE': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', 01:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:42 INFO - '_': '/tools/buildbot/bin/python'} 01:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:26:42 INFO - Cleaning up... 01:26:42 INFO - Return code: 0 01:26:42 INFO - Running post-action listener: _resource_record_post_action 01:26:42 INFO - Running post-action listener: _start_resource_monitoring 01:26:42 INFO - Starting resource monitoring. 01:26:42 INFO - [mozharness: 2017-09-14 08:26:42.768375Z] Finished create-virtualenv step (success) 01:26:42 INFO - [mozharness: 2017-09-14 08:26:42.768897Z] Running install step. 01:26:42 INFO - Running pre-action listener: _resource_record_pre_action 01:26:42 INFO - Running main action method: install 01:26:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:42 INFO - Reading from file tmpfile_stdout 01:26:42 INFO - Detecting whether we're running mozinstall >=1.0... 01:26:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:26:43 INFO - Reading from file tmpfile_stdout 01:26:43 INFO - Output received: 01:26:43 INFO - Usage: mozinstall [options] installer 01:26:43 INFO - Options: 01:26:43 INFO - -h, --help show this help message and exit 01:26:43 INFO - -d DEST, --destination=DEST 01:26:43 INFO - Directory to install application into. [default: 01:26:43 INFO - "/builds/slave/test"] 01:26:43 INFO - --app=APP Application being installed. [default: firefox] 01:26:43 INFO - mkdir: /builds/slave/test/build/application 01:26:43 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'] 01:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:27:00 INFO - Reading from file tmpfile_stdout 01:27:00 INFO - Output received: 01:27:00 INFO - /builds/slave/test/build/application/firefox/firefox 01:27:00 INFO - Running post-action listener: _resource_record_post_action 01:27:00 INFO - [mozharness: 2017-09-14 08:27:00.725343Z] Finished install step (success) 01:27:00 INFO - [mozharness: 2017-09-14 08:27:00.725471Z] Running setup-mitmproxy step. 01:27:00 INFO - Running pre-action listener: _resource_record_pre_action 01:27:00 INFO - Running main action method: setup_mitmproxy 01:27:00 INFO - Skipping: mitmproxy is not required 01:27:00 INFO - Running post-action listener: _resource_record_post_action 01:27:00 INFO - [mozharness: 2017-09-14 08:27:00.726003Z] Finished setup-mitmproxy step (success) 01:27:00 INFO - [mozharness: 2017-09-14 08:27:00.726107Z] Running run-tests step. 01:27:00 INFO - Running pre-action listener: _resource_record_pre_action 01:27:00 INFO - Running pre-action listener: _set_gcov_prefix 01:27:00 INFO - Running main action method: run_tests 01:27:00 WARNING - Try message not found. 01:27:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:27:00 INFO - Python 2.7.3 01:27:00 INFO - Return code: 0 01:27:00 INFO - grabbing minidump binary from tooltool 01:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:27:00 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 0x219f090>, '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 0x219fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2199f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:27:00 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 01:27:00 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 01:27:00 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 01:27:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:27:00 INFO - Return code: 0 01:27:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:27:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:27:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:27:00 INFO - ENV: RUST_BACKTRACE is now full 01:27:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:27:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:27:00 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/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 01:27:00 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/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 01:27:00 INFO - Using env: {'DISPLAY': ':0', 01:27:00 INFO - 'HOME': '/home/cltbld', 01:27:00 INFO - 'LANG': 'en_US.UTF-8', 01:27:00 INFO - 'LANGUAGE': 'en_US:en', 01:27:00 INFO - 'LOGNAME': 'cltbld', 01:27:00 INFO - 'MAIL': '/var/mail/cltbld', 01:27:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:27:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:00 INFO - 'MOZ_NO_REMOTE': '1', 01:27:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:00 INFO - 'NO_EM_RESTART': '1', 01:27:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:00 INFO - 'PWD': '/builds/slave/test', 01:27:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:27:00 INFO - 'RUST_BACKTRACE': 'full', 01:27:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:27:00 INFO - 'SHELL': '/bin/bash', 01:27:00 INFO - 'SHLVL': '1', 01:27:00 INFO - 'TERM': 'linux', 01:27:00 INFO - 'TMOUT': '86400', 01:27:00 INFO - 'USER': 'cltbld', 01:27:00 INFO - 'XDG_SESSION_COOKIE': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', 01:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:00 INFO - '_': '/tools/buildbot/bin/python'} 01:27:00 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/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 01:27:01 INFO - mozversion application_buildid: 20170914070342 01:27:01 INFO - mozversion application_changeset: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 01:27:01 INFO - mozversion application_display_name: Nightly 01:27:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:27:01 INFO - mozversion application_name: Firefox 01:27:01 INFO - mozversion application_remotingname: firefox 01:27:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:27:01 INFO - mozversion application_vendor: Mozilla 01:27:01 INFO - mozversion application_version: 57.0a1 01:27:01 INFO - mozversion platform_buildid: 20170914070342 01:27:01 INFO - mozversion platform_changeset: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 01:27:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:27:01 INFO - mozversion platform_version: 57.0a1 01:27:01 INFO - using testdate: 1505377621 01:27:01 INFO - actual date: 1505377621 01:27:01 INFO - starting webserver on 'localhost:59921' 01:27:01 INFO - SUITE-START | Running 2 tests 01:27:01 INFO - TEST-START | dromaeo_css 01:27:01 INFO - Initialising browser for dromaeo_css test... 01:27:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59921/getInfo.html -profile /tmp/tmpIppt4Z/profile 01:27:01 INFO - TEST-INFO | started process 1486 (/builds/slave/test/build/application/firefox/firefox http://localhost:59921/getInfo.html) 01:28:54 INFO - TEST-INFO | 1486: killed by SIGTERM 01:28:56 INFO - Browser initialized. 01:28:56 INFO - Running cycle 1/1 for dromaeo_css test... 01:28:56 INFO - Using env: {'DISPLAY': ':0', 01:28:56 INFO - 'HOME': '/home/cltbld', 01:28:56 INFO - 'JSGC_DISABLE_POISONING': '1', 01:28:56 INFO - 'LANG': 'en_US.UTF-8', 01:28:56 INFO - 'LANGUAGE': 'en_US:en', 01:28:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 01:28:56 INFO - 'LOGNAME': 'cltbld', 01:28:56 INFO - 'MAIL': '/var/mail/cltbld', 01:28:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:28:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:28:56 INFO - 'MOZ_CRASHREPORTER': '1', 01:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 01:28:56 INFO - 'MOZ_NO_REMOTE': '1', 01:28:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:56 INFO - 'NO_EM_RESTART': '1', 01:28:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:56 INFO - 'PWD': '/builds/slave/test', 01:28:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:28:56 INFO - 'RUST_BACKTRACE': 'full', 01:28:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:28:56 INFO - 'SHELL': '/bin/bash', 01:28:56 INFO - 'SHLVL': '1', 01:28:56 INFO - 'TERM': 'linux', 01:28:56 INFO - 'TMOUT': '86400', 01:28:56 INFO - 'USER': 'cltbld', 01:28:56 INFO - 'XDG_SESSION_COOKIE': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', 01:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:56 INFO - '_': '/tools/buildbot/bin/python'} 01:28:56 INFO - TEST-INFO | started process 1718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIppt4Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:28:57 INFO - PID 1718 | 01:28:57 INFO - PID 1718 | (/builds/slave/test/build/application/firefox/firefox:1770): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 01:28:57 INFO - PID 1718 | 01:29:08 INFO - PID 1718 | RSS: Main: 171597824 01:29:08 INFO - PID 1718 | 01:32:07 INFO - PID 1718 | Cycle 1(1): loaded http://localhost:59921/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59921/tests/dromaeo/cssquery-ext.html) 01:32:08 INFO - PID 1718 | RSS: Main: 168370176 01:32:08 INFO - PID 1718 | 01:35:10 INFO - PID 1718 | Cycle 1(1): loaded http://localhost:59921/tests/dromaeo/cssquery-ext.html (next: http://localhost:59921/tests/dromaeo/cssquery-jquery.html) 01:35:10 INFO - PID 1718 | RSS: Main: 168185856 01:35:10 INFO - PID 1718 | 01:38:12 INFO - PID 1718 | Cycle 1(1): loaded http://localhost:59921/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59921/tests/dromaeo/cssquery-mootools.html) 01:38:12 INFO - PID 1718 | RSS: Main: 168849408 01:38:12 INFO - PID 1718 | 01:41:14 INFO - PID 1718 | Cycle 1(1): loaded http://localhost:59921/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59921/tests/dromaeo/cssquery-prototype.html) 01:41:14 INFO - PID 1718 | RSS: Main: 168267776 01:41:14 INFO - PID 1718 | 01:44:18 INFO - PID 1718 | Cycle 1(1): loaded http://localhost:59921/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59921/tests/dromaeo/cssquery-yui.html) 01:44:18 INFO - PID 1718 | RSS: Main: 169705472 01:44:18 INFO - PID 1718 | 01:47:20 INFO - PID 1718 | Cycle 1(1): loaded http://localhost:59921/tests/dromaeo/cssquery-yui.html (next: http://localhost:59921/tests/dromaeo/cssquery-dojo.html) 01:47:20 INFO - PID 1718 | RSS: Main: 171917312 01:47:20 INFO - PID 1718 | 01:47:20 INFO - PID 1718 | __start_tp_report 01:47:20 INFO - PID 1718 | _x_x_mozilla_page_load 01:47:20 INFO - PID 1718 | _x_x_mozilla_page_load_details 01:47:20 INFO - PID 1718 | |i|pagename|runs| 01:47:20 INFO - PID 1718 | |0;dojo.html;3803.676687481564;3819.5798462169155;3859.9228015439676;3906.589808070151;3919.8432062717493;6021.126936594192;6210.503159747221;6245.188125543685;6297.275813281474;6358.109864618951;6219.875602487948;6255.186825712651;6332.936670633292;6341.904871426932;6343.333949935248;5502.0921547944545;5604.859878503029;5606.439356064381;5664.575156863231;5666.716664166795;5339.999805073913;5528.889422211553;5645.15322701596;5681.914771278434;5700.543956483492;5506.063969125258;5545.77816887324;5606.971965140189;5626.831195064155;5706.28671416073;5546.306711661043;5560.36055853578;5599.244102046212;5605.887882242332;5639.68981706006;5559.694216818073;5619.859503512404;5620.775168993236;5628.099504079328;5641.746121424546;6272.56092073555;6277.623342599459;6346.619202847844;6359.936400635981;6365.267994180682;6664.100346453215;6714.160729908762;6716.697748601325;6798.388145066968;6862.451003919675;6777.356151165632;6793.4225590824835;6866.279040700704;6878.209005964278;6931.480138989546;6262.968685156545;6411.903821442682;6426.1003459515705;6428.035794630796;6431.356864313578;6959.547629404073;6970.372666460043;7056.259092795285;7062.823429414203;7062.858742825115;6616;6678.9332106679285;6688.163979502562;6733.663316834139;6849.315068493111;6867.690953907087;6898.586084834926;6912.4815638826285;6914.723411063602;6932.861342773116;6683.799486015428;6723.932760672428;6725.932740672531;6767.898481522781;6803.65981700913;6823.829404264834;6844.691988860513;6852.040714300002;6863.210730766026;6872.41584465316;4979.377577802775;4982;5041.470645582234;5042.546170844568;5046.44489106198;4423.756693381831;4504.031633198812;4510.503844577094;4542.205114105019;4548.909021819545;6222.471089957405;6225.875482490324;6233.252009758858;6253.6873156342;6257.749690012349;6799.660016999131;6831.59010459374;6846.246912839583;6880.58716477013;6895.75864844728;6122.908156377658;6199.132121502993;6240.843978900564;6243.719032643542;6262.1546091278005;5388.110961691355;5452.236686863842;5492.752826122834;5495.670259784426;5518.779248830082;7078.929210707827;7123.643817809088;7125.50121491501;7131.536450130725;7134.714611415589;6663;6750.594964302158;6752.729890804411;6848.452123830181;6872.10662613857;6914.585124892523;7018.298170183145;7020.122484689414;7036.648167591702;7100.112485939258;6752.324767523405;6752.459803215829;6765.729370825112;6791.04925310447;6799.014142949146;6839.418649414855;6854.074699915647;6863.210730766026;6932.410745086724;6939.618320992394;6501.6424096673245;6502.122213501117;6509.349065093642;6579.835504112435;6615.966920165561;6490.188726409199;6562.114114594659;6562.737490500517;6571.145751052332;6579.605223686594;6369.777057802955;6377.74489020434;6412.6793660317735;6438.742450302123;6452.257990331172;6359.17330747;6376.39424254695;6430.228372595318;6506.219253689587;6581.769638062645;6320.778772742932;6381.87236255263;6389.904151437825;6420.357964203542;6490.643014634052 01:47:20 INFO - PID 1718 | |1;ext.html;941.1012483078658;943.2642538819723;968.2060710217621;994.5425104451951;998.5606333213385;42879.571204287946;44659.999999999956;44718.55281447185;45001.77499112504;45003.77498112513;41200.38199427011;41302.38046429306;41411.58588414123;41427.58572414275;41646.791766041126;7362.889556656654;7468.58922759248;7477;7482.700691972314;7489.850202995937;7091.89362159568;7092.751753688622;7095.971084192789;7117.501774875761;7131.037309963141;7968.482048666847;8081.595920203996;8148.062972758149;8151.429399942006;8159.714409995651;8022.318102961255;8049.235322644339;8052;8077.838443231132;8086.312663423616;7878.330341920886;7954.125046244909;7957;7972.641231144612;8127.390445716535;39780.602193978266;39783;40813.59186408157;41273.79363103196;41298.58701413008;3813.161104556993;3861.6524512793985;3864.3044252034624;3866.2074274773604;3866.6906647468136;33835.15412114692;33913.32173356519;34000.489992649884;34030.319393611986;34173.48739768905;5537.612367134302;5566.192902029183;5569.582281328876;5598.664080155204;5607.299087614048;236604;240463.99999999825;240508;240607;240713;54729.1790623141;54900.72549637226;55130.72434637801;55286;55300;57513;57649;57716;57863;57963.13055304174;16529.421470248722;16907.83092169087;16937.407190748265;16951.660966780597;16954.830451695572;13505.932470337586;13570.93214533921;13639.931800340935;13668.111572747739;13691.520796772065;15578;15884.76172857408;15904.522864314089;15963.680726385408;15981.520554383387;6433.260175079926;6433.356664333529;6511.186101737283;6540.607563546202;6669.533132680763;1085.9076978456762;1098.3519723363254;1100.9119270458343;1103.448275862069;1105.4748994227677;24676.38309042288;25106.372340691265;25315.87342063278;25322.74677253204;25464;1204.879462100255;1209.5041033176356;1211.1885037025215;1216.9391530423443;1219.201423067892;13185.73628527424;13268.867311326956;13343;13439.328033598282;13532.255725935169;289470;291188;291612;291920;292613;59134.704326478095;59850;63577.68211158914;63807.68096159583;64188;1452.2666053642843;1499.1155218420965;1500.8499150084904;1508.7585986242148;1510.886683498742;30364;30405.695943040286;30462.390752185274;30639;30776.076717698506;42679;42721;42780.35829462498;42867.356989644555;42877.78561107175;249310;251472;252263;253308;253334;36955;36975;37069.62930370662;37077.258454831295;37312.880613581634;45880.77059614681;46936.29595556001;46971.29543056789;47196.7640161797;47426.28860567163;34946.30107397787;35002.824985874904;35014.47478287879;35054;35603.287934241685;34279;34481.482777757854;35152;35261.471077934366;35305;40307.1938561233;41098.383524246565;41270.38094428526;41431.72125533125;41549.37675934924;33621.66378336185;34161.658383415845;34252.657473424944;34619.30761384808;34652.48021279633;24702.163144400183;24832;25443.569240562192;25457.745422545537;25618.694317510766 01:47:20 INFO - PID 1718 | |2;jquery.html;597.6414151509096;603.56844855928;613.2058983616216;618.3414663383496;628.6102616377847;22543.210987615435;23199.652005219934;23246.883765581148;23282.65076023861;23295.650565241536;23743.287701368987;25254.36864078399;25352;25378.873105634448;25410.745892541116;6672.466202703772;6718.193816741998;6755.054292399068;6757.493188010894;6813.250542440328;6496.675166241693;6627.469802415795;6695.933040669604;6735.629540375277;6745.291744366845;6710.396064354231;6711.798646040626;6713.899291510631;6715.227748808877;6721.798346049602;6693.4979876509215;6703.195616526048;6707.429868461187;6710.16122984627;6716.1269035025625;5865.296164460249;6043.8186854394;6069.119977603223;6073.817785466443;6245.281792593819;30115.397692046256;30648.540271895938;30690;30693.69306306953;30713;2199.8790066546335;2216.944576385587;2230.7992280694816;2232.319142661504;2234.1510226113974;19171.424857254166;19569.510762230915;19847.305344313023;19934.202631894706;20297.391078267676;2507.4358269389422;2530.3168144600854;2570.897164113433;2572.935676608081;2574.266334094793;125212.37393812972;129876.35061824725;130438;141919;149520.2523987373;15060.590305551279;15348.462803801813;15832.60418489547;16100.114493702958;16175.514734557746;25820.225393238234;25960;25966.35084122912;25977.610335844976;26030.219093427226;10183.287169898036;10216.897831021595;10443.582256709798;10488.947555262328;10561.735956600993;9268.119528644902;9349.924758652705;9353.485558294224;9355.29835262358;9516.143547080796;9662.516874156405;9678.128968392879;9819.459929703935;9832.803343933225;10001.749956251151;2785.4011387551773;2834.801563890508;2875.159897665496;2932.648082230146;2974.8810047597854;1024.9180065594735;1038.4755698372273;1042.890496497872;1044.1751016696724;1060.1995493402433;20285.695714564292;20319.898400507904;20358.491037724176;20749.68875466839;20764.792352076587;1064.818980773255;1095.4007149561728;1095.6055819904827;1106.7399161197113;1115.0967716149944;11102;11289.20975531705;11358.886411135783;11385.08919286455;11455.656330309937;587140;601433;606399;612822;622570;127004;127256;130764;133694;133940;1095.2552264460085;1124.1512657943201;1209.7459533497888;1238.6160290310033;1240.5347994502242;21155.682664759734;21287.8935605321;21451.034703438694;21783.891080544498;21847.67228491542;60092.69953650204;60148;60999;61656.383436165066;62761.37238627555;79480.60259698665;79626.6018669903;79919;80315.59842200752;80483;14855.554333370017;14953.925230373778;14957.326920288395;15049.398024078915;15064.246787660792;22957.655635165152;23044.078236870337;23058.308250752503;23292.951817168607;23308.417289567897;18950.810491894903;19070.33253836109;19165;19435.416937491897;19673.803261967198;16305.755413669041;16808.57978550497;16877.915610422362;17001.914990424968;17461.30154793794;19288.324908628132;19480.707789382886;19545.609087818448;19547.51131221731;19704.40886773399;14636.04865683727;14849.480268190562;14851.628709282355;14854.777178342118;14862.925685371936;18802.341918032802;18820.341288054853;19051.33320333837;19077.236910523425;19250.326238581583 01:47:20 INFO - PID 1718 | |3;mootools.html;1421.7796241582553;1468.8188040759464;1480.2006916265218;1491.2916364726764;1494.8280947691014;16629.83370166298;17358.47924562262;17374.044427556495;17384.913075434637;17392.82607173928;17095.658086838255;17136.571585710364;17152.39966601166;17181.570460738458;17182.312707491717;2882.6108475355823;2912.8689208985543;2926.151416089342;2926.7073292670775;2942.9411411771753;2669.292637451077;2811.11449893284;2827.363843135299;2829.052267490393;2833.3624934389804;2709.011210908014;2930.7801914856364;2932.1057077591327;2933.149386677861;2934.3397735509448;2778.7360200780895;2794.5668421394716;2847.288177955511;2872.741453269195;2877.036192875389;2753.876075576604;2840.4887120318335;2868.512352900012;2957.467655821951;2959.067893613505;16687.08221047842;16746.49760507187;16793;16801.24394402255;16837.24232409532;8671.523066231355;8946.105389461067;9011.819763604692;9011.819763604757;9025.368224224307;5802.477777000048;5901.23283973085;5973.596204891847;6003.519718422515;6039.214902062704;1910.3218357483172;1914.7032210007471;1930.9227630894748;1953.4823271832975;1960.4314748722995;31024.0692779217;31257.37485250305;31312.37375252482;31333.529997050064;31389.215269617984;7088.893666595005;7137;7149.964250178716;7337.26627337262;7395;19779.901100494404;19783.604327913363;19787.604247914962;19798.802011979697;19802.801971980385;8518.74443766688;8688.435251708619;8721.258693011037;8745.169208925143;8772.429792063496;7892.4869883457395;7917.7624671259955;7935.166807485131;8037.557934313669;8040.959795200986;5187.221916712523;5396.244525766396;5439.864003399867;5449.100898351807;5504.4770746778995;1662.426462870308;1664.176232764765;1682.3943380383052;1684.730443129118;1708.7009773289624;983.2134292565919;986.0927946289288;988.5600907596195;1013.4729940430934;1015.8120747661559;8388.454750441202;8405.285550728135;8549.957250213709;8668.913310866938;8763.649454021768;747.3012733094574;774.9418793590503;782.194339829976;795.2564352330589;801.5831767480877;5725.885482290331;5944.108383742473;5962.433568810956;6162.753489860355;6226.470749986212;24042.63936040961;24711.38221544476;25202.117925872506;25478.617820732703;25586.48827023449;25096.49421034744;25100.372490687878;25103.874480627845;25194.118205862706;25408.618870716953;11789.174757766874;12432.56486023003;12495.125341226209;12497.562585309652;12561.309127998047;9546.85679714791;9578.90421095808;9593.13661770444;9593.568289426852;9702.466364350028;20703.17187312551;20911.477213069797;20917.1633134679;21542.892285538474;21955.560888782453;22024.44938876477;22132.88933555322;22397.66403503916;22404.551908962054;22960.19639312616;11926.761464770829;12124.515019399478;12130;12190.268583884996;12209.511619535118;15195;15231.92384038117;15366.846331536988;15382.230888455757;15401;11845.703857403634;12087.879121209027;12116.818247726114;12298;12329.815052774036;12137.271763694207;12244.265344079384;12365.938170309451;12384.56654017105;12459.190152640049;11059.115270778479;11352.716182095513;11362.03422709079;11362.54549818031;11366.204365694322;8292.917070829215;8324.084350721538;8383.119772423808;8398.328133749408;8480.321574274167;8270.131636178356;8314.875276870973;8406;8430.072692003752;8430.946131733534 01:47:20 INFO - PID 1718 | |4;prototype.html;563.3270133217884;571.5827445964444;584.544055636603;592.6740292838939;596.668848788922;6200.496719353568;6271.937280627192;6278.748850046004;6279.9999999999945;6337.302896681373;6198.194234749488;6214.5649804513705;6257.124002639623;6264.498840092793;6309.810705678826;5030.924536131952;5092.8472145835685;5106.208537676666;5110.156824124034;5117.769700363474;4854.805807767702;5021.548060674539;5107.514786095315;5130.358705161855;5155.226715992612;4912.21404575268;4917.532834380728;4931.753412329387;4942.973380913826;4955.900881982358;4885.169521181408;4914.901701965959;4956.653034287619;4971.627127965381;4972.5276098770555;4471.329300604935;4477.597016268519;4478.977605111986;4482.9551704482865;4495.303227999665;6175.07373893915;6181.876362472725;6201.627902325875;6252.4673559439225;6252.749890004395;5847.8012007538355;5913.319968203668;5917.094717486439;5925.792597259076;5935.703214839284;6590;6632.900506492407;6646.700898459581;6697.799066028027;6721.958096495051;4884.776047808429;5068.822591209327;5083.389993200803;5097;5103.336566246401;6697.799066028027;6848.7260509580055;6875.690593923286;6890.31096890312;6967.6864541095265;5141.0232055909255;5165.870853228625;5180.818671346485;5191.117510023305;5199.090159222121;5247.003069416799;5272.815451459181;5279.683219006872;5279.947200527946;5280.735963201824;5822.82531524055;5824.767009319579;5826.82519524415;5835.503982161479;5856.690969602161;6649.335066493312;6649.73401063952;6649.803035453665;6659.501612137327;6669.533132680763;1817.1731862002757;1817.1822679794145;1819.8999055051834;1822.7265910113324;1831.716084006981;1197.0060144405243;1248.6628610275175;1256.145820841818;1266.645339304996;1267.8161666558483;6069.696515174223;6104.755809767559;6118.663473508911;6130.908036379458;6155.969220153871;6677.833054173684;6721.798346049626;6773.458123350219;6798.252192258848;6799.456043516507;6082.239720034996;6108.511319094462;6131.417515336036;6134.325224225332;6143.815685529441;3358.95103986568;3500.8774692886136;3514.9824250878582;3535.8585656573964;3540.7875527468436;6845.726170953206;6847.589144651337;6858.451323894076;6967.54710943787;7019.227884932653;6773.324536807933;6792.592444453348;6821.703876263494;6866.656667166621;6929.272426395156;6960.721571137098;7010.228874823765;7022.683979220845;7037.683304251321;7067.116610423697;6684.665766711548;6721.966390168018;6722.731090756315;6750.717363700881;6800.251972283144;6517.3808488193545;6570.244421891352;6591.967040164768;6631.038499417654;6678.83302917431;6835.521513494206;6880.518363714692;6887.793366199022;6896.310368963063;6977.7208911642965;4988.906877735827;5074.822381216787;5088.295421033847;5089.770960306869;5108.489151084862;6500.187476565429;6534.8366290843105;6756.594604323756;6786.69459874297;6870.7595234166565;6312.431881130537;6326.936730632819;6341.619502829845;6463.256725476443;6482.643454610042;6349.428551430208;6356.252030691597;6408.166938297992;6513.837154071186;6553.836154096186;6403.743850245938;6427.325130861379;6444.452221561032;6462.515311351762;6482.384173503509;6539.444147247347;6540.182477190351;6545.116409284686;6597.416620011067;6612.603243805194;6342;6358.427741503287;6411.647359395278;6435.935640643534;6441.227052753512 01:47:20 INFO - PID 1718 | |5;yui.html;969.8787651543557;980.9509524523772;996.9651062212824;1001.6594357918307;1001.9048190421912;18893.811061889377;19563.706544401844;19626.705599415985;19673.114709838057;19724.605507889835;19296;19531.5117122072;19563.902180489113;19588.902055489703;19594;1024.3188279793928;1035.2184101003731;1036.7926414717049;1039.8232300508932;1041.9687409377693;1076.1068313299982;1076.773877485729;1077.5474300793646;1079.535799606173;1079.9514021869036;1091.323379504708;1124.668222874254;1127.870294916087;1133.9886601134008;1135.8636963564343;1114.4260705736551;1118.725912151524;1121.831725241212;1122.0967121467215;1122.354646078508;781.5662307419379;810.9837803243961;816.4366587054913;818.0183779464667;832.0514613340796;19104.713429298572;19277.132529036226;19340.903295483575;19377.224911003545;19469.51326216856;21953.67069493943;22008.88995555012;22993.885030574907;23209.651855222186;23258.883705581364;18431.539211519685;18512.814871851242;18612.34856780006;18619.1621377037;18814.529636759053;3926.038120660428;3955.584663610337;3956.2285354355913;3957.465742124834;3958.7426817257074;129491;159693.20153399158;161504;164555;164923;17774.555636109202;17985.280588776564;18348;18365.26538938454;18393.52851771855;33986.83006584951;34471.4829277561;34491.65508344935;34582.13544661403;34728.65271347305;9636.373635713657;9803.362781419184;9839.704808855746;9849.359791613522;9874.851877221847;4311.741295522279;4333.696641235147;4375.934360984587;4412.0734645724115;4417.558244175621;5868;5978.342382337939;5978.611390259619;5979.5515336349945;5983.072623743326;1104.9558017679365;1146.747715502588;1157.242006485753;1165.685264978451;1172.2380452705638;740.8999785028952;754.9622518874035;759.734093067422;764.7705688293489;771.5794891783879;13931.233782142079;13991.650208744863;14107.506237281646;15006.249687515581;15245.847541524665;685.1264637587117;691.1257259566652;691.325957191734;705.002421573478;710.9680064397114;6029.859689419249;6147.72335244915;6167.938320616826;6178.62928224308;6189.04069869171;142449.0893533798;143846.2807685955;147787.04425911422;150805;151966;130713;130772.69227307606;132215.33892330478;133297;135172;109564.4521777386;111114;111992.44003780092;113347.4332628348;113499;11379.367213229505;11410.429478526206;11634.883651163718;11868.940655296668;11963.222390544586;54106.729466352415;55371.723141384035;55653.44346556483;56101;57559.42440575541;70515.29484705087;70525.64737176281;70879.29120708727;71033.28966710267;71584.64207678929;17156.742648860527;17394.73907891357;17402.47792566225;17525.649487009934;17609.20758565842;19596.314129005415;19716.40850774479;19758.506037348605;19889.403317900487;19999;19107.331243406414;19471.4158575243;19480.318188863323;19544.31594894172;19680.60638787245;15410.614734631725;15559.144247066068;15668.608284792972;15687.843121568638;15762;18792.342268020555;18923.243070277036;19031.619367612846;19218.807811921703;19300.517487062934;12803.551875684307;12831.807522886977;13108.934455327662;13113.475460981454;13241.404136814059;13727;13735.24456154921;13830.308484575933;13869.306534673024;14034.438622455396 01:47:20 INFO - PID 1718 | __end_tp_report 01:47:20 INFO - PID 1718 | __start_cc_report 01:47:20 INFO - PID 1718 | _x_x_mozilla_cycle_collect,328 01:47:20 INFO - PID 1718 | __end_cc_report 01:47:20 INFO - PID 1718 | __startTimestamp1505378840487__endTimestamp 01:47:20 INFO - PID 1718 | 01:47:20 INFO - PID 1718 | ------- Summary: start ------- 01:47:20 INFO - PID 1718 | Number of tests: 6 01:47:20 INFO - PID 1718 | 01:47:20 INFO - PID 1718 | [#0] dojo.html Cycles:165 Average:6247.08 Median:6428.04 stddev:751.24 (11.7%) stddev-sans-first:728.68 01:47:20 INFO - PID 1718 | Values: 3803.7 3819.6 3859.9 3906.6 3919.8 6021.1 6210.5 6245.2 6297.3 6358.1 6219.9 6255.2 6332.9 6341.9 6343.3 5502.1 5604.9 5606.4 5664.6 5666.7 5340.0 5528.9 5645.2 5681.9 5700.5 5506.1 5545.8 5607.0 5626.8 5706.3 5546.3 5560.4 5599.2 5605.9 5639.7 5559.7 5619.9 5620.8 5628.1 5641.7 6272.6 6277.6 6346.6 6359.9 6365.3 6664.1 6714.2 6716.7 6798.4 6862.5 6777.4 6793.4 6866.3 6878.2 6931.5 6263.0 6411.9 6426.1 6428.0 6431.4 6959.5 6970.4 7056.3 7062.8 7062.9 6616.0 6678.9 6688.2 6733.7 6849.3 6867.7 6898.6 6912.5 6914.7 6932.9 6683.8 6723.9 6725.9 6767.9 6803.7 6823.8 6844.7 6852.0 6863.2 6872.4 4979.4 4982.0 5041.5 5042.5 5046.4 4423.8 4504.0 4510.5 4542.2 4548.9 6222.5 6225.9 6233.3 6253.7 6257.7 6799.7 6831.6 6846.2 6880.6 6895.8 6122.9 6199.1 6240.8 6243.7 6262.2 5388.1 5452.2 5492.8 5495.7 5518.8 7078.9 7123.6 7125.5 7131.5 7134.7 6663.0 6750.6 6752.7 6848.5 6872.1 6914.6 7018.3 7020.1 7036.6 7100.1 6752.3 6752.5 6765.7 6791.0 6799.0 6839.4 6854.1 6863.2 6932.4 6939.6 6501.6 6502.1 6509.3 6579.8 6616.0 6490.2 6562.1 6562.7 6571.1 6579.6 6369.8 6377.7 6412.7 6438.7 6452.3 6359.2 6376.4 6430.2 6506.2 6581.8 6320.8 6381.9 6389.9 6420.4 6490.6 01:47:20 INFO - PID 1718 | 01:47:20 INFO - PID 1718 | [#1] ext.html Cycles:180 Average:44183.76 Median:3837.41 stddev:68202.01 (1777.3%) stddev-sans-first:68316.05 01:47:20 INFO - PID 1718 | Values: 941.1 943.3 968.2 994.5 998.6 42879.6 44660.0 44718.6 45001.8 45003.8 41200.4 41302.4 41411.6 41427.6 41646.8 7362.9 7468.6 7477.0 7482.7 7489.9 7091.9 7092.8 7096.0 7117.5 7131.0 7968.5 8081.6 8148.1 8151.4 8159.7 8022.3 8049.2 8052.0 8077.8 8086.3 7878.3 7954.1 7957.0 7972.6 8127.4 39780.6 39783.0 40813.6 41273.8 41298.6 3813.2 3861.7 3864.3 3866.2 3866.7 33835.2 33913.3 34000.5 34030.3 34173.5 5537.6 5566.2 5569.6 5598.7 5607.3 236604.0 240464.0 240508.0 240607.0 240713.0 54729.2 54900.7 55130.7 55286.0 55300.0 57513.0 57649.0 57716.0 57863.0 57963.1 16529.4 16907.8 16937.4 16951.7 16954.8 13505.9 13570.9 13639.9 13668.1 13691.5 15578.0 15884.8 15904.5 15963.7 15981.5 6433.3 6433.4 6511.2 6540.6 6669.5 1085.9 1098.4 1100.9 1103.4 1105.5 24676.4 25106.4 25315.9 25322.7 25464.0 1204.9 1209.5 1211.2 1216.9 1219.2 13185.7 13268.9 13343.0 13439.3 13532.3 289470.0 291188.0 291612.0 291920.0 292613.0 59134.7 59850.0 63577.7 63807.7 64188.0 1452.3 1499.1 1500.8 1508.8 1510.9 30364.0 30405.7 30462.4 30639.0 30776.1 42679.0 42721.0 42780.4 42867.4 42877.8 249310.0 251472.0 252263.0 253308.0 253334.0 36955.0 36975.0 37069.6 37077.3 37312.9 45880.8 46936.3 46971.3 47196.8 47426.3 34946.3 35002.8 35014.5 35054.0 35603.3 34279.0 34481.5 35152.0 35261.5 35305.0 40307.2 41098.4 41270.4 41431.7 41549.4 33621.7 34161.7 34252.7 34619.3 34652.5 24702.2 24832.0 25443.6 25457.7 25618.7 01:47:20 INFO - PID 1718 | 01:47:20 INFO - PID 1718 | [#2] jquery.html Cycles:180 Average:39115.12 Median:12388.68 stddev:101014.72 (815.4%) stddev-sans-first:101256.69 01:47:20 INFO - PID 1718 | Values: 597.6 603.6 613.2 618.3 628.6 22543.2 23199.7 23246.9 23282.7 23295.7 23743.3 25254.4 25352.0 25378.9 25410.7 6672.5 6718.2 6755.1 6757.5 6813.3 6496.7 6627.5 6695.9 6735.6 6745.3 6710.4 6711.8 6713.9 6715.2 6721.8 6693.5 6703.2 6707.4 6710.2 6716.1 5865.3 6043.8 6069.1 6073.8 6245.3 30115.4 30648.5 30690.0 30693.7 30713.0 2199.9 2216.9 2230.8 2232.3 2234.2 19171.4 19569.5 19847.3 19934.2 20297.4 2507.4 2530.3 2570.9 2572.9 2574.3 125212.4 129876.4 130438.0 141919.0 149520.3 15060.6 15348.5 15832.6 16100.1 16175.5 25820.2 25960.0 25966.4 25977.6 26030.2 10183.3 10216.9 10443.6 10488.9 10561.7 9268.1 9349.9 9353.5 9355.3 9516.1 9662.5 9678.1 9819.5 9832.8 10001.7 2785.4 2834.8 2875.2 2932.6 2974.9 1024.9 1038.5 1042.9 1044.2 1060.2 20285.7 20319.9 20358.5 20749.7 20764.8 1064.8 1095.4 1095.6 1106.7 1115.1 11102.0 11289.2 11358.9 11385.1 11455.7 587140.0 601433.0 606399.0 612822.0 622570.0 127004.0 127256.0 130764.0 133694.0 133940.0 1095.3 1124.2 1209.7 1238.6 1240.5 21155.7 21287.9 21451.0 21783.9 21847.7 60092.7 60148.0 60999.0 61656.4 62761.4 79480.6 79626.6 79919.0 80315.6 80483.0 14855.6 14953.9 14957.3 15049.4 15064.2 22957.7 23044.1 23058.3 23293.0 23308.4 18950.8 19070.3 19165.0 19435.4 19673.8 16305.8 16808.6 16877.9 17001.9 17461.3 19288.3 19480.7 19545.6 19547.5 19704.4 14636.0 14849.5 14851.6 14854.8 14862.9 18802.3 18820.3 19051.3 19077.2 19250.3 01:47:20 INFO - PID 1718 | 01:47:20 INFO - PID 1718 | [#3] mootools.html Cycles:180 Average:10493.10 Median:2786.65 stddev:7799.28 (279.9%) stddev-sans-first:7791.38 01:47:20 INFO - PID 1718 | Values: 1421.8 1468.8 1480.2 1491.3 1494.8 16629.8 17358.5 17374.0 17384.9 17392.8 17095.7 17136.6 17152.4 17181.6 17182.3 2882.6 2912.9 2926.2 2926.7 2942.9 2669.3 2811.1 2827.4 2829.1 2833.4 2709.0 2930.8 2932.1 2933.1 2934.3 2778.7 2794.6 2847.3 2872.7 2877.0 2753.9 2840.5 2868.5 2957.5 2959.1 16687.1 16746.5 16793.0 16801.2 16837.2 8671.5 8946.1 9011.8 9011.8 9025.4 5802.5 5901.2 5973.6 6003.5 6039.2 1910.3 1914.7 1930.9 1953.5 1960.4 31024.1 31257.4 31312.4 31333.5 31389.2 7088.9 7137.0 7150.0 7337.3 7395.0 19779.9 19783.6 19787.6 19798.8 19802.8 8518.7 8688.4 8721.3 8745.2 8772.4 7892.5 7917.8 7935.2 8037.6 8041.0 5187.2 5396.2 5439.9 5449.1 5504.5 1662.4 1664.2 1682.4 1684.7 1708.7 983.2 986.1 988.6 1013.5 1015.8 8388.5 8405.3 8550.0 8668.9 8763.6 747.3 774.9 782.2 795.3 801.6 5725.9 5944.1 5962.4 6162.8 6226.5 24042.6 24711.4 25202.1 25478.6 25586.5 25096.5 25100.4 25103.9 25194.1 25408.6 11789.2 12432.6 12495.1 12497.6 12561.3 9546.9 9578.9 9593.1 9593.6 9702.5 20703.2 20911.5 20917.2 21542.9 21955.6 22024.4 22132.9 22397.7 22404.6 22960.2 11926.8 12124.5 12130.0 12190.3 12209.5 15195.0 15231.9 15366.8 15382.2 15401.0 11845.7 12087.9 12116.8 12298.0 12329.8 12137.3 12244.3 12365.9 12384.6 12459.2 11059.1 11352.7 11362.0 11362.5 11366.2 8292.9 8324.1 8383.1 8398.3 8480.3 8270.1 8314.9 8406.0 8430.1 8430.9 01:47:20 INFO - PID 1718 | 01:47:20 INFO - PID 1718 | [#4] prototype.html Cycles:180 Average:5604.32 Median:6233.52 stddev:1564.33 (25.1%) stddev-sans-first:1522.27 01:47:20 INFO - PID 1718 | Values: 563.3 571.6 584.5 592.7 596.7 6200.5 6271.9 6278.7 6280.0 6337.3 6198.2 6214.6 6257.1 6264.5 6309.8 5030.9 5092.8 5106.2 5110.2 5117.8 4854.8 5021.5 5107.5 5130.4 5155.2 4912.2 4917.5 4931.8 4943.0 4955.9 4885.2 4914.9 4956.7 4971.6 4972.5 4471.3 4477.6 4479.0 4483.0 4495.3 6175.1 6181.9 6201.6 6252.5 6252.7 5847.8 5913.3 5917.1 5925.8 5935.7 6590.0 6632.9 6646.7 6697.8 6722.0 4884.8 5068.8 5083.4 5097.0 5103.3 6697.8 6848.7 6875.7 6890.3 6967.7 5141.0 5165.9 5180.8 5191.1 5199.1 5247.0 5272.8 5279.7 5279.9 5280.7 5822.8 5824.8 5826.8 5835.5 5856.7 6649.3 6649.7 6649.8 6659.5 6669.5 1817.2 1817.2 1819.9 1822.7 1831.7 1197.0 1248.7 1256.1 1266.6 1267.8 6069.7 6104.8 6118.7 6130.9 6156.0 6677.8 6721.8 6773.5 6798.3 6799.5 6082.2 6108.5 6131.4 6134.3 6143.8 3359.0 3500.9 3515.0 3535.9 3540.8 6845.7 6847.6 6858.5 6967.5 7019.2 6773.3 6792.6 6821.7 6866.7 6929.3 6960.7 7010.2 7022.7 7037.7 7067.1 6684.7 6722.0 6722.7 6750.7 6800.3 6517.4 6570.2 6592.0 6631.0 6678.8 6835.5 6880.5 6887.8 6896.3 6977.7 4988.9 5074.8 5088.3 5089.8 5108.5 6500.2 6534.8 6756.6 6786.7 6870.8 6312.4 6326.9 6341.6 6463.3 6482.6 6349.4 6356.3 6408.2 6513.8 6553.8 6403.7 6427.3 6444.5 6462.5 6482.4 6539.4 6540.2 6545.1 6597.4 6612.6 6342.0 6358.4 6411.6 6435.9 6441.2 01:47:20 INFO - PID 1718 | 01:47:20 INFO - PID 1718 | [#5] yui.html Cycles:180 Average:28053.62 Median:19068.17 stddev:41696.74 (218.7%) stddev-sans-first:41764.11 01:47:20 INFO - PID 1718 | Values: 969.9 981.0 997.0 1001.7 1001.9 18893.8 19563.7 19626.7 19673.1 19724.6 19296.0 19531.5 19563.9 19588.9 19594.0 1024.3 1035.2 1036.8 1039.8 1042.0 1076.1 1076.8 1077.5 1079.5 1080.0 1091.3 1124.7 1127.9 1134.0 1135.9 1114.4 1118.7 1121.8 1122.1 1122.4 781.6 811.0 816.4 818.0 832.1 19104.7 19277.1 19340.9 19377.2 19469.5 21953.7 22008.9 22993.9 23209.7 23258.9 18431.5 18512.8 18612.3 18619.2 18814.5 3926.0 3955.6 3956.2 3957.5 3958.7 129491.0 159693.2 161504.0 164555.0 164923.0 17774.6 17985.3 18348.0 18365.3 18393.5 33986.8 34471.5 34491.7 34582.1 34728.7 9636.4 9803.4 9839.7 9849.4 9874.9 4311.7 4333.7 4375.9 4412.1 4417.6 5868.0 5978.3 5978.6 5979.6 5983.1 1105.0 1146.7 1157.2 1165.7 1172.2 740.9 755.0 759.7 764.8 771.6 13931.2 13991.7 14107.5 15006.2 15245.8 685.1 691.1 691.3 705.0 711.0 6029.9 6147.7 6167.9 6178.6 6189.0 142449.1 143846.3 147787.0 150805.0 151966.0 130713.0 130772.7 132215.3 133297.0 135172.0 109564.5 111114.0 111992.4 113347.4 113499.0 11379.4 11410.4 11634.9 11868.9 11963.2 54106.7 55371.7 55653.4 56101.0 57559.4 70515.3 70525.6 70879.3 71033.3 71584.6 17156.7 17394.7 17402.5 17525.6 17609.2 19596.3 19716.4 19758.5 19889.4 19999.0 19107.3 19471.4 19480.3 19544.3 19680.6 15410.6 15559.1 15668.6 15687.8 15762.0 18792.3 18923.2 19031.6 19218.8 19300.5 12803.6 12831.8 13108.9 13113.5 13241.4 13727.0 13735.2 13830.3 13869.3 14034.4 01:47:20 INFO - PID 1718 | -------- Summary: end -------- 01:47:20 INFO - PID 1718 | 01:47:23 INFO - TEST-INFO | 1718: exit 0 01:47:23 INFO - TEST-OK | dromaeo_css | took 1222185ms 01:47:23 INFO - TEST-START | kraken 01:47:23 INFO - Initialising browser for kraken test... 01:47:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59921/getInfo.html -profile /tmp/tmplwhI5C/profile 01:47:23 INFO - TEST-INFO | started process 2100 (/builds/slave/test/build/application/firefox/firefox http://localhost:59921/getInfo.html) 01:47:54 INFO - TEST-INFO | 2100: exit 0 01:47:54 INFO - Browser initialized. 01:47:54 INFO - Running cycle 1/1 for kraken test... 01:47:54 INFO - Using env: {'DISPLAY': ':0', 01:47:54 INFO - 'HOME': '/home/cltbld', 01:47:54 INFO - 'JSGC_DISABLE_POISONING': '1', 01:47:54 INFO - 'LANG': 'en_US.UTF-8', 01:47:54 INFO - 'LANGUAGE': 'en_US:en', 01:47:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 01:47:54 INFO - 'LOGNAME': 'cltbld', 01:47:54 INFO - 'MAIL': '/var/mail/cltbld', 01:47:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:47:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:47:54 INFO - 'MOZ_CRASHREPORTER': '1', 01:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 01:47:54 INFO - 'MOZ_NO_REMOTE': '1', 01:47:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:54 INFO - 'NO_EM_RESTART': '1', 01:47:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:54 INFO - 'PWD': '/builds/slave/test', 01:47:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:47:54 INFO - 'RUST_BACKTRACE': 'full', 01:47:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:47:54 INFO - 'SHELL': '/bin/bash', 01:47:54 INFO - 'SHLVL': '1', 01:47:54 INFO - 'TERM': 'linux', 01:47:54 INFO - 'TMOUT': '86400', 01:47:54 INFO - 'USER': 'cltbld', 01:47:54 INFO - 'XDG_SESSION_COOKIE': 'ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757', 01:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:54 INFO - '_': '/tools/buildbot/bin/python'} 01:47:54 INFO - TEST-INFO | started process 2338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplwhI5C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:47:55 INFO - PID 2338 | 01:47:55 INFO - PID 2338 | (/builds/slave/test/build/application/firefox/firefox:2386): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 01:47:55 INFO - PID 2338 | 01:48:05 INFO - PID 2338 | RSS: Main: 160632832 01:48:05 INFO - PID 2338 | 01:48:08 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59921/tests/kraken/driver.html?testName=audio-beat-detection) 01:48:09 INFO - PID 2338 | RSS: Main: 167239680 01:48:09 INFO - PID 2338 | 01:48:11 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59921/tests/kraken/driver.html?testName=audio-dft) 01:48:12 INFO - PID 2338 | RSS: Main: 167407616 01:48:12 INFO - PID 2338 | 01:48:15 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59921/tests/kraken/driver.html?testName=audio-fft) 01:48:16 INFO - PID 2338 | RSS: Main: 161755136 01:48:16 INFO - PID 2338 | 01:48:18 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59921/tests/kraken/driver.html?testName=audio-oscillator) 01:48:18 INFO - PID 2338 | RSS: Main: 163090432 01:48:18 INFO - PID 2338 | 01:48:20 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59921/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:48:21 INFO - PID 2338 | RSS: Main: 162803712 01:48:21 INFO - PID 2338 | 01:48:24 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59921/tests/kraken/driver.html?testName=imaging-darkroom) 01:48:25 INFO - PID 2338 | RSS: Main: 166092800 01:48:25 INFO - PID 2338 | 01:48:28 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59921/tests/kraken/driver.html?testName=imaging-desaturate) 01:48:29 INFO - PID 2338 | RSS: Main: 165842944 01:48:29 INFO - PID 2338 | 01:48:32 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59921/tests/kraken/driver.html?testName=json-parse-financial) 01:48:32 INFO - PID 2338 | RSS: Main: 165814272 01:48:32 INFO - PID 2338 | 01:48:34 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59921/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:48:35 INFO - PID 2338 | RSS: Main: 165666816 01:48:35 INFO - PID 2338 | 01:48:36 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59921/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:48:37 INFO - PID 2338 | RSS: Main: 165699584 01:48:37 INFO - PID 2338 | 01:48:39 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59921/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:48:40 INFO - PID 2338 | RSS: Main: 165367808 01:48:40 INFO - PID 2338 | 01:48:42 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:48:43 INFO - PID 2338 | RSS: Main: 175521792 01:48:43 INFO - PID 2338 | 01:50:19 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:50:19 INFO - PID 2338 | RSS: Main: 164171776 01:50:19 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | Cycle 1(1): loaded http://localhost:59921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59921/tests/kraken/driver.html?testName=ai-astar) 01:50:40 INFO - PID 2338 | RSS: Main: 166883328 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | __start_tp_report 01:50:40 INFO - PID 2338 | _x_x_mozilla_page_load 01:50:40 INFO - PID 2338 | _x_x_mozilla_page_load_details 01:50:40 INFO - PID 2338 | |i|pagename|runs| 01:50:40 INFO - PID 2338 | |0;ai-astar;106;104;108;107;106;110;106;105;106;104 01:50:40 INFO - PID 2338 | |1;audio-beat-detection;113;121;116;112;117;112;112;113;140;115 01:50:40 INFO - PID 2338 | |2;audio-dft;163;160;164;162;164;161;161;166;166;168 01:50:40 INFO - PID 2338 | |3;audio-fft;82;73;76;72;72;73;73;73;74;74 01:50:40 INFO - PID 2338 | |4;audio-oscillator;80;79;78;78;78;77;77;78;77;78 01:50:40 INFO - PID 2338 | |5;imaging-gaussian-blur;115;113;110;113;114;113;113;114;115;114 01:50:40 INFO - PID 2338 | |6;imaging-darkroom;149;150;151;152;151;151;149;150;150;150 01:50:40 INFO - PID 2338 | |7;imaging-desaturate;94;93;94;97;95;98;99;99;99;99 01:50:40 INFO - PID 2338 | |8;json-parse-financial;46;45;42;43;43;45;43;45;45;44 01:50:40 INFO - PID 2338 | |9;json-stringify-tinderbox;40;43;43;43;39;39;38;39;43;39 01:50:40 INFO - PID 2338 | |10;stanford-crypto-aes;81;72;72;73;72;73;72;73;73;71 01:50:40 INFO - PID 2338 | |11;stanford-crypto-ccm;106;106;112;108;108;105;107;103;109;109 01:50:40 INFO - PID 2338 | |12;stanford-crypto-pbkdf2;157;163;159;160;162;154;159;152;153;156 01:50:40 INFO - PID 2338 | |13;stanford-crypto-sha256-iterative;59;61;59;59;60;60;59;64;64;60 01:50:40 INFO - PID 2338 | __end_tp_report 01:50:40 INFO - PID 2338 | __start_cc_report 01:50:40 INFO - PID 2338 | _x_x_mozilla_cycle_collect,895 01:50:40 INFO - PID 2338 | __end_cc_report 01:50:40 INFO - PID 2338 | __startTimestamp1505379040355__endTimestamp 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | ------- Summary: start ------- 01:50:40 INFO - PID 2338 | Number of tests: 14 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#0] ai-astar Cycles:10 Average:106.20 Median:106.00 stddev:1.81 (1.7%) stddev-sans-first:1.92 01:50:40 INFO - PID 2338 | Values: 106.0 104.0 108.0 107.0 106.0 110.0 106.0 105.0 106.0 104.0 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#1] audio-beat-detection Cycles:10 Average:117.10 Median:115.50 stddev:8.54 (7.4%) stddev-sans-first:8.93 01:50:40 INFO - PID 2338 | Values: 113.0 121.0 116.0 112.0 117.0 112.0 112.0 113.0 140.0 115.0 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:2.59 (1.6%) stddev-sans-first:2.74 01:50:40 INFO - PID 2338 | Values: 163.0 160.0 164.0 162.0 164.0 161.0 161.0 166.0 166.0 168.0 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#3] audio-fft Cycles:10 Average:74.20 Median:73.50 stddev:2.97 (4.0%) stddev-sans-first:1.22 01:50:40 INFO - PID 2338 | Values: 82.0 73.0 76.0 72.0 72.0 73.0 73.0 73.0 74.0 74.0 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:78.00 stddev:0.94 (1.2%) stddev-sans-first:0.67 01:50:40 INFO - PID 2338 | Values: 80.0 79.0 78.0 78.0 78.0 77.0 77.0 78.0 77.0 78.0 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:114.00 stddev:1.43 (1.3%) stddev-sans-first:1.39 01:50:40 INFO - PID 2338 | Values: 115.0 113.0 110.0 113.0 114.0 113.0 113.0 114.0 115.0 114.0 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 01:50:40 INFO - PID 2338 | Values: 149.0 150.0 151.0 152.0 151.0 151.0 149.0 150.0 150.0 150.0 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:98.50 stddev:2.45 (2.5%) stddev-sans-first:2.40 01:50:40 INFO - PID 2338 | Values: 94.0 93.0 94.0 97.0 95.0 98.0 99.0 99.0 99.0 99.0 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#8] json-parse-financial Cycles:10 Average:44.10 Median:45.00 stddev:1.29 (2.9%) stddev-sans-first:1.17 01:50:40 INFO - PID 2338 | Values: 46.0 45.0 42.0 43.0 43.0 45.0 43.0 45.0 45.0 44.0 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#9] json-stringify-tinderbox Cycles:10 Average:40.60 Median:41.50 stddev:2.12 (5.1%) stddev-sans-first:2.24 01:50:40 INFO - PID 2338 | Values: 40.0 43.0 43.0 43.0 39.0 39.0 38.0 39.0 43.0 39.0 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.00 stddev:2.82 (3.9%) stddev-sans-first:0.71 01:50:40 INFO - PID 2338 | Values: 81.0 72.0 72.0 73.0 72.0 73.0 72.0 73.0 73.0 71.0 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#11] stanford-crypto-ccm Cycles:10 Average:107.30 Median:108.00 stddev:2.50 (2.3%) stddev-sans-first:2.60 01:50:40 INFO - PID 2338 | Values: 106.0 106.0 112.0 108.0 108.0 105.0 107.0 103.0 109.0 109.0 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:159.00 stddev:3.75 (2.4%) stddev-sans-first:3.97 01:50:40 INFO - PID 2338 | Values: 157.0 163.0 159.0 160.0 162.0 154.0 159.0 152.0 153.0 156.0 01:50:40 INFO - PID 2338 | 01:50:40 INFO - PID 2338 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:60.00 stddev:1.96 (3.3%) stddev-sans-first:2.00 01:50:40 INFO - PID 2338 | Values: 59.0 61.0 59.0 59.0 60.0 60.0 59.0 64.0 64.0 60.0 01:50:40 INFO - PID 2338 | -------- Summary: end -------- 01:50:40 INFO - PID 2338 | 01:50:42 INFO - TEST-INFO | 2338: exit 0 01:50:42 INFO - TEST-OK | kraken | took 199717ms 01:50:42 INFO - SUITE-END | took 1421s 01:50:43 INFO - Completed test suite (00:23:41) 01:50:43 INFO - javascript benchmark 01:50:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9042.390572102116, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3803.676687481564, 3819.5798462169155, 3859.9228015439676, 3906.589808070151, 3919.8432062717493, 6021.126936594192, 6210.503159747221, 6245.188125543685, 6297.275813281474, 6358.109864618951, 6219.875602487948, 6255.186825712651, 6332.936670633292, 6341.904871426932, 6343.333949935248, 5502.0921547944545, 5604.859878503029, 5606.439356064381, 5664.575156863231, 5666.716664166795, 5339.999805073913, 5528.889422211553, 5645.15322701596, 5681.914771278434, 5700.543956483492, 5506.063969125258, 5545.77816887324, 5606.971965140189, 5626.831195064155, 5706.28671416073, 5546.306711661043, 5560.36055853578, 5599.244102046212, 5605.887882242332, 5639.68981706006, 5559.694216818073, 5619.859503512404, 5620.775168993236, 5628.099504079328, 5641.746121424546, 6272.56092073555, 6277.623342599459, 6346.619202847844, 6359.936400635981, 6365.267994180682, 6664.100346453215, 6714.160729908762, 6716.697748601325, 6798.388145066968, 6862.451003919675, 6777.356151165632, 6793.4225590824835, 6866.279040700704, 6878.209005964278, 6931.480138989546, 6262.968685156545, 6411.903821442682, 6426.1003459515705, 6428.035794630796, 6431.356864313578, 6959.547629404073, 6970.372666460043, 7056.259092795285, 7062.823429414203, 7062.858742825115, 6616.0, 6678.9332106679285, 6688.163979502562, 6733.663316834139, 6849.315068493111, 6867.690953907087, 6898.586084834926, 6912.4815638826285, 6914.723411063602, 6932.861342773116, 6683.799486015428, 6723.932760672428, 6725.932740672531, 6767.898481522781, 6803.65981700913, 6823.829404264834, 6844.691988860513, 6852.040714300002, 6863.210730766026, 6872.41584465316, 4979.377577802775, 4982.0, 5041.470645582234, 5042.546170844568, 5046.44489106198, 4423.756693381831, 4504.031633198812, 4510.503844577094, 4542.205114105019, 4548.909021819545, 6222.471089957405, 6225.875482490324, 6233.252009758858, 6253.6873156342, 6257.749690012349, 6799.660016999131, 6831.59010459374, 6846.246912839583, 6880.58716477013, 6895.75864844728, 6122.908156377658, 6199.132121502993, 6240.843978900564, 6243.719032643542, 6262.1546091278005, 5388.110961691355, 5452.236686863842, 5492.752826122834, 5495.670259784426, 5518.779248830082, 7078.929210707827, 7123.643817809088, 7125.50121491501, 7131.536450130725, 7134.714611415589, 6663.0, 6750.594964302158, 6752.729890804411, 6848.452123830181, 6872.10662613857, 6914.585124892523, 7018.298170183145, 7020.122484689414, 7036.648167591702, 7100.112485939258, 6752.324767523405, 6752.459803215829, 6765.729370825112, 6791.04925310447, 6799.014142949146, 6839.418649414855, 6854.074699915647, 6863.210730766026, 6932.410745086724, 6939.618320992394, 6501.6424096673245, 6502.122213501117, 6509.349065093642, 6579.835504112435, 6615.966920165561, 6490.188726409199, 6562.114114594659, 6562.737490500517, 6571.145751052332, 6579.605223686594, 6369.777057802955, 6377.74489020434, 6412.6793660317735, 6438.742450302123, 6452.257990331172, 6359.17330747, 6376.39424254695, 6430.228372595318, 6506.219253689587, 6581.769638062645, 6320.778772742932, 6381.87236255263, 6389.904151437825, 6420.357964203542, 6490.643014634052], "value": 6195.71455290833, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [941.1012483078658, 943.2642538819723, 968.2060710217621, 994.5425104451951, 998.5606333213385, 42879.571204287946, 44659.999999999956, 44718.55281447185, 45001.77499112504, 45003.77498112513, 41200.38199427011, 41302.38046429306, 41411.58588414123, 41427.58572414275, 41646.791766041126, 7362.889556656654, 7468.58922759248, 7477.0, 7482.700691972314, 7489.850202995937, 7091.89362159568, 7092.751753688622, 7095.971084192789, 7117.501774875761, 7131.037309963141, 7968.482048666847, 8081.595920203996, 8148.062972758149, 8151.429399942006, 8159.714409995651, 8022.318102961255, 8049.235322644339, 8052.0, 8077.838443231132, 8086.312663423616, 7878.330341920886, 7954.125046244909, 7957.0, 7972.641231144612, 8127.390445716535, 39780.602193978266, 39783.0, 40813.59186408157, 41273.79363103196, 41298.58701413008, 3813.161104556993, 3861.6524512793985, 3864.3044252034624, 3866.2074274773604, 3866.6906647468136, 33835.15412114692, 33913.32173356519, 34000.489992649884, 34030.319393611986, 34173.48739768905, 5537.612367134302, 5566.192902029183, 5569.582281328876, 5598.664080155204, 5607.299087614048, 236604.0, 240463.99999999825, 240508.0, 240607.0, 240713.0, 54729.1790623141, 54900.72549637226, 55130.72434637801, 55286.0, 55300.0, 57513.0, 57649.0, 57716.0, 57863.0, 57963.13055304174, 16529.421470248722, 16907.83092169087, 16937.407190748265, 16951.660966780597, 16954.830451695572, 13505.932470337586, 13570.93214533921, 13639.931800340935, 13668.111572747739, 13691.520796772065, 15578.0, 15884.76172857408, 15904.522864314089, 15963.680726385408, 15981.520554383387, 6433.260175079926, 6433.356664333529, 6511.186101737283, 6540.607563546202, 6669.533132680763, 1085.9076978456762, 1098.3519723363254, 1100.9119270458343, 1103.448275862069, 1105.4748994227677, 24676.38309042288, 25106.372340691265, 25315.87342063278, 25322.74677253204, 25464.0, 1204.879462100255, 1209.5041033176356, 1211.1885037025215, 1216.9391530423443, 1219.201423067892, 13185.73628527424, 13268.867311326956, 13343.0, 13439.328033598282, 13532.255725935169, 289470.0, 291188.0, 291612.0, 291920.0, 292613.0, 59134.704326478095, 59850.0, 63577.68211158914, 63807.68096159583, 64188.0, 1452.2666053642843, 1499.1155218420965, 1500.8499150084904, 1508.7585986242148, 1510.886683498742, 30364.0, 30405.695943040286, 30462.390752185274, 30639.0, 30776.076717698506, 42679.0, 42721.0, 42780.35829462498, 42867.356989644555, 42877.78561107175, 249310.0, 251472.0, 252263.0, 253308.0, 253334.0, 36955.0, 36975.0, 37069.62930370662, 37077.258454831295, 37312.880613581634, 45880.77059614681, 46936.29595556001, 46971.29543056789, 47196.7640161797, 47426.28860567163, 34946.30107397787, 35002.824985874904, 35014.47478287879, 35054.0, 35603.287934241685, 34279.0, 34481.482777757854, 35152.0, 35261.471077934366, 35305.0, 40307.1938561233, 41098.383524246565, 41270.38094428526, 41431.72125533125, 41549.37675934924, 33621.66378336185, 34161.658383415845, 34252.657473424944, 34619.30761384808, 34652.48021279633, 24702.163144400183, 24832.0, 25443.569240562192, 25457.745422545537, 25618.694317510766], "value": 18839.722912474994, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.6414151509096, 603.56844855928, 613.2058983616216, 618.3414663383496, 628.6102616377847, 22543.210987615435, 23199.652005219934, 23246.883765581148, 23282.65076023861, 23295.650565241536, 23743.287701368987, 25254.36864078399, 25352.0, 25378.873105634448, 25410.745892541116, 6672.466202703772, 6718.193816741998, 6755.054292399068, 6757.493188010894, 6813.250542440328, 6496.675166241693, 6627.469802415795, 6695.933040669604, 6735.629540375277, 6745.291744366845, 6710.396064354231, 6711.798646040626, 6713.899291510631, 6715.227748808877, 6721.798346049602, 6693.4979876509215, 6703.195616526048, 6707.429868461187, 6710.16122984627, 6716.1269035025625, 5865.296164460249, 6043.8186854394, 6069.119977603223, 6073.817785466443, 6245.281792593819, 30115.397692046256, 30648.540271895938, 30690.0, 30693.69306306953, 30713.0, 2199.8790066546335, 2216.944576385587, 2230.7992280694816, 2232.319142661504, 2234.1510226113974, 19171.424857254166, 19569.510762230915, 19847.305344313023, 19934.202631894706, 20297.391078267676, 2507.4358269389422, 2530.3168144600854, 2570.897164113433, 2572.935676608081, 2574.266334094793, 125212.37393812972, 129876.35061824725, 130438.0, 141919.0, 149520.2523987373, 15060.590305551279, 15348.462803801813, 15832.60418489547, 16100.114493702958, 16175.514734557746, 25820.225393238234, 25960.0, 25966.35084122912, 25977.610335844976, 26030.219093427226, 10183.287169898036, 10216.897831021595, 10443.582256709798, 10488.947555262328, 10561.735956600993, 9268.119528644902, 9349.924758652705, 9353.485558294224, 9355.29835262358, 9516.143547080796, 9662.516874156405, 9678.128968392879, 9819.459929703935, 9832.803343933225, 10001.749956251151, 2785.4011387551773, 2834.801563890508, 2875.159897665496, 2932.648082230146, 2974.8810047597854, 1024.9180065594735, 1038.4755698372273, 1042.890496497872, 1044.1751016696724, 1060.1995493402433, 20285.695714564292, 20319.898400507904, 20358.491037724176, 20749.68875466839, 20764.792352076587, 1064.818980773255, 1095.4007149561728, 1095.6055819904827, 1106.7399161197113, 1115.0967716149944, 11102.0, 11289.20975531705, 11358.886411135783, 11385.08919286455, 11455.656330309937, 587140.0, 601433.0, 606399.0, 612822.0, 622570.0, 127004.0, 127256.0, 130764.0, 133694.0, 133940.0, 1095.2552264460085, 1124.1512657943201, 1209.7459533497888, 1238.6160290310033, 1240.5347994502242, 21155.682664759734, 21287.8935605321, 21451.034703438694, 21783.891080544498, 21847.67228491542, 60092.69953650204, 60148.0, 60999.0, 61656.383436165066, 62761.37238627555, 79480.60259698665, 79626.6018669903, 79919.0, 80315.59842200752, 80483.0, 14855.554333370017, 14953.925230373778, 14957.326920288395, 15049.398024078915, 15064.246787660792, 22957.655635165152, 23044.078236870337, 23058.308250752503, 23292.951817168607, 23308.417289567897, 18950.810491894903, 19070.33253836109, 19165.0, 19435.416937491897, 19673.803261967198, 16305.755413669041, 16808.57978550497, 16877.915610422362, 17001.914990424968, 17461.30154793794, 19288.324908628132, 19480.707789382886, 19545.609087818448, 19547.51131221731, 19704.40886773399, 14636.04865683727, 14849.480268190562, 14851.628709282355, 14854.777178342118, 14862.925685371936, 18802.341918032802, 18820.341288054853, 19051.33320333837, 19077.236910523425, 19250.326238581583], "value": 12558.385461881284, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.7796241582553, 1468.8188040759464, 1480.2006916265218, 1491.2916364726764, 1494.8280947691014, 16629.83370166298, 17358.47924562262, 17374.044427556495, 17384.913075434637, 17392.82607173928, 17095.658086838255, 17136.571585710364, 17152.39966601166, 17181.570460738458, 17182.312707491717, 2882.6108475355823, 2912.8689208985543, 2926.151416089342, 2926.7073292670775, 2942.9411411771753, 2669.292637451077, 2811.11449893284, 2827.363843135299, 2829.052267490393, 2833.3624934389804, 2709.011210908014, 2930.7801914856364, 2932.1057077591327, 2933.149386677861, 2934.3397735509448, 2778.7360200780895, 2794.5668421394716, 2847.288177955511, 2872.741453269195, 2877.036192875389, 2753.876075576604, 2840.4887120318335, 2868.512352900012, 2957.467655821951, 2959.067893613505, 16687.08221047842, 16746.49760507187, 16793.0, 16801.24394402255, 16837.24232409532, 8671.523066231355, 8946.105389461067, 9011.819763604692, 9011.819763604757, 9025.368224224307, 5802.477777000048, 5901.23283973085, 5973.596204891847, 6003.519718422515, 6039.214902062704, 1910.3218357483172, 1914.7032210007471, 1930.9227630894748, 1953.4823271832975, 1960.4314748722995, 31024.0692779217, 31257.37485250305, 31312.37375252482, 31333.529997050064, 31389.215269617984, 7088.893666595005, 7137.0, 7149.964250178716, 7337.26627337262, 7395.0, 19779.901100494404, 19783.604327913363, 19787.604247914962, 19798.802011979697, 19802.801971980385, 8518.74443766688, 8688.435251708619, 8721.258693011037, 8745.169208925143, 8772.429792063496, 7892.4869883457395, 7917.7624671259955, 7935.166807485131, 8037.557934313669, 8040.959795200986, 5187.221916712523, 5396.244525766396, 5439.864003399867, 5449.100898351807, 5504.4770746778995, 1662.426462870308, 1664.176232764765, 1682.3943380383052, 1684.730443129118, 1708.7009773289624, 983.2134292565919, 986.0927946289288, 988.5600907596195, 1013.4729940430934, 1015.8120747661559, 8388.454750441202, 8405.285550728135, 8549.957250213709, 8668.913310866938, 8763.649454021768, 747.3012733094574, 774.9418793590503, 782.194339829976, 795.2564352330589, 801.5831767480877, 5725.885482290331, 5944.108383742473, 5962.433568810956, 6162.753489860355, 6226.470749986212, 24042.63936040961, 24711.38221544476, 25202.117925872506, 25478.617820732703, 25586.48827023449, 25096.49421034744, 25100.372490687878, 25103.874480627845, 25194.118205862706, 25408.618870716953, 11789.174757766874, 12432.56486023003, 12495.125341226209, 12497.562585309652, 12561.309127998047, 9546.85679714791, 9578.90421095808, 9593.13661770444, 9593.568289426852, 9702.466364350028, 20703.17187312551, 20911.477213069797, 20917.1633134679, 21542.892285538474, 21955.560888782453, 22024.44938876477, 22132.88933555322, 22397.66403503916, 22404.551908962054, 22960.19639312616, 11926.761464770829, 12124.515019399478, 12130.0, 12190.268583884996, 12209.511619535118, 15195.0, 15231.92384038117, 15366.846331536988, 15382.230888455757, 15401.0, 11845.703857403634, 12087.879121209027, 12116.818247726114, 12298.0, 12329.815052774036, 12137.271763694207, 12244.265344079384, 12365.938170309451, 12384.56654017105, 12459.190152640049, 11059.115270778479, 11352.716182095513, 11362.03422709079, 11362.54549818031, 11366.204365694322, 8292.917070829215, 8324.084350721538, 8383.119772423808, 8398.328133749408, 8480.321574274167, 8270.131636178356, 8314.875276870973, 8406.0, 8430.072692003752, 8430.946131733534], "value": 7309.602830402117, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.3270133217884, 571.5827445964444, 584.544055636603, 592.6740292838939, 596.668848788922, 6200.496719353568, 6271.937280627192, 6278.748850046004, 6279.9999999999945, 6337.302896681373, 6198.194234749488, 6214.5649804513705, 6257.124002639623, 6264.498840092793, 6309.810705678826, 5030.924536131952, 5092.8472145835685, 5106.208537676666, 5110.156824124034, 5117.769700363474, 4854.805807767702, 5021.548060674539, 5107.514786095315, 5130.358705161855, 5155.226715992612, 4912.21404575268, 4917.532834380728, 4931.753412329387, 4942.973380913826, 4955.900881982358, 4885.169521181408, 4914.901701965959, 4956.653034287619, 4971.627127965381, 4972.5276098770555, 4471.329300604935, 4477.597016268519, 4478.977605111986, 4482.9551704482865, 4495.303227999665, 6175.07373893915, 6181.876362472725, 6201.627902325875, 6252.4673559439225, 6252.749890004395, 5847.8012007538355, 5913.319968203668, 5917.094717486439, 5925.792597259076, 5935.703214839284, 6590.0, 6632.900506492407, 6646.700898459581, 6697.799066028027, 6721.958096495051, 4884.776047808429, 5068.822591209327, 5083.389993200803, 5097.0, 5103.336566246401, 6697.799066028027, 6848.7260509580055, 6875.690593923286, 6890.31096890312, 6967.6864541095265, 5141.0232055909255, 5165.870853228625, 5180.818671346485, 5191.117510023305, 5199.090159222121, 5247.003069416799, 5272.815451459181, 5279.683219006872, 5279.947200527946, 5280.735963201824, 5822.82531524055, 5824.767009319579, 5826.82519524415, 5835.503982161479, 5856.690969602161, 6649.335066493312, 6649.73401063952, 6649.803035453665, 6659.501612137327, 6669.533132680763, 1817.1731862002757, 1817.1822679794145, 1819.8999055051834, 1822.7265910113324, 1831.716084006981, 1197.0060144405243, 1248.6628610275175, 1256.145820841818, 1266.645339304996, 1267.8161666558483, 6069.696515174223, 6104.755809767559, 6118.663473508911, 6130.908036379458, 6155.969220153871, 6677.833054173684, 6721.798346049626, 6773.458123350219, 6798.252192258848, 6799.456043516507, 6082.239720034996, 6108.511319094462, 6131.417515336036, 6134.325224225332, 6143.815685529441, 3358.95103986568, 3500.8774692886136, 3514.9824250878582, 3535.8585656573964, 3540.7875527468436, 6845.726170953206, 6847.589144651337, 6858.451323894076, 6967.54710943787, 7019.227884932653, 6773.324536807933, 6792.592444453348, 6821.703876263494, 6866.656667166621, 6929.272426395156, 6960.721571137098, 7010.228874823765, 7022.683979220845, 7037.683304251321, 7067.116610423697, 6684.665766711548, 6721.966390168018, 6722.731090756315, 6750.717363700881, 6800.251972283144, 6517.3808488193545, 6570.244421891352, 6591.967040164768, 6631.038499417654, 6678.83302917431, 6835.521513494206, 6880.518363714692, 6887.793366199022, 6896.310368963063, 6977.7208911642965, 4988.906877735827, 5074.822381216787, 5088.295421033847, 5089.770960306869, 5108.489151084862, 6500.187476565429, 6534.8366290843105, 6756.594604323756, 6786.69459874297, 6870.7595234166565, 6312.431881130537, 6326.936730632819, 6341.619502829845, 6463.256725476443, 6482.643454610042, 6349.428551430208, 6356.252030691597, 6408.166938297992, 6513.837154071186, 6553.836154096186, 6403.743850245938, 6427.325130861379, 6444.452221561032, 6462.515311351762, 6482.384173503509, 6539.444147247347, 6540.182477190351, 6545.116409284686, 6597.416620011067, 6612.603243805194, 6342.0, 6358.427741503287, 6411.647359395278, 6435.935640643534, 6441.227052753512], "value": 5156.734534202983, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [969.8787651543557, 980.9509524523772, 996.9651062212824, 1001.6594357918307, 1001.9048190421912, 18893.811061889377, 19563.706544401844, 19626.705599415985, 19673.114709838057, 19724.605507889835, 19296.0, 19531.5117122072, 19563.902180489113, 19588.902055489703, 19594.0, 1024.3188279793928, 1035.2184101003731, 1036.7926414717049, 1039.8232300508932, 1041.9687409377693, 1076.1068313299982, 1076.773877485729, 1077.5474300793646, 1079.535799606173, 1079.9514021869036, 1091.323379504708, 1124.668222874254, 1127.870294916087, 1133.9886601134008, 1135.8636963564343, 1114.4260705736551, 1118.725912151524, 1121.831725241212, 1122.0967121467215, 1122.354646078508, 781.5662307419379, 810.9837803243961, 816.4366587054913, 818.0183779464667, 832.0514613340796, 19104.713429298572, 19277.132529036226, 19340.903295483575, 19377.224911003545, 19469.51326216856, 21953.67069493943, 22008.88995555012, 22993.885030574907, 23209.651855222186, 23258.883705581364, 18431.539211519685, 18512.814871851242, 18612.34856780006, 18619.1621377037, 18814.529636759053, 3926.038120660428, 3955.584663610337, 3956.2285354355913, 3957.465742124834, 3958.7426817257074, 129491.0, 159693.20153399158, 161504.0, 164555.0, 164923.0, 17774.555636109202, 17985.280588776564, 18348.0, 18365.26538938454, 18393.52851771855, 33986.83006584951, 34471.4829277561, 34491.65508344935, 34582.13544661403, 34728.65271347305, 9636.373635713657, 9803.362781419184, 9839.704808855746, 9849.359791613522, 9874.851877221847, 4311.741295522279, 4333.696641235147, 4375.934360984587, 4412.0734645724115, 4417.558244175621, 5868.0, 5978.342382337939, 5978.611390259619, 5979.5515336349945, 5983.072623743326, 1104.9558017679365, 1146.747715502588, 1157.242006485753, 1165.685264978451, 1172.2380452705638, 740.8999785028952, 754.9622518874035, 759.734093067422, 764.7705688293489, 771.5794891783879, 13931.233782142079, 13991.650208744863, 14107.506237281646, 15006.249687515581, 15245.847541524665, 685.1264637587117, 691.1257259566652, 691.325957191734, 705.002421573478, 710.9680064397114, 6029.859689419249, 6147.72335244915, 6167.938320616826, 6178.62928224308, 6189.04069869171, 142449.0893533798, 143846.2807685955, 147787.04425911422, 150805.0, 151966.0, 130713.0, 130772.69227307606, 132215.33892330478, 133297.0, 135172.0, 109564.4521777386, 111114.0, 111992.44003780092, 113347.4332628348, 113499.0, 11379.367213229505, 11410.429478526206, 11634.883651163718, 11868.940655296668, 11963.222390544586, 54106.729466352415, 55371.723141384035, 55653.44346556483, 56101.0, 57559.42440575541, 70515.29484705087, 70525.64737176281, 70879.29120708727, 71033.28966710267, 71584.64207678929, 17156.742648860527, 17394.73907891357, 17402.47792566225, 17525.649487009934, 17609.20758565842, 19596.314129005415, 19716.40850774479, 19758.506037348605, 19889.403317900487, 19999.0, 19107.331243406414, 19471.4158575243, 19480.318188863323, 19544.31594894172, 19680.60638787245, 15410.614734631725, 15559.144247066068, 15668.608284792972, 15687.843121568638, 15762.0, 18792.342268020555, 18923.243070277036, 19031.619367612846, 19218.807811921703, 19300.517487062934, 12803.551875684307, 12831.807522886977, 13108.934455327662, 13113.475460981454, 13241.404136814059, 13727.0, 13735.24456154921, 13830.308484575933, 13869.306534673024, 14034.438622455396], "value": 9892.457855362334, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1382.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 108.0, 107.0, 106.0, 110.0, 106.0, 105.0, 106.0, 104.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 121.0, 116.0, 112.0, 117.0, 112.0, 112.0, 113.0, 140.0, 115.0], "value": 117.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 164.0, 162.0, 164.0, 161.0, 161.0, 166.0, 166.0, 168.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 73.0, 76.0, 72.0, 72.0, 73.0, 73.0, 73.0, 74.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 78.0, 78.0, 77.0, 77.0, 78.0, 77.0, 78.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 110.0, 113.0, 114.0, 113.0, 113.0, 114.0, 115.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 151.0, 152.0, 151.0, 151.0, 149.0, 150.0, 150.0, 150.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 97.0, 95.0, 98.0, 99.0, 99.0, 99.0, 99.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 42.0, 43.0, 43.0, 45.0, 43.0, 45.0, 45.0, 44.0], "value": 44.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 43.0, 43.0, 43.0, 39.0, 39.0, 38.0, 39.0, 43.0, 39.0], "value": 40.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 72.0, 72.0, 73.0, 72.0, 73.0, 72.0, 73.0, 73.0, 71.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 106.0, 112.0, 108.0, 108.0, 105.0, 107.0, 103.0, 109.0, 109.0], "value": 107.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 163.0, 159.0, 160.0, 162.0, 154.0, 159.0, 152.0, 153.0, 156.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 59.0, 60.0, 60.0, 59.0, 64.0, 64.0, 60.0], "value": 60.5, "unit": "score"}]}]} 01:50:43 INFO - Return code: 0 01:50:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:50:43 INFO - # TBPL SUCCESS # 01:50:43 INFO - Running post-action listener: _package_coverage_data 01:50:43 INFO - Running post-action listener: _resource_record_post_action 01:50:43 INFO - [mozharness: 2017-09-14 08:50:43.141911Z] Finished run-tests step (success) 01:50:43 INFO - Running post-run listener: _resource_record_post_run 01:50:43 INFO - Total resource usage - Wall time: 1440s; CPU: 15.0%; Read bytes: 4096; Write bytes: 477589504; Read time: 28; Write time: 19020316 01:50:43 INFO - TinderboxPrint: CPU usage
14.8% 01:50:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 01:50:43 INFO - TinderboxPrint: I/O write bytes / time
477,589,504 / 19,020,316 01:50:43 INFO - TinderboxPrint: CPU idle
9,784.5 (85.2%) 01:50:43 INFO - TinderboxPrint: CPU iowait
457.6 (4.0%) 01:50:43 INFO - TinderboxPrint: CPU user
1,197.7 (10.4%) 01:50:43 INFO - TinderboxPrint: Swap in / out
0 / 0 01:50:43 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 1650688; Read time: 0; Write time: 1024 01:50:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 01:50:43 INFO - run-tests - Wall time: 1422s; CPU: 15.0%; Read bytes: 4096; Write bytes: 475549696; Read time: 28; Write time: 19019172 01:50:43 INFO - Running post-run listener: _upload_blobber_files 01:50:43 INFO - Blob upload gear active. 01:50:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:50:43 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 01:50:43 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'] 01:50:43 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 01:50:44 INFO - (blobuploader) - INFO - Open directory for files ... 01:50:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:50:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:50:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:50:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:50:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:50:45 INFO - (blobuploader) - INFO - Done attempting. 01:50:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:50:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:50:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:50:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:50:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:50:53 INFO - (blobuploader) - INFO - Done attempting. 01:50:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:50:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:50:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:50:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:50:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:50:54 INFO - (blobuploader) - INFO - Done attempting. 01:50:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:50:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:50:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:50:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:50:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:50:55 INFO - (blobuploader) - INFO - Done attempting. 01:50:55 INFO - (blobuploader) - INFO - Iteration through files over. 01:50:55 INFO - Return code: 0 01:50:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:50:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:50:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b76efe553121cdc8b866a49ca4d8565d6c4845855e7be023081e62f1d8e7cb0a7dc4d55cbe98781d86fb9d4212228407c43eb98c35f3d0e2ab382fcfcd25120b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/026f56a9a876e5540ae1690230c02397fe7f9e06580b2b3b106719f110e93d6cb22e77b017db622a916670b03f5414e8e83b2e5cd1a854029967cc06d4c6a7af", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03ac50f965b6882f720b8559763f00867873e7ab00a8fbeaa42ec2d6129231a5b4e596bf000a7709746498676f073244418d75d7857f52c02fb6e88444bce838", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70649b8f3246e8881ef42419538cf80378138d0f31db7ec2628d889c6dc600b59811f4fd77d53943c2e881c429fbfa9b1fa53306c637f3f8ad13f2ad50d47e1c"} 01:50:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:50:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:50:55 INFO - Contents: 01:50:55 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b76efe553121cdc8b866a49ca4d8565d6c4845855e7be023081e62f1d8e7cb0a7dc4d55cbe98781d86fb9d4212228407c43eb98c35f3d0e2ab382fcfcd25120b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/026f56a9a876e5540ae1690230c02397fe7f9e06580b2b3b106719f110e93d6cb22e77b017db622a916670b03f5414e8e83b2e5cd1a854029967cc06d4c6a7af", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03ac50f965b6882f720b8559763f00867873e7ab00a8fbeaa42ec2d6129231a5b4e596bf000a7709746498676f073244418d75d7857f52c02fb6e88444bce838", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70649b8f3246e8881ef42419538cf80378138d0f31db7ec2628d889c6dc600b59811f4fd77d53943c2e881c429fbfa9b1fa53306c637f3f8ad13f2ad50d47e1c"} 01:50:55 INFO - Running post-run listener: copy_logs_to_upload_dir 01:50:55 INFO - Copying logs to upload dir... 01:50:55 INFO - mkdir: /builds/slave/test/build/upload/logs 01:50:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1599.624449 ========= master_lag: -0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 39 secs) (at 2017-09-14 01:50:55.789035) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 01:50:55.792723) ========= 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=ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b76efe553121cdc8b866a49ca4d8565d6c4845855e7be023081e62f1d8e7cb0a7dc4d55cbe98781d86fb9d4212228407c43eb98c35f3d0e2ab382fcfcd25120b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/026f56a9a876e5540ae1690230c02397fe7f9e06580b2b3b106719f110e93d6cb22e77b017db622a916670b03f5414e8e83b2e5cd1a854029967cc06d4c6a7af", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03ac50f965b6882f720b8559763f00867873e7ab00a8fbeaa42ec2d6129231a5b4e596bf000a7709746498676f073244418d75d7857f52c02fb6e88444bce838", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70649b8f3246e8881ef42419538cf80378138d0f31db7ec2628d889c6dc600b59811f4fd77d53943c2e881c429fbfa9b1fa53306c637f3f8ad13f2ad50d47e1c"} build_url:https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011453 build_url: 'https://queue.taskcluster.net/v1/task/Wiwdja74QTmS_gMgcPIgNA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b76efe553121cdc8b866a49ca4d8565d6c4845855e7be023081e62f1d8e7cb0a7dc4d55cbe98781d86fb9d4212228407c43eb98c35f3d0e2ab382fcfcd25120b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/026f56a9a876e5540ae1690230c02397fe7f9e06580b2b3b106719f110e93d6cb22e77b017db622a916670b03f5414e8e83b2e5cd1a854029967cc06d4c6a7af", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03ac50f965b6882f720b8559763f00867873e7ab00a8fbeaa42ec2d6129231a5b4e596bf000a7709746498676f073244418d75d7857f52c02fb6e88444bce838", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70649b8f3246e8881ef42419538cf80378138d0f31db7ec2628d889c6dc600b59811f4fd77d53943c2e881c429fbfa9b1fa53306c637f3f8ad13f2ad50d47e1c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 01:50:55.821208) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:50:55.821548) ========= 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=ea1537f79099159eb082e9be00000831-1505372078.442730-1910221757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:50:55.907292) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 01:50:55.907609) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 01:50:55.907941) ========= ========= Total master_lag: 0.14 =========