builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1504086924.82 results: success (0) revision: ab2d700fda2b4934d24227216972dce9fac19b74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:24.822091) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:24.824733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:24.825164) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:25.004574) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:25.005535) ========= 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=af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-30 02:55:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-08-30 02:55:25 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083394 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:25.127589) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:25.128189) ========= 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=af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020227 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:25.206553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-30 02:55:25.206964) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ab2d700fda2b4934d24227216972dce9fac19b74 --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 ab2d700fda2b4934d24227216972dce9fac19b74 --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=af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-30 02:55:25,250 truncating revision to first 12 chars 2017-08-30 02:55:25,250 Setting DEBUG logging. 2017-08-30 02:55:25,250 attempt 1/10 2017-08-30 02:55:25,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ab2d700fda2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-30 02:55:26,156 unpacking tar archive at: mozilla-central-ab2d700fda2b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.216072 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-30 02:55:26.444926) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:26.445327) ========= script_repo_revision: ab2d700fda2b4934d24227216972dce9fac19b74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:26.445766) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:26.446033) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:26.466881) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-30 02:55:26.467302) ========= /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=af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:55:26 INFO - MultiFileLogger online at 20170830 02:55:26 in /builds/slave/test 02:55:26 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 02:55:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:55:26 INFO - {'append_to_log': False, 02:55:26 INFO - 'base_work_dir': '/builds/slave/test', 02:55:26 INFO - 'blob_upload_branch': 'Firefox', 02:55:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:55:26 INFO - 'branch': 'Firefox', 02:55:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:55:26 INFO - 'code_coverage': False, 02:55:26 INFO - 'config_files': ('talos/linux_config.py',), 02:55:26 INFO - 'default_actions': ('clobber', 02:55:26 INFO - 'read-buildbot-config', 02:55:26 INFO - 'download-and-extract', 02:55:26 INFO - 'populate-webroot', 02:55:26 INFO - 'create-virtualenv', 02:55:26 INFO - 'install', 02:55:26 INFO - 'setup-mitmproxy', 02:55:26 INFO - 'run-tests'), 02:55:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:55:26 INFO - 'disable_ccov_upload': False, 02:55:26 INFO - 'disable_stylo': False, 02:55:26 INFO - 'download_minidump_stackwalk': True, 02:55:26 INFO - 'download_symbols': 'ondemand', 02:55:26 INFO - 'enable_stylo': False, 02:55:26 INFO - 'enable_webrender': False, 02:55:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:55:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:55:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:55:26 INFO - 'gecko_profile': False, 02:55:26 INFO - 'gecko_profile_interval': 0, 02:55:26 INFO - 'installer_path': 'installer.exe', 02:55:26 INFO - 'log_level': 'info', 02:55:26 INFO - 'log_name': 'talos', 02:55:26 INFO - 'log_to_console': True, 02:55:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:55:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:55:26 INFO - 'opt_config_files': (), 02:55:26 INFO - 'pip_index': False, 02:55:26 INFO - 'suite': 'dromaeojs-e10s', 02:55:26 INFO - 'system_bits': '32', 02:55:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:55:26 INFO - 'title': 'talos-linux64-ix-020', 02:55:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:55:26 INFO - 'use_talos_json': True, 02:55:26 INFO - 'verify': 'False', 02:55:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:55:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:55:26 INFO - 'work_dir': 'build'} 02:55:26 INFO - [mozharness: 2017-08-30 09:55:26.657948Z] Running clobber step. 02:55:26 INFO - Running pre-action listener: _resource_record_pre_action 02:55:26 INFO - Running main action method: clobber 02:55:26 INFO - rmtree: /builds/slave/test/build 02:55:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:55:27 INFO - Running post-action listener: _resource_record_post_action 02:55:27 INFO - [mozharness: 2017-08-30 09:55:27.687765Z] Finished clobber step (success) 02:55:27 INFO - [mozharness: 2017-08-30 09:55:27.687862Z] Running read-buildbot-config step. 02:55:27 INFO - Running pre-action listener: _resource_record_pre_action 02:55:27 INFO - Running main action method: read_buildbot_config 02:55:27 INFO - Using buildbot properties: 02:55:27 INFO - { 02:55:27 INFO - "project": "", 02:55:27 INFO - "product": "firefox", 02:55:27 INFO - "who": "archaeopteryx@coole-files.de", 02:55:27 INFO - "installer_path": "public/build/target.tar.bz2", 02:55:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 02:55:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:55:27 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 02:55:27 INFO - "stage_platform": "linux64-stylo", 02:55:27 INFO - "basedir": "/builds/slave/test", 02:55:27 INFO - "buildnumber": 110, 02:55:27 INFO - "platform": "ubuntu64_hw_stylo", 02:55:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:55:27 INFO - "slavebuilddir": "test", 02:55:27 INFO - "taskId": "WWi3ZY9pSv24DKcCvYdpNw", 02:55:27 INFO - "branch": "mozilla-central", 02:55:27 INFO - "script_repo_revision": "production", 02:55:27 INFO - "revision": "ab2d700fda2b4934d24227216972dce9fac19b74", 02:55:27 INFO - "slavename": "talos-linux64-ix-020", 02:55:27 INFO - "repo_path": "mozilla-central" 02:55:27 INFO - } 02:55:27 INFO - Finding installer, test and symbols from parent task. 02:55:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WWi3ZY9pSv24DKcCvYdpNw'}, attempt #1 02:55:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WWi3ZY9pSv24DKcCvYdpNw'}, attempt #1 02:55:28 INFO - Task dependencies: eSP-W7eQTHm081zyISUr-A 02:55:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A'}, attempt #1 02:55:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2 02:55:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.test_packages.json 02:55:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.crashreporter-symbols.zip 02:55:29 INFO - Running post-action listener: _resource_record_post_action 02:55:29 INFO - [mozharness: 2017-08-30 09:55:29.062952Z] Finished read-buildbot-config step (success) 02:55:29 INFO - [mozharness: 2017-08-30 09:55:29.063170Z] Running download-and-extract step. 02:55:29 INFO - Running pre-action listener: _resource_record_pre_action 02:55:29 INFO - Running main action method: download_and_extract 02:55:29 INFO - mkdir: /builds/slave/test/build/tests 02:55: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')]} 02:55:29 INFO - trying https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.test_packages.json 02:55:29 INFO - Downloading https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:55:29 INFO - Downloaded 989 bytes. 02:55:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:55:29 INFO - Using the following test package requirements: 02:55:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:55:29 INFO - u'common': [u'target.common.tests.zip'], 02:55:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:55:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:55:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:55:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:55:29 INFO - u'mozbase': [u'target.common.tests.zip'], 02:55:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:55:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:55:29 INFO - u'web-platform': [u'target.common.tests.zip', 02:55:29 INFO - u'target.web-platform.tests.tar.gz'], 02:55:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:55:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:55:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.common.tests.zip 02:55:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:55:29 INFO - Fetch https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.common.tests.zip into memory 02:55:30 INFO - Content-Length response header: 54962578 02:55:30 INFO - Bytes received: 54962578 02:55:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:55:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.common.tests.zip 02:55:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:55:41 INFO - Fetch https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.common.tests.zip into memory 02:55:42 INFO - Content-Length response header: 54962578 02:55:42 INFO - Bytes received: 54962578 02:55:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.talos.tests.zip 02:55:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:55:54 INFO - Fetch https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.talos.tests.zip into memory 02:55:55 INFO - Content-Length response header: 14496650 02:55:55 INFO - Bytes received: 14496650 02:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:55 INFO - trying https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2 02:55:55 INFO - Downloading https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:55:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:55:56 INFO - Downloaded 62596709 bytes. 02:55:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2 02:55:56 INFO - mkdir: /builds/slave/test/properties 02:55:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:55:56 INFO - Writing to file /builds/slave/test/properties/build_url 02:55:56 INFO - Contents: 02:55:56 INFO - build_url:https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2 02:55:56 INFO - Running post-action listener: _resource_record_post_action 02:55:56 INFO - Running post-action listener: find_tests_for_verification 02:55:56 INFO - Running post-action listener: set_extra_try_arguments 02:55:56 INFO - [mozharness: 2017-08-30 09:55:56.751151Z] Finished download-and-extract step (success) 02:55:56 INFO - [mozharness: 2017-08-30 09:55:56.751247Z] Running populate-webroot step. 02:55:56 INFO - Running pre-action listener: _resource_record_pre_action 02:55:56 INFO - Running main action method: populate_webroot 02:55:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:55:56 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:55:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:55:56 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:55:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:55:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:56 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:55:56 INFO - 'talos_options': ['--enable-stylo'], 02:55:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:55:56 INFO - 'tests': ['damp', 'tps']}, 02:55:56 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:55:56 INFO - 'talos_options': ['--enable-stylo'], 02:55:56 INFO - 'tests': ['damp', 'tps']}, 02:55:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:55:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:55:56 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:55:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:55:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:55:56 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:55:56 INFO - 'talos_options': ['--enable-stylo'], 02:55:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:55:56 INFO - 'other-e10s': {'tests': ['a11yr', 02:55:56 INFO - 'ts_paint', 02:55:56 INFO - 'tpaint', 02:55:56 INFO - 'sessionrestore', 02:55:56 INFO - 'sessionrestore_many_windows', 02:55:56 INFO - 'sessionrestore_no_auto_restore', 02:55:56 INFO - 'tabpaint']}, 02:55:56 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:56 INFO - 'tests': ['a11yr', 02:55:56 INFO - 'ts_paint', 02:55:56 INFO - 'tpaint', 02:55:56 INFO - 'sessionrestore', 02:55:56 INFO - 'sessionrestore_many_windows', 02:55:56 INFO - 'sessionrestore_no_auto_restore', 02:55:56 INFO - 'tabpaint']}, 02:55:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:55:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:55:56 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:56 INFO - 'tests': ['bloom_basic_singleton']}, 02:55:56 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:56 INFO - 'tests': ['bloom_basic']}, 02:55:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:55:56 INFO - 'tsvgr_opacity', 02:55:56 INFO - 'tart', 02:55:56 INFO - 'tscrollx', 02:55:56 INFO - 'tsvg_static']}, 02:55:56 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:56 INFO - 'tests': ['tsvgx', 02:55:56 INFO - 'tsvgr_opacity', 02:55:56 INFO - 'tart', 02:55:56 INFO - 'tscrollx', 02:55:56 INFO - 'tsvg_static']}, 02:55:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:55:56 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:55:56 INFO - 'talos_options': ['--enable-stylo'], 02:55:56 INFO - 'tests': ['tp5o']}, 02:55:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:55:56 INFO - 'talos_options': ['--mitmproxy', 02:55:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:55:56 INFO - '--firstNonBlankPaint'], 02:55:56 INFO - 'tests': ['tp6_google', 02:55:56 INFO - 'tp6_youtube', 02:55:56 INFO - 'tp6_amazon', 02:55:56 INFO - 'tp6_facebook']}, 02:55:56 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:55:56 INFO - 'talos_options': ['--enable-stylo', 02:55:56 INFO - '--mitmproxy', 02:55:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:55:56 INFO - '--firstNonBlankPaint'], 02:55:56 INFO - 'tests': ['tp6_google', 02:55:56 INFO - 'tp6_youtube', 02:55:56 INFO - 'tp6_amazon', 02:55:56 INFO - 'tp6_facebook']}, 02:55:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:55:56 INFO - 'talos_options': ['--enable-stylo', 02:55:56 INFO - '--stylo-threads=1', 02:55:56 INFO - '--mitmproxy', 02:55:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:55:56 INFO - '--firstNonBlankPaint'], 02:55:56 INFO - 'tests': ['tp6_google', 02:55:56 INFO - 'tp6_youtube', 02:55:56 INFO - 'tp6_amazon', 02:55:56 INFO - 'tp6_facebook']}, 02:55:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:55:56 INFO - 'talos_options': ['--xperf_path', 02:55:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:56 INFO - 'tests': ['tp5n']}, 02:55:56 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:55:56 INFO - 'talos_options': ['--enable-stylo', 02:55:56 INFO - '--xperf_path', 02:55:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:56 INFO - 'tests': ['tp5n']}}} 02:55:56 INFO - Running post-action listener: _resource_record_post_action 02:55:56 INFO - [mozharness: 2017-08-30 09:55:56.765655Z] Finished populate-webroot step (success) 02:55:56 INFO - [mozharness: 2017-08-30 09:55:56.765745Z] Running create-virtualenv step. 02:55:56 INFO - Running pre-action listener: _resource_record_pre_action 02:55:56 INFO - Running main action method: create_virtualenv 02:55:56 INFO - Creating virtualenv /builds/slave/test/build/venv 02:55:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:55:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:55:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:55:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:55:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:55:57 INFO - Installing distribute.............................................................................................................................................................................................done. 02:55:57 INFO - Installing pip...............done. 02:55:57 INFO - Return code: 0 02:55:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:55:57 INFO - Reading from file tmpfile_stdout 02:55:57 INFO - Output received: 02:55:57 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:55:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81580>, '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 0xf82480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', '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 02:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:55:57 INFO - Using env: {'DISPLAY': ':0', 02:55:57 INFO - 'HOME': '/home/cltbld', 02:55:57 INFO - 'LANG': 'en_US.UTF-8', 02:55:57 INFO - 'LANGUAGE': 'en_US:en', 02:55:57 INFO - 'LOGNAME': 'cltbld', 02:55:57 INFO - 'MAIL': '/var/mail/cltbld', 02:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:57 INFO - 'MOZ_NO_REMOTE': '1', 02:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:57 INFO - 'NO_EM_RESTART': '1', 02:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:57 INFO - 'PWD': '/builds/slave/test', 02:55:57 INFO - 'SHELL': '/bin/bash', 02:55:57 INFO - 'SHLVL': '1', 02:55:57 INFO - 'TERM': 'linux', 02:55:57 INFO - 'TMOUT': '86400', 02:55:57 INFO - 'USER': 'cltbld', 02:55:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', 02:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:57 INFO - '_': '/tools/buildbot/bin/python'} 02:55:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:55:58 INFO - Downloading/unpacking pip>=1.5 02:55:58 INFO - Running setup.py egg_info for package pip 02:55:58 INFO - warning: no files found matching 'pip/cacert.pem' 02:55:58 INFO - warning: no files found matching '*.html' under directory 'docs' 02:55:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:55:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:55:58 INFO - Installing collected packages: pip 02:55:58 INFO - Found existing installation: pip 1.1 02:55:58 INFO - Uninstalling pip: 02:55:58 INFO - Successfully uninstalled pip 02:55:58 INFO - Running setup.py install for pip 02:55:58 INFO - warning: no files found matching 'pip/cacert.pem' 02:55:58 INFO - warning: no files found matching '*.html' under directory 'docs' 02:55:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:55:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:55:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:55:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:55:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:55:58 INFO - Successfully installed pip 02:55:58 INFO - Cleaning up... 02:55:58 INFO - Return code: 0 02:55:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:58 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 0xc151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81580>, '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 0xf82480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', '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 02:55:58 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 02:55:58 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 02:55:58 INFO - Using env: {'DISPLAY': ':0', 02:55:58 INFO - 'HOME': '/home/cltbld', 02:55:58 INFO - 'LANG': 'en_US.UTF-8', 02:55:58 INFO - 'LANGUAGE': 'en_US:en', 02:55:58 INFO - 'LOGNAME': 'cltbld', 02:55:58 INFO - 'MAIL': '/var/mail/cltbld', 02:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:58 INFO - 'MOZ_NO_REMOTE': '1', 02:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:58 INFO - 'NO_EM_RESTART': '1', 02:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:58 INFO - 'PWD': '/builds/slave/test', 02:55:58 INFO - 'SHELL': '/bin/bash', 02:55:58 INFO - 'SHLVL': '1', 02:55:58 INFO - 'TERM': 'linux', 02:55:58 INFO - 'TMOUT': '86400', 02:55:58 INFO - 'USER': 'cltbld', 02:55:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', 02:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:58 INFO - '_': '/tools/buildbot/bin/python'} 02:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:59 INFO - Downloading/unpacking psutil>=3.1.1 02:55:59 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 02:55:59 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 02:55:59 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 02:55:59 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 02:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:56:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:56:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:56:00 INFO - Installing collected packages: psutil 02:56:00 INFO - Running setup.py install for psutil 02:56:00 INFO - building 'psutil._psutil_linux' extension 02:56:00 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 02:56:00 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 02:56:00 INFO - building 'psutil._psutil_posix' extension 02:56:00 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 02:56:00 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 02:56:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:56:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:56:00 INFO - Successfully installed psutil 02:56:00 INFO - Cleaning up... 02:56:00 INFO - Return code: 0 02:56:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56: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')]} 02:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:00 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 0xc151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81580>, '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 0xf82480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', '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 02:56:00 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 02:56:00 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 02:56:00 INFO - Using env: {'DISPLAY': ':0', 02:56:00 INFO - 'HOME': '/home/cltbld', 02:56:00 INFO - 'LANG': 'en_US.UTF-8', 02:56:00 INFO - 'LANGUAGE': 'en_US:en', 02:56:00 INFO - 'LOGNAME': 'cltbld', 02:56:00 INFO - 'MAIL': '/var/mail/cltbld', 02:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:00 INFO - 'MOZ_NO_REMOTE': '1', 02:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:00 INFO - 'NO_EM_RESTART': '1', 02:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:00 INFO - 'PWD': '/builds/slave/test', 02:56:00 INFO - 'SHELL': '/bin/bash', 02:56:00 INFO - 'SHLVL': '1', 02:56:00 INFO - 'TERM': 'linux', 02:56:00 INFO - 'TMOUT': '86400', 02:56:00 INFO - 'USER': 'cltbld', 02:56:00 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', 02:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:00 INFO - '_': '/tools/buildbot/bin/python'} 02:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:56:01 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 02:56:01 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 02:56:01 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 02:56:01 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 02:56:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:56:02 INFO - Installing collected packages: mozsystemmonitor 02:56:02 INFO - Running setup.py install for mozsystemmonitor 02:56:02 INFO - Successfully installed mozsystemmonitor 02:56:02 INFO - Cleaning up... 02:56:02 INFO - Return code: 0 02:56:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:02 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 0xc151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81580>, '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 0xf82480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', '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 02:56:02 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 02:56:02 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 02:56:02 INFO - Using env: {'DISPLAY': ':0', 02:56:02 INFO - 'HOME': '/home/cltbld', 02:56:02 INFO - 'LANG': 'en_US.UTF-8', 02:56:02 INFO - 'LANGUAGE': 'en_US:en', 02:56:02 INFO - 'LOGNAME': 'cltbld', 02:56:02 INFO - 'MAIL': '/var/mail/cltbld', 02:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:02 INFO - 'MOZ_NO_REMOTE': '1', 02:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:02 INFO - 'NO_EM_RESTART': '1', 02:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:02 INFO - 'PWD': '/builds/slave/test', 02:56:02 INFO - 'SHELL': '/bin/bash', 02:56:02 INFO - 'SHLVL': '1', 02:56:02 INFO - 'TERM': 'linux', 02:56:02 INFO - 'TMOUT': '86400', 02:56:02 INFO - 'USER': 'cltbld', 02:56:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', 02:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:02 INFO - '_': '/tools/buildbot/bin/python'} 02:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:02 INFO - Downloading/unpacking jsonschema==2.5.1 02:56:02 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 02:56:02 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 02:56:02 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 02:56:02 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 02:56:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:56:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:03 INFO - Downloading functools32-3.2.3-2.tar.gz 02:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:56:03 INFO - warning: no files found matching '*.txt' 02:56:03 INFO - no previously-included directories found matching 'build' 02:56:03 INFO - no previously-included directories found matching 'dist' 02:56:03 INFO - no previously-included directories found matching '.git*' 02:56:03 INFO - Installing collected packages: jsonschema, functools32 02:56:03 INFO - Running setup.py install for functools32 02:56:04 INFO - warning: no files found matching '*.txt' 02:56:04 INFO - no previously-included directories found matching 'build' 02:56:04 INFO - no previously-included directories found matching 'dist' 02:56:04 INFO - no previously-included directories found matching '.git*' 02:56:04 INFO - Successfully installed jsonschema functools32 02:56:04 INFO - Cleaning up... 02:56:04 INFO - Return code: 0 02:56:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:56:04 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')]} 02:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:04 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')]} 02:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:04 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 0xc151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81580>, '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 0xf82480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', '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 02:56:04 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 02:56:04 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 02:56:04 INFO - Using env: {'DISPLAY': ':0', 02:56:04 INFO - 'HOME': '/home/cltbld', 02:56:04 INFO - 'LANG': 'en_US.UTF-8', 02:56:04 INFO - 'LANGUAGE': 'en_US:en', 02:56:04 INFO - 'LOGNAME': 'cltbld', 02:56:04 INFO - 'MAIL': '/var/mail/cltbld', 02:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:04 INFO - 'MOZ_NO_REMOTE': '1', 02:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:04 INFO - 'NO_EM_RESTART': '1', 02:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:04 INFO - 'PWD': '/builds/slave/test', 02:56:04 INFO - 'SHELL': '/bin/bash', 02:56:04 INFO - 'SHLVL': '1', 02:56:04 INFO - 'TERM': 'linux', 02:56:04 INFO - 'TMOUT': '86400', 02:56:04 INFO - 'USER': 'cltbld', 02:56:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', 02:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:04 INFO - '_': '/tools/buildbot/bin/python'} 02:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:56:04 INFO - Cleaning up... 02:56:04 INFO - Return code: 0 02:56:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:56:04 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')]} 02:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:04 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')]} 02:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:04 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 0xc151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81580>, '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 0xf82480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', '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 02:56:04 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 02:56:04 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 02:56:04 INFO - Using env: {'DISPLAY': ':0', 02:56:04 INFO - 'HOME': '/home/cltbld', 02:56:04 INFO - 'LANG': 'en_US.UTF-8', 02:56:04 INFO - 'LANGUAGE': 'en_US:en', 02:56:04 INFO - 'LOGNAME': 'cltbld', 02:56:04 INFO - 'MAIL': '/var/mail/cltbld', 02:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:04 INFO - 'MOZ_NO_REMOTE': '1', 02:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:04 INFO - 'NO_EM_RESTART': '1', 02:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:04 INFO - 'PWD': '/builds/slave/test', 02:56:04 INFO - 'SHELL': '/bin/bash', 02:56:04 INFO - 'SHLVL': '1', 02:56:04 INFO - 'TERM': 'linux', 02:56:04 INFO - 'TMOUT': '86400', 02:56:04 INFO - 'USER': 'cltbld', 02:56:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', 02:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:04 INFO - '_': '/tools/buildbot/bin/python'} 02:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:04 INFO - Downloading/unpacking blobuploader==1.2.4 02:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:05 INFO - Downloading blobuploader-1.2.4.tar.gz 02:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:56:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:56:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:06 INFO - Downloading docopt-0.6.1.tar.gz 02:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:56:06 INFO - Installing collected packages: blobuploader, requests, docopt 02:56:06 INFO - Running setup.py install for blobuploader 02:56:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:56:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:56:06 INFO - Running setup.py install for requests 02:56:06 INFO - Running setup.py install for docopt 02:56:06 INFO - Successfully installed blobuploader requests docopt 02:56:06 INFO - Cleaning up... 02:56:06 INFO - Return code: 0 02:56:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:06 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')]} 02:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:06 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')]} 02:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:06 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 0xc151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81580>, '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 0xf82480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', '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 02:56:06 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 02:56:06 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 02:56:06 INFO - Using env: {'DISPLAY': ':0', 02:56:06 INFO - 'HOME': '/home/cltbld', 02:56:06 INFO - 'LANG': 'en_US.UTF-8', 02:56:06 INFO - 'LANGUAGE': 'en_US:en', 02:56:06 INFO - 'LOGNAME': 'cltbld', 02:56:06 INFO - 'MAIL': '/var/mail/cltbld', 02:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:06 INFO - 'MOZ_NO_REMOTE': '1', 02:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:06 INFO - 'NO_EM_RESTART': '1', 02:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:06 INFO - 'PWD': '/builds/slave/test', 02:56:06 INFO - 'SHELL': '/bin/bash', 02:56:06 INFO - 'SHLVL': '1', 02:56:06 INFO - 'TERM': 'linux', 02:56:06 INFO - 'TMOUT': '86400', 02:56:06 INFO - 'USER': 'cltbld', 02:56:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', 02:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:06 INFO - '_': '/tools/buildbot/bin/python'} 02:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:07 INFO - Running setup.py (path:/tmp/pip-mZ3FpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:07 INFO - Running setup.py (path:/tmp/pip-qlOiVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:07 INFO - Running setup.py (path:/tmp/pip-9pb1FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:07 INFO - Running setup.py (path:/tmp/pip-Doc8jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:07 INFO - Running setup.py (path:/tmp/pip-a00Wnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:07 INFO - Running setup.py (path:/tmp/pip-MJTHb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:07 INFO - Running setup.py (path:/tmp/pip-auTupy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:07 INFO - Running setup.py (path:/tmp/pip-EUCLp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:07 INFO - Running setup.py (path:/tmp/pip-9t4lha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:07 INFO - Running setup.py (path:/tmp/pip-oCjMwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:07 INFO - Running setup.py (path:/tmp/pip-JbLXX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:07 INFO - Running setup.py (path:/tmp/pip-uN6lrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:07 INFO - Running setup.py (path:/tmp/pip-eSXtt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:07 INFO - Running setup.py (path:/tmp/pip-D43GTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:08 INFO - Running setup.py (path:/tmp/pip-GnPMfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:08 INFO - Running setup.py (path:/tmp/pip-Z3nOLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:08 INFO - Running setup.py (path:/tmp/pip-tduJo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:56:08 INFO - Running setup.py install for manifestparser 02:56:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:56:08 INFO - Running setup.py install for mozcrash 02:56:08 INFO - Running setup.py install for mozdebug 02:56:08 INFO - Running setup.py install for mozdevice 02:56:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:56:08 INFO - Running setup.py install for mozfile 02:56:08 INFO - Running setup.py install for mozhttpd 02:56:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:56:08 INFO - Running setup.py install for mozinfo 02:56:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:56:08 INFO - Running setup.py install for mozInstall 02:56:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:56:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:56:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:56:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:56:08 INFO - Running setup.py install for mozleak 02:56:09 INFO - Running setup.py install for mozlog 02:56:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:56:09 INFO - Running setup.py install for moznetwork 02:56:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:56:09 INFO - Running setup.py install for mozprocess 02:56:09 INFO - Running setup.py install for mozprofile 02:56:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:56:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:56:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:56:09 INFO - Running setup.py install for mozrunner 02:56:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:56:09 INFO - Running setup.py install for mozscreenshot 02:56:09 INFO - Running setup.py install for moztest 02:56:09 INFO - Running setup.py install for mozversion 02:56:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:56:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:56:09 INFO - Cleaning up... 02:56:09 INFO - Return code: 0 02:56:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:09 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')]} 02:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:09 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')]} 02:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:09 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 0xc151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81580>, '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 0xf82480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', '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 02:56:09 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 02:56:09 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 02:56:09 INFO - Using env: {'DISPLAY': ':0', 02:56:09 INFO - 'HOME': '/home/cltbld', 02:56:09 INFO - 'LANG': 'en_US.UTF-8', 02:56:09 INFO - 'LANGUAGE': 'en_US:en', 02:56:09 INFO - 'LOGNAME': 'cltbld', 02:56:09 INFO - 'MAIL': '/var/mail/cltbld', 02:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:09 INFO - 'MOZ_NO_REMOTE': '1', 02:56:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:09 INFO - 'NO_EM_RESTART': '1', 02:56:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:09 INFO - 'PWD': '/builds/slave/test', 02:56:09 INFO - 'SHELL': '/bin/bash', 02:56:09 INFO - 'SHLVL': '1', 02:56:09 INFO - 'TERM': 'linux', 02:56:09 INFO - 'TMOUT': '86400', 02:56:09 INFO - 'USER': 'cltbld', 02:56:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', 02:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:09 INFO - '_': '/tools/buildbot/bin/python'} 02:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:10 INFO - Running setup.py (path:/tmp/pip-AWKbfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:10 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)) 02:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:10 INFO - Running setup.py (path:/tmp/pip-vyFI_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:10 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)) 02:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:10 INFO - Running setup.py (path:/tmp/pip-kfvYdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:10 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)) 02:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:10 INFO - Running setup.py (path:/tmp/pip-mA4WMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:10 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)) 02:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:10 INFO - Running setup.py (path:/tmp/pip-Fl_svC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:10 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)) 02:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:10 INFO - Running setup.py (path:/tmp/pip-_yzfSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:10 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)) 02:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:10 INFO - Running setup.py (path:/tmp/pip-ginxW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:10 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)) 02:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:10 INFO - Running setup.py (path:/tmp/pip-rSYO0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:10 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)) 02:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:10 INFO - Running setup.py (path:/tmp/pip-7h1jOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:10 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)) 02:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:10 INFO - Running setup.py (path:/tmp/pip-2vjxYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:10 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)) 02:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:10 INFO - Running setup.py (path:/tmp/pip-qCrpJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:10 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)) 02:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:10 INFO - Running setup.py (path:/tmp/pip-4RNn6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:11 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)) 02:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:11 INFO - Running setup.py (path:/tmp/pip-ASL0OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:11 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)) 02:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:11 INFO - Running setup.py (path:/tmp/pip-Lzizsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:11 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)) 02:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:11 INFO - Running setup.py (path:/tmp/pip-yoH_AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:11 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)) 02:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:11 INFO - Running setup.py (path:/tmp/pip-Jmq5yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:11 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)) 02:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:11 INFO - Running setup.py (path:/tmp/pip-qublLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:11 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)) 02:56:11 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)) 02:56:11 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)) 02:56:11 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)) 02:56:11 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)) 02:56:11 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)) 02:56:11 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)) 02:56:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:56:11 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 02:56:11 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 02:56:11 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 02:56:11 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 02:56:12 INFO - Downloading blessings-1.6.tar.gz 02:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:56:12 INFO - Installing collected packages: blessings 02:56:12 INFO - Running setup.py install for blessings 02:56:12 INFO - Successfully installed blessings 02:56:12 INFO - Cleaning up... 02:56:12 INFO - Return code: 0 02:56:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:56:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:12 INFO - Reading from file tmpfile_stdout 02:56:12 INFO - Current package versions: 02:56:12 INFO - argparse == 1.2.1 02:56:12 INFO - blessings == 1.6 02:56:12 INFO - blobuploader == 1.2.4 02:56:12 INFO - docopt == 0.6.1 02:56:12 INFO - functools32 == 3.2.3-2 02:56:12 INFO - jsonschema == 2.5.1 02:56:12 INFO - manifestparser == 1.1 02:56:12 INFO - mozInstall == 1.13 02:56:12 INFO - mozcrash == 1.0 02:56:12 INFO - mozdebug == 0.1 02:56:12 INFO - mozdevice == 0.51 02:56:12 INFO - mozfile == 1.2 02:56:12 INFO - mozhttpd == 0.7 02:56:12 INFO - mozinfo == 0.10 02:56:12 INFO - mozleak == 0.1 02:56:12 INFO - mozlog == 3.5 02:56:12 INFO - moznetwork == 0.27 02:56:12 INFO - mozprocess == 0.25 02:56:12 INFO - mozprofile == 0.28 02:56:12 INFO - mozrunner == 6.13 02:56:12 INFO - mozscreenshot == 0.1 02:56:12 INFO - mozsystemmonitor == 0.3 02:56:12 INFO - moztest == 0.8 02:56:12 INFO - mozversion == 1.4 02:56:12 INFO - psutil == 3.1.1 02:56:12 INFO - requests == 1.2.3 02:56:12 INFO - wsgiref == 0.1.2 02:56:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:12 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')]} 02:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:12 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')]} 02:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:12 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 0xc151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81580>, '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 0xf82480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', '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 02:56:12 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 02:56:12 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 02:56:12 INFO - Using env: {'DISPLAY': ':0', 02:56:12 INFO - 'HOME': '/home/cltbld', 02:56:12 INFO - 'LANG': 'en_US.UTF-8', 02:56:12 INFO - 'LANGUAGE': 'en_US:en', 02:56:12 INFO - 'LOGNAME': 'cltbld', 02:56:12 INFO - 'MAIL': '/var/mail/cltbld', 02:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:12 INFO - 'MOZ_NO_REMOTE': '1', 02:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:12 INFO - 'NO_EM_RESTART': '1', 02:56:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:12 INFO - 'PWD': '/builds/slave/test', 02:56:12 INFO - 'SHELL': '/bin/bash', 02:56:12 INFO - 'SHLVL': '1', 02:56:12 INFO - 'TERM': 'linux', 02:56:12 INFO - 'TMOUT': '86400', 02:56:12 INFO - 'USER': 'cltbld', 02:56:12 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', 02:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:12 INFO - '_': '/tools/buildbot/bin/python'} 02:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:13 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)) 02:56:13 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)) 02:56:13 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)) 02:56:13 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)) 02:56:13 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)) 02:56:13 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)) 02:56:13 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)) 02:56:13 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)) 02:56:13 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)) 02:56:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:56:13 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 02:56:13 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 02:56:13 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 02:56:13 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 02:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:56:14 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)) 02:56:14 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)) 02:56:14 INFO - Installing collected packages: simplejson 02:56:14 INFO - Running setup.py install for simplejson 02:56:14 INFO - building 'simplejson._speedups' extension 02:56:14 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 02:56:15 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 02:56:15 INFO - Successfully installed simplejson 02:56:15 INFO - Cleaning up... 02:56:15 INFO - Return code: 0 02:56:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:56:15 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')]} 02:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:15 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')]} 02:56:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:15 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 0xc151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81580>, '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 0xf82480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', '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 02:56:15 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 02:56:15 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 02:56:15 INFO - Using env: {'DISPLAY': ':0', 02:56:15 INFO - 'HOME': '/home/cltbld', 02:56:15 INFO - 'LANG': 'en_US.UTF-8', 02:56:15 INFO - 'LANGUAGE': 'en_US:en', 02:56:15 INFO - 'LOGNAME': 'cltbld', 02:56:15 INFO - 'MAIL': '/var/mail/cltbld', 02:56:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:15 INFO - 'MOZ_NO_REMOTE': '1', 02:56:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:15 INFO - 'NO_EM_RESTART': '1', 02:56:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:15 INFO - 'PWD': '/builds/slave/test', 02:56:15 INFO - 'SHELL': '/bin/bash', 02:56:15 INFO - 'SHLVL': '1', 02:56:15 INFO - 'TERM': 'linux', 02:56:15 INFO - 'TMOUT': '86400', 02:56:15 INFO - 'USER': 'cltbld', 02:56:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', 02:56:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:15 INFO - '_': '/tools/buildbot/bin/python'} 02:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:56:15 INFO - Cleaning up... 02:56:15 INFO - Return code: 0 02:56:15 INFO - Running post-action listener: _resource_record_post_action 02:56:15 INFO - Running post-action listener: _start_resource_monitoring 02:56:15 INFO - Starting resource monitoring. 02:56:15 INFO - [mozharness: 2017-08-30 09:56:15.667081Z] Finished create-virtualenv step (success) 02:56:15 INFO - [mozharness: 2017-08-30 09:56:15.667553Z] Running install step. 02:56:15 INFO - Running pre-action listener: _resource_record_pre_action 02:56:15 INFO - Running main action method: install 02:56:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:15 INFO - Reading from file tmpfile_stdout 02:56:15 INFO - Detecting whether we're running mozinstall >=1.0... 02:56:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:56:16 INFO - Reading from file tmpfile_stdout 02:56:16 INFO - Output received: 02:56:16 INFO - Usage: mozinstall [options] installer 02:56:16 INFO - Options: 02:56:16 INFO - -h, --help show this help message and exit 02:56:16 INFO - -d DEST, --destination=DEST 02:56:16 INFO - Directory to install application into. [default: 02:56:16 INFO - "/builds/slave/test"] 02:56:16 INFO - --app=APP Application being installed. [default: firefox] 02:56:16 INFO - mkdir: /builds/slave/test/build/application 02:56:16 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'] 02:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:56:32 INFO - Reading from file tmpfile_stdout 02:56:32 INFO - Output received: 02:56:32 INFO - /builds/slave/test/build/application/firefox/firefox 02:56:32 INFO - Running post-action listener: _resource_record_post_action 02:56:32 INFO - [mozharness: 2017-08-30 09:56:32.475682Z] Finished install step (success) 02:56:32 INFO - [mozharness: 2017-08-30 09:56:32.476024Z] Running setup-mitmproxy step. 02:56:32 INFO - Running pre-action listener: _resource_record_pre_action 02:56:32 INFO - Running main action method: setup_mitmproxy 02:56:32 INFO - Skipping: mitmproxy is not required 02:56:32 INFO - Running post-action listener: _resource_record_post_action 02:56:32 INFO - [mozharness: 2017-08-30 09:56:32.477746Z] Finished setup-mitmproxy step (success) 02:56:32 INFO - [mozharness: 2017-08-30 09:56:32.478058Z] Running run-tests step. 02:56:32 INFO - Running pre-action listener: _resource_record_pre_action 02:56:32 INFO - Running pre-action listener: _set_gcov_prefix 02:56:32 INFO - Running main action method: run_tests 02:56:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:56:32 INFO - Python 2.7.3 02:56:32 INFO - Return code: 0 02:56:32 INFO - grabbing minidump binary from tooltool 02:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:32 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 0xf81580>, '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 0xf82480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:56:32 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 02:56:32 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 02:56:32 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 02:56:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:56:32 INFO - Return code: 0 02:56:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:56:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:56:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:56:32 INFO - ENV: RUST_BACKTRACE is now full 02:56:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:56:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:56:32 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/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 02:56:32 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/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 02:56:32 INFO - Using env: {'DISPLAY': ':0', 02:56:32 INFO - 'HOME': '/home/cltbld', 02:56:32 INFO - 'LANG': 'en_US.UTF-8', 02:56:32 INFO - 'LANGUAGE': 'en_US:en', 02:56:32 INFO - 'LOGNAME': 'cltbld', 02:56:32 INFO - 'MAIL': '/var/mail/cltbld', 02:56:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:32 INFO - 'MOZ_NO_REMOTE': '1', 02:56:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:32 INFO - 'NO_EM_RESTART': '1', 02:56:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:32 INFO - 'PWD': '/builds/slave/test', 02:56:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:32 INFO - 'RUST_BACKTRACE': 'full', 02:56:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:56:32 INFO - 'SHELL': '/bin/bash', 02:56:32 INFO - 'SHLVL': '1', 02:56:32 INFO - 'STYLO_FORCE_ENABLED': '1', 02:56:32 INFO - 'TERM': 'linux', 02:56:32 INFO - 'TMOUT': '86400', 02:56:32 INFO - 'USER': 'cltbld', 02:56:32 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', 02:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:32 INFO - '_': '/tools/buildbot/bin/python'} 02:56:32 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/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 02:56:32 INFO - mozversion application_buildid: 20170830090533 02:56:32 INFO - mozversion application_changeset: ab2d700fda2b4934d24227216972dce9fac19b74 02:56:32 INFO - mozversion application_display_name: Nightly 02:56:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:56:32 INFO - mozversion application_name: Firefox 02:56:32 INFO - mozversion application_remotingname: firefox 02:56:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:56:32 INFO - mozversion application_vendor: Mozilla 02:56:32 INFO - mozversion application_version: 57.0a1 02:56:32 INFO - mozversion platform_buildid: 20170830090533 02:56:32 INFO - mozversion platform_changeset: ab2d700fda2b4934d24227216972dce9fac19b74 02:56:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:56:32 INFO - mozversion platform_version: 57.0a1 02:56:32 INFO - using testdate: 1504086992 02:56:32 INFO - actual date: 1504086992 02:56:32 INFO - starting webserver on 'localhost:37345' 02:56:32 INFO - SUITE-START | Running 2 tests 02:56:32 INFO - TEST-START | dromaeo_css 02:56:32 INFO - Initialising browser for dromaeo_css test... 02:56:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37345/getInfo.html -profile /tmp/tmpdHKWTp/profile 02:56:32 INFO - TEST-INFO | started process 14126 (/builds/slave/test/build/application/firefox/firefox http://localhost:37345/getInfo.html) 02:56:39 INFO - TEST-INFO | 14126: exit 0 02:56:39 INFO - Browser initialized. 02:56:39 INFO - Running cycle 1/1 for dromaeo_css test... 02:56:39 INFO - Using env: {'DISPLAY': ':0', 02:56:39 INFO - 'HOME': '/home/cltbld', 02:56:39 INFO - 'JSGC_DISABLE_POISONING': '1', 02:56:39 INFO - 'LANG': 'en_US.UTF-8', 02:56:39 INFO - 'LANGUAGE': 'en_US:en', 02:56:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:56:39 INFO - 'LOGNAME': 'cltbld', 02:56:39 INFO - 'MAIL': '/var/mail/cltbld', 02:56:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:56:39 INFO - 'MOZ_CRASHREPORTER': '1', 02:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:56:39 INFO - 'MOZ_NO_REMOTE': '1', 02:56:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:39 INFO - 'NO_EM_RESTART': '1', 02:56:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:39 INFO - 'PWD': '/builds/slave/test', 02:56:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:39 INFO - 'RUST_BACKTRACE': 'full', 02:56:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:56:39 INFO - 'SHELL': '/bin/bash', 02:56:39 INFO - 'SHLVL': '1', 02:56:39 INFO - 'STYLO_FORCE_ENABLED': '1', 02:56:39 INFO - 'TERM': 'linux', 02:56:39 INFO - 'TMOUT': '86400', 02:56:39 INFO - 'USER': 'cltbld', 02:56:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', 02:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:39 INFO - '_': '/tools/buildbot/bin/python'} 02:56:39 INFO - TEST-INFO | started process 14326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdHKWTp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:56:40 INFO - PID 14326 | 02:56:40 INFO - PID 14326 | (/builds/slave/test/build/application/firefox/firefox:14377): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:56:40 INFO - PID 14326 | 02:56:50 INFO - PID 14326 | RSS: Main: 171311104 02:56:50 INFO - PID 14326 | 02:59:49 INFO - PID 14326 | Cycle 1(1): loaded http://localhost:37345/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37345/tests/dromaeo/cssquery-ext.html) 02:59:51 INFO - PID 14326 | RSS: Main: 173998080 02:59:51 INFO - PID 14326 | 03:02:52 INFO - PID 14326 | Cycle 1(1): loaded http://localhost:37345/tests/dromaeo/cssquery-ext.html (next: http://localhost:37345/tests/dromaeo/cssquery-jquery.html) 03:02:53 INFO - PID 14326 | RSS: Main: 170672128 03:02:53 INFO - PID 14326 | 03:05:54 INFO - PID 14326 | Cycle 1(1): loaded http://localhost:37345/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37345/tests/dromaeo/cssquery-mootools.html) 03:05:55 INFO - PID 14326 | RSS: Main: 172646400 03:05:55 INFO - PID 14326 | 03:08:57 INFO - PID 14326 | Cycle 1(1): loaded http://localhost:37345/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37345/tests/dromaeo/cssquery-prototype.html) 03:08:57 INFO - PID 14326 | RSS: Main: 169623552 03:08:57 INFO - PID 14326 | 03:12:01 INFO - PID 14326 | Cycle 1(1): loaded http://localhost:37345/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37345/tests/dromaeo/cssquery-yui.html) 03:12:01 INFO - PID 14326 | RSS: Main: 172826624 03:12:01 INFO - PID 14326 | 03:15:03 INFO - PID 14326 | Cycle 1(1): loaded http://localhost:37345/tests/dromaeo/cssquery-yui.html (next: http://localhost:37345/tests/dromaeo/cssquery-dojo.html) 03:15:03 INFO - PID 14326 | RSS: Main: 175087616 03:15:03 INFO - PID 14326 | 03:15:03 INFO - PID 14326 | __start_tp_report 03:15:03 INFO - PID 14326 | _x_x_mozilla_page_load 03:15:03 INFO - PID 14326 | _x_x_mozilla_page_load_details 03:15:03 INFO - PID 14326 | |i|pagename|runs| 03:15:03 INFO - PID 14326 | |0;dojo.html;3208.5187221916694;3362.0418180818456;3384.458486642138;3385.4583266677328;3399.9150021249466;6399.872002559958;6482.286948435668;6495.8700825983515;6526.249481309651;6565.573237739543;6333;6400.199975003125;6403.3596640335945;6409;6436.645984470852;5859.6484210947265;5893.145493903381;5893.292804863411;5901.05583106703;5906.438888305604;5942.6137301075505;5949.434803693643;5968.343482216953;6034.487068599153;6072.05883088122;5954.166416701643;5992.610480318765;6014.488768454665;6023.879522409549;6064.636121832682;5740.5981581289325;5806.1000544915605;5832.591718579701;5923;5929.318128415244;5875.8531036724;5889.823305300848;5900.498457631106;5917.053271476543;5929.169916211734;6292.937070629327;6377.744890204386;6385.23377194735;6408.487321014308;6443.29123796382;6856.965715171392;6880.759173428956;6893.276205998348;6942.20164681058;6974;7002.929970700278;7004.369606735368;7012;7016.929830701679;7017.649117544153;6476.060971159155;6477.481801455872;6484.513661475408;6503.804885853432;6509.511786615928;6998.055262539492;7089.255628159072;7182.994380786694;7186.568805871664;7209.315115064061;6778.8983165251575;6798.830029249309;6862.656867156722;6876.037354770337;6892.620905850226;6757.594544327356;6846.726130954806;6913.827154321182;7003.369696727319;7006.929930700628;6869.244383117953;6926.307369263033;6951.582905025714;6962.721491140399;6974.825629359205;6912.343327383891;6986.4061554767395;7001.544899581511;7007.754728584475;7013.333733295329;5094.133997220481;5107.517521650256;5195.376554813447;5198.142306519458;5198.662086964335;4375.7374557526655;4407.889802754893;4435.6673249505775;4473.955260447419;4514.480834704051;6094.39056094387;6097.207363042865;6106.389361063858;6109.969450152721;6112.052631842072;6863.073485079551;6876.17485901685;6951.930480695129;6959.547629404073;6970.825729356807;6041.456268935729;6049.395060494004;6118.418750218722;6123.969380153071;6141.6007959482495;5731.885362292731;5836.708164591753;5864.501517370986;5927.585069045212;5929.495992840571;6742.224644165885;6783.728650853911;6823.931760682429;6829.043933849265;6838.829029274308;6940;6946.44428445713;6952.270011648704;7005.754798582026;7064.576125432491;6584.868302633825;6699.162604674416;6747.392734653905;6767.323267673391;6839.350261725128;6890.758823441155;6908.689108990007;6919.792406227822;6930.792076237721;6932.688029038806;6852.486063545154;7010.228874823663;7033.402160816388;7036.824079398056;7039.6832142552685;6682.431993280626;6684.83287917806;6691.866162676622;6770.593764374154;6798.8640227196165;6484.967575162094;6566.113574667359;6622.238442579165;6716.697748601422;6719.294474080151;6688.264290928091;6697.631630260383;6704.899426508508;6712.060311556484;6739.59562426256;6671.799846004627;6730.730770769114;6736.427403670743;6746.089277947414;6798.388145066968;6498.870022599616;6503.772367967288;6504.6747662615735;6508.121403610452;6508.349165083454 03:15:03 INFO - PID 14326 | |1;ext.html;827.1191181391818;837.9413441059128;855.8202777416742;884.3941899798639;886.7650072730728;40852;41584.79207603965;41591.37612935801;41652;41665.3750193747;40199;40605;40676.59323406765;40704.79647601758;40741;7591.24087591242;7714.537127772323;7725;7741.3419859312025;7751.457397982143;7536.962315188416;7744.148143704188;7773.883391749128;7774.689012439524;7775.416843736714;7721.49810262334;7728.420368472387;7745.380369570421;7747;7755.49589276698;7730.961345193266;7746.767596972099;7794.10367807698;7795.220477952216;7797.844043119163;7684.116326622398;7742.8838567421535;7743.883841742322;7749.535027898344;7751.186125456802;36814.44778328327;37062.07344816374;37092.07269818249;37107.257854843025;37162.814185929165;3626.1297288650535;3653.451982202664;3656.323580137683;3659.3779057560014;3660.0666829958454;30710.846445767853;30720.53919191214;30942.845285773426;31015.379692406026;31025.37949241025;5129.820456284012;5148.073346797575;5169.612279079047;5191.195364718475;5194.3247377840635;182993;185939;186021;186277;187510;48515.75742121267;48910.510894891304;48948;49013.26480102801;49304.506954929995;50069;50136;50196.49803501991;50279.24581131286;50303.496965030616;14232.430702771773;14388.424463021362;14401.495947641783;14405.855941440452;14591.927040364943;11626.302421854547;11632.88367116318;11639.59261425846;11644.010259128068;11669.183157178915;12790.424430900632;12918.806217906738;12941.223526588436;12964;13039.413226404835;5214.061468935628;5227.581793456515;5229.555487783505;5234;5240.475952404805;996.9601215951426;1004.5479534209635;1019.1184625299063;1021.3514418344256;1021.3718563083798;22458.663120053214;28069.438611227662;29062.19367166077;29134.708652913625;29463.852680736887;1062.8405739139191;1087.2606627493221;1094.600470828142;1101.7576133250673;1102.9834552481718;12255.509779608894;12326.198797078161;12350.505979760888;12359.62921112368;12361.93819030917;242565;244192;244495;244509;244728;50124.99500019958;50393.49606503962;50442;50479.74760126249;50609.24086138711;1372.1698372484502;1437.7915202295608;1440.7550716378241;1448.037055358196;1448.5437087317673;21935;22096.668549972084;22463.876806159955;22532.436689082904;22856.31431057071;37961.240775184895;38146;38245.617543824206;38340.23319533649;38348.42477362786;213834;214354;214446;214798;215151;32586.185345366557;32855.67144328622;35181.29637407289;36857.63142368649;36990.63009369872;44455;44484.11031779411;44711.77644111759;44926.32610510779;45023.87440314018;33452.330953381286;33629.49555756715;33912.15219619529;34138;34179;33194.66805332012;33271.66728332686;33368.33263334671;33668.32663346768;33896;36314.4552831713;37228;37543.061423464635;37546.06134846651;37819.24361512809;32260.35479290354;32830.507542386404;33157;34120.48819267763;34251.31497369989;24195.22999486131;24361.26916192517;24612.6308105375;24733.134340298002;25036.62445063362 03:15:03 INFO - PID 14326 | |2;jquery.html;574.6840233857555;576.5646936562895;591.3436085944603;593.379917985705;593.8485686150032;21799;22077.66883496747;22794.88602556987;22816.999999999978;22847.200347987822;24593.631095533583;25196;26376.472470550627;26510.939562417527;26683.599746003827;6515.80452586422;6650.667466626674;6657.500687448436;6661.766838160665;6691.598504089746;6182.72177752;6438.903416448757;6560.606363618198;6579.868402631969;6615.206175258975;6410.67946602668;6416.165898433197;6419.03714442835;6435.195600549931;6446.226452825667;6396.944504156809;6401.391867772578;6401.743930242785;6402.167718196628;6403.10356550081;5892.23400957877;5898.233229680114;5903.645781253139;5904.734286957054;5905.763769449217;28183.57724634132;29280.121596352143;29633.111006669835;29905;30009.549856752164;2062.05145633009;2107.8419118566167;2108.7469503659504;2108.968365474519;2111.092230340953;19970.301039463695;20111.899440502704;20426.591468170704;20432.693509597368;20434.182632694676;2461.667674863906;2480.751924807505;2516.3709072731817;2519.4205332773563;2525.2929179829675;137422;141484;141726;141886;142004;14758.48345307909;15031.699366012619;15238.695226095417;15270.541883743506;15461.226938653022;20838.37484875456;20922.895385522974;20929.790702093087;20943.16227350889;20945.37163885086;9698.27262955267;9711.514424278757;9730.367526110922;9739.56171972263;9869.753256168653;9209.217216536535;9226.630934762668;9306.86039709405;9423.151916327564;9424.575894084783;7685.730999414994;8877.689280875138;8930.240929520933;9011.324150688724;9299.535023248945;2584.224732580218;2651.7745991590546;2661.893524259047;2764.226016715323;2776.972230277712;955.1928620315822;980.6861804222581;981.9410835349902;985.9260555458369;1006.5118417567473;19483.415497535098;19723.112459939337;19961.500962476053;19980.10089545974;20381.490462738253;1035.5805898611075;1049.6693541534391;1051.0750539525168;1051.3429106808244;1066.4561073852235;11026.669199923856;13150.671233219246;14182.031778901644;14206;14423.567292981228;556688;559473;570906;572038;579460;114805;119692.40153799175;121570.39214803869;121827;122124;1231.4027696567157;1233.7224124571899;1257.3398965543163;1262.715888925003;1265.3546691187375;21573.568528629654;21787.673184902556;21817.454563636034;21928.342149735534;22222.22222222279;59118;60261.69869150626;60696.696516517135;61368.69315653393;62559.37440625535;72323.27676723376;72547.63726181335;72658.63670681613;72720.27279727347;73625;14289.071210371292;14437.133771973715;14460.20468874222;14486.565403037926;14517.274136293354;23027.07891684314;23074.307770766904;23159.884200579563;23179.3046208614;23211;18365.449036528924;18389.356372526898;18647.81352186461;18741.531461713566;18768.7184692227;16331.673366532841;16451.341946322493;16570.254338555034;17016.744748829024;17061.06164160983;17691.38080167188;18637.974911380003;19138.330158444387;19141.61716765685;19162.904185478983;14434;14596.978211525091;14607.85392146065;14619;14625.195614241318;18148.364807231683;18763.71854422212;19534.413967580997;19596.11817468246;19605.70591441101 03:15:03 INFO - PID 14326 | |3;mootools.html;1334.1061488802502;1379.7033637767881;1380.137414116178;1380.7100508893132;1390.0686540018187;14910.850891491096;15536;15668.216589170524;15674.921625391886;15856.048637081783;15973.680526389466;16324.102174380405;16372.83627163728;16387.180640967963;16394.426195083175;2732.945341093187;2763.295359683288;2798.664160300767;2822.6753923298775;2824.957625635617;2742.2321749909956;2755.435135797167;2757.379589592346;2757.600147978542;2759.572266298727;2686.865656717166;2689.690685571155;2713.3894873653467;2714.7556719895206;2715.3618899558587;2673.0777881630806;2677.866106694677;2678.7990900682526;2679.289988153141;2686.865656717166;2599.5970624553224;2622.1609085092778;2631.6841978962457;2640.762331390165;2641.8546979916096;15009.549713508612;15344.539663810103;15372.538823835303;15387.230638468032;15428.074315541104;8041.236082572146;8309.37679674021;8358.955130608674;8361.95819020901;8380.20388063133;5386.353637563518;5394.7842086316505;5553.8333849984565;5598.860028499279;5637.520810731093;1877.2303355624128;1898.5348589595499;1901.6862217734058;1908.9331873384365;1942.6114777044506;27416.725832741617;27606.171814845588;27625.309367265778;27746.861265693744;27812.721872781214;6782.626955517395;6795.18457785059;6855.314468553204;6976.895346569806;7065.82335441618;17415.303387864344;17428.302867885144;17445.563860903327;17465.650686986442;17475.56311092233;7606.467547271638;7714.382849372037;7727.5749833758555;7734.187910269453;7742.535447873146;5704.8859022819315;6342.365763423621;7114.110736157981;7479.065116860393;7490.1386340571535;4927.605791536668;5065.468125846806;5066.36670416198;5116.232565115188;5133.332666753298;1389.6317475868902;1395.427874571421;1397.210576024543;1415.4267521653746;1419.9503017394547;905.2350763604743;923.5243849417556;935.1630290889616;941.802221533472;943.4622265308845;7721.691132354643;7793.766187014398;7824.178461261599;7899.289063984269;7902.407319451064;650.7884937395365;677.4986509982676;721.7257442172046;729.5403895545772;735.0554537419497;4729.69256998294;4750.192467280571;4761.738104404221;4933.28467372229;5259.421463638997;21339.253126140822;22044.669329960063;22248.332550023526;22263.666045009337;22266.55466890653;21484.248051318442;21539.2461263855;21994.45013874634;22105.889470552866;22196.77803221947;11459.08327333828;11509.654710358702;11705.414729263503;11823.113266505046;11828.763424731456;8277.751667449986;8388.161183881562;8484.236418722345;8607.18231767981;8652.653893844175;18488;18924.43226703201;19026.7145992813;19415.3204637837;19478;19596.902015490403;19681.40955771329;19800.30698925588;19860;19892.104855281836;11291.887081129084;11479.4260286987;11489.195756296978;11490.310581365145;11492.482838272465;14249.216293103978;14404.42382304696;14489.347979340744;14590;14615.92692036533;10655.922095191363;10750.247482676137;10823.945880270549;10959.287646302964;11149.609763658233;10382.428966406618;10509.632162874568;10544.736381590521;10562.471876405994;10789.352638841694;9281.814363712823;9562.665306714232;9562.760930976781;9564.713058608253;9585.952070239604;7249.673764680497;7396.297351751575;7445.4415918805225;7523.623818808928;7581.658825352983;7403.222661620668;7412.740554080797;7445.888311675221;7500.812479688051;7509.136449308399 03:15:03 INFO - PID 14326 | |4;prototype.html;513.407014897793;525.5506541906667;537.5323468582334;538.8221886777362;540.889117730865;6314.968425157874;6326.588771729835;6357.55497115201;6362.65005424702;6392.680365981706;6180.381961803829;6253.656048917308;6260.937390626093;6326.272478664955;6348.682565871711;5230.783068412928;5239.847233608619;5260.843054347718;5281.63028587999;5297.761600727958;4898.456986049401;5067.366579177603;5202.193659982709;5272.209168624699;5284.867878303035;4981.825636102737;4998.475160108191;5000.874978125539;5038.697678139305;5060.7854115012315;4852.951470485285;4980.900381992376;5002.949970500321;5014.1225285575065;5017.64876458648;4517;4529.09418116378;4542.114287713897;4546.249868771649;4553.476350219701;6032.577719559633;6069.666168360783;6109.808587325473;6200.534959878028;6266.561340706153;5711.885762284731;5728.424683212108;5736.561961166488;5778.739956701958;5804.506616937565;6614.206295244553;6625.966870165618;6645.700943457556;6659.866802663968;6666.666666666696;4923;4924.778384972685;4929.408470983469;4933.235348520985;4952.678075925053;6607.306232845578;6691.159931019009;6886.655667216669;6889.827754306182;7065.858682826366;4986.950130498722;4987.825426110068;5000.774965126578;5018.5985121190215;5093.974530127326;5110.415771110967;5124.615653825978;5129.615278854101;5132.923006154911;5199.818006369835;5728.455796699391;5737.77048918047;5765.394633563499;5765.88468230633;5772.3938986406665;6612.636305003271;6637.701303441357;6689.96305572637;6693.631850248185;6697.7655782047395;1757.5957529768225;1776.7956684981134;1781.2429717370067;1789.7762779652544;1795.1921635264184;1160.9593664221882;1226.4113225651738;1240.4356018011783;1240.7332423528985;1241.5654520917788;5863.853403664943;5899.46904778572;5936.5066671997865;5943.702814859326;5974.462298393166;6749.291324410964;6764.627945462948;6793.592384456949;6834.555753875982;6943.9931209974275;5825.854353641193;5828.59199856006;5869.765209391662;5938.435848594377;5973.432523910308;3531.256867720225;3534.2578058607464;3599.2981368632863;3611.7652352596997;3635.5455568053994;6446.709898054599;6540.607563546202;6569.343065693488;6580.506462015368;6621.404073633396;6426.132472116298;6790.185177778698;6856.108705868205;6947.687354069079;6985.6507174641065;6514.013225966031;6590.439812615981;6591.934080659228;6680.899786503303;6742.292059333699;6712.2616512184595;6752.966235168793;6797.388235058671;6826.825526130373;6865.519413641197;6614.272430032789;6655.833604159935;6680.665966701743;6685.966570167118;6768.4585233182215;6583.30875258091;6633.170853643294;6657.234418041987;6680.331966803281;6688.933110669026;4927.852164435073;4958.157113290821;4968.950310496849;4969.45336013031;4991.825286114969;6531.836704082436;6659.567128136656;6674.199096108304;6748.527603067934;6842.623655698984;6462.192225971754;6529.085927970183;6531.706073226811;6556.901646475402;6638.734450622114;6564.9671751640935;6578.407943285128;6595.571287866273;6598.538102332791;6643.867122657423;6404.871902562016;6520.2395353253405;6522.445592124533;6565.934340656532;6604.603723776589;6536.934630653633;6555.475561955128;6619.768308109193;6640.83397915056;6652.634105124071;6288;6328.873422531616;6389.93610063912;6419.2938776735455;6475.255345635123 03:15:03 INFO - PID 14326 | |5;yui.html;876.2814492116465;880.3617377401381;881.3213825354474;899.7615631857557;901.9729408117755;16773.916130419362;17322.307107715707;17369.392071277493;17539.298428062877;20946.16215351388;20593.073311700973;21445;21654.675179872316;21812.236571719994;21859.890700546515;957.3298690916351;977.9853302200472;982.6658935961772;983.5082458770614;986.0977205856633;948.340903072365;984.1290457944699;985.5072463768116;986.6842610364686;988.5897352598663;1037.6938803053117;1038.678009816959;1038.9220808439397;1039.018127869164;1049.0139269087072;1028.4086650176105;1032.8708911386077;1033.1631378583334;1033.705393962717;1044.3838135500052;763.8052296664371;763.8090477380655;764.1174443517746;766.2988365645427;770.7803276066351;18921.62156756871;19210;19495.12271947766;19668.606627867506;19698.50753731154;18444.35444759427;18459.16933737985;18719;18822.905885470624;19066.61866762657;16226.594335141715;16413.17934103302;16526.256318465697;16596.917015414965;16599.170041497997;3561.4301711726;3642.0894776305922;3643.635636436335;3644.7995360255177;3646.6353364663587;134729;136582;138973.61026389708;139778.30110849484;139911;16014.759778603331;16300.42948496797;16539.338426463048;16629.6674066518;16779.748303775454;29826;29965.70034299629;30237.395252094833;30533.389332213676;30596.84701576478;7404.740834070782;7925.167857374892;8306.169383061646;8722.258608018263;8997.325200609981;4141.295979683461;4267.637250833652;4269.03946612016;4269.637080848162;4271.380649805761;5182.844514664566;5259.47405259471;5289.259503669489;5331.093714068617;5349.438308977579;1041.2815157541272;1059.2479339668766;1067.3595842494442;1080.0387654987069;1081.1350919264557;653.4804830160034;660.2572106380322;668.1514476614672;674.7098747538605;683.5147045597582;11453.885461145448;11494.770104597861;11745;12200.511979520898;12950.445946486481;638.450932198309;641.403494749887;648.967551622417;650.9153810004669;655.9147310849559;5548.445155484419;5607.186957891165;5632.690202038927;5712.942870571241;5872.031114866085;105920.47039764751;111130;111361.44319278514;111939;112506.87493124964;97639.51180244054;98746;99902.99999999854;101967.4901625502;102813;85980;86561.56719216364;86891;86895;88948.5552572233;10354.016368444985;10513.264071514921;10515.421651809223;10607.469626518488;10678.359298442118;40328.39507407333;41782.79108604437;41849.79075104605;42076.57923420727;43579;51537.7423112882;52300.73849630728;52886.20670689866;53156.468435316696;55102.72448637731;15361.385544578092;15610.141442220787;15689.137097459748;15736.05583664938;15783.131927744083;17102.914485427493;17140.485785426456;17166.31334746646;17339.739903901704;17405.912970435067;15093.54719358421;15154.16652084146;15184.392624294904;15190;15290.311935962685;16355.836441635907;16364.754528682317;16452.095134767704;16503.33986640521;16659.500214993568;15171.16558589244;15246.085234885943;15290.923545382202;15374.461893833663;15498.5350439487;11474.655760327203;11675.474603642686;11825.46785394642;12039.277643341427;12055.698607534881;11976.28142311464;12573.93713031429;12735.98112151007;13814;14319.498817541336 03:15:03 INFO - PID 14326 | __end_tp_report 03:15:03 INFO - PID 14326 | __start_cc_report 03:15:03 INFO - PID 14326 | _x_x_mozilla_cycle_collect,354 03:15:03 INFO - PID 14326 | __end_cc_report 03:15:03 INFO - PID 14326 | __startTimestamp1504088103859__endTimestamp 03:15:03 INFO - PID 14326 | 03:15:03 INFO - PID 14326 | ------- Summary: start ------- 03:15:03 INFO - PID 14326 | Number of tests: 6 03:15:03 INFO - PID 14326 | 03:15:03 INFO - PID 14326 | [#0] dojo.html Cycles:165 Average:6356.92 Median:6584.87 stddev:789.93 (12.0%) stddev-sans-first:752.76 03:15:03 INFO - PID 14326 | Values: 3208.5 3362.0 3384.5 3385.5 3399.9 6399.9 6482.3 6495.9 6526.2 6565.6 6333.0 6400.2 6403.4 6409.0 6436.6 5859.6 5893.1 5893.3 5901.1 5906.4 5942.6 5949.4 5968.3 6034.5 6072.1 5954.2 5992.6 6014.5 6023.9 6064.6 5740.6 5806.1 5832.6 5923.0 5929.3 5875.9 5889.8 5900.5 5917.1 5929.2 6292.9 6377.7 6385.2 6408.5 6443.3 6857.0 6880.8 6893.3 6942.2 6974.0 7002.9 7004.4 7012.0 7016.9 7017.6 6476.1 6477.5 6484.5 6503.8 6509.5 6998.1 7089.3 7183.0 7186.6 7209.3 6778.9 6798.8 6862.7 6876.0 6892.6 6757.6 6846.7 6913.8 7003.4 7006.9 6869.2 6926.3 6951.6 6962.7 6974.8 6912.3 6986.4 7001.5 7007.8 7013.3 5094.1 5107.5 5195.4 5198.1 5198.7 4375.7 4407.9 4435.7 4474.0 4514.5 6094.4 6097.2 6106.4 6110.0 6112.1 6863.1 6876.2 6951.9 6959.5 6970.8 6041.5 6049.4 6118.4 6124.0 6141.6 5731.9 5836.7 5864.5 5927.6 5929.5 6742.2 6783.7 6823.9 6829.0 6838.8 6940.0 6946.4 6952.3 7005.8 7064.6 6584.9 6699.2 6747.4 6767.3 6839.4 6890.8 6908.7 6919.8 6930.8 6932.7 6852.5 7010.2 7033.4 7036.8 7039.7 6682.4 6684.8 6691.9 6770.6 6798.9 6485.0 6566.1 6622.2 6716.7 6719.3 6688.3 6697.6 6704.9 6712.1 6739.6 6671.8 6730.7 6736.4 6746.1 6798.4 6498.9 6503.8 6504.7 6508.1 6508.3 03:15:03 INFO - PID 14326 | 03:15:03 INFO - PID 14326 | [#1] ext.html Cycles:180 Average:38408.10 Median:3657.85 stddev:56060.07 (1532.6%) stddev-sans-first:56146.31 03:15:03 INFO - PID 14326 | Values: 827.1 837.9 855.8 884.4 886.8 40852.0 41584.8 41591.4 41652.0 41665.4 40199.0 40605.0 40676.6 40704.8 40741.0 7591.2 7714.5 7725.0 7741.3 7751.5 7537.0 7744.1 7773.9 7774.7 7775.4 7721.5 7728.4 7745.4 7747.0 7755.5 7731.0 7746.8 7794.1 7795.2 7797.8 7684.1 7742.9 7743.9 7749.5 7751.2 36814.4 37062.1 37092.1 37107.3 37162.8 3626.1 3653.5 3656.3 3659.4 3660.1 30710.8 30720.5 30942.8 31015.4 31025.4 5129.8 5148.1 5169.6 5191.2 5194.3 182993.0 185939.0 186021.0 186277.0 187510.0 48515.8 48910.5 48948.0 49013.3 49304.5 50069.0 50136.0 50196.5 50279.2 50303.5 14232.4 14388.4 14401.5 14405.9 14591.9 11626.3 11632.9 11639.6 11644.0 11669.2 12790.4 12918.8 12941.2 12964.0 13039.4 5214.1 5227.6 5229.6 5234.0 5240.5 997.0 1004.5 1019.1 1021.4 1021.4 22458.7 28069.4 29062.2 29134.7 29463.9 1062.8 1087.3 1094.6 1101.8 1103.0 12255.5 12326.2 12350.5 12359.6 12361.9 242565.0 244192.0 244495.0 244509.0 244728.0 50125.0 50393.5 50442.0 50479.7 50609.2 1372.2 1437.8 1440.8 1448.0 1448.5 21935.0 22096.7 22463.9 22532.4 22856.3 37961.2 38146.0 38245.6 38340.2 38348.4 213834.0 214354.0 214446.0 214798.0 215151.0 32586.2 32855.7 35181.3 36857.6 36990.6 44455.0 44484.1 44711.8 44926.3 45023.9 33452.3 33629.5 33912.2 34138.0 34179.0 33194.7 33271.7 33368.3 33668.3 33896.0 36314.5 37228.0 37543.1 37546.1 37819.2 32260.4 32830.5 33157.0 34120.5 34251.3 24195.2 24361.3 24612.6 24733.1 25036.6 03:15:03 INFO - PID 14326 | 03:15:03 INFO - PID 14326 | [#2] jquery.html Cycles:180 Average:37432.60 Median:22937.14 stddev:94859.78 (413.6%) stddev-sans-first:95085.52 03:15:03 INFO - PID 14326 | Values: 574.7 576.6 591.3 593.4 593.8 21799.0 22077.7 22794.9 22817.0 22847.2 24593.6 25196.0 26376.5 26510.9 26683.6 6515.8 6650.7 6657.5 6661.8 6691.6 6182.7 6438.9 6560.6 6579.9 6615.2 6410.7 6416.2 6419.0 6435.2 6446.2 6396.9 6401.4 6401.7 6402.2 6403.1 5892.2 5898.2 5903.6 5904.7 5905.8 28183.6 29280.1 29633.1 29905.0 30009.5 2062.1 2107.8 2108.7 2109.0 2111.1 19970.3 20111.9 20426.6 20432.7 20434.2 2461.7 2480.8 2516.4 2519.4 2525.3 137422.0 141484.0 141726.0 141886.0 142004.0 14758.5 15031.7 15238.7 15270.5 15461.2 20838.4 20922.9 20929.8 20943.2 20945.4 9698.3 9711.5 9730.4 9739.6 9869.8 9209.2 9226.6 9306.9 9423.2 9424.6 7685.7 8877.7 8930.2 9011.3 9299.5 2584.2 2651.8 2661.9 2764.2 2777.0 955.2 980.7 981.9 985.9 1006.5 19483.4 19723.1 19961.5 19980.1 20381.5 1035.6 1049.7 1051.1 1051.3 1066.5 11026.7 13150.7 14182.0 14206.0 14423.6 556688.0 559473.0 570906.0 572038.0 579460.0 114805.0 119692.4 121570.4 121827.0 122124.0 1231.4 1233.7 1257.3 1262.7 1265.4 21573.6 21787.7 21817.5 21928.3 22222.2 59118.0 60261.7 60696.7 61368.7 62559.4 72323.3 72547.6 72658.6 72720.3 73625.0 14289.1 14437.1 14460.2 14486.6 14517.3 23027.1 23074.3 23159.9 23179.3 23211.0 18365.4 18389.4 18647.8 18741.5 18768.7 16331.7 16451.3 16570.3 17016.7 17061.1 17691.4 18638.0 19138.3 19141.6 19162.9 14434.0 14597.0 14607.9 14619.0 14625.2 18148.4 18763.7 19534.4 19596.1 19605.7 03:15:03 INFO - PID 14326 | 03:15:03 INFO - PID 14326 | [#3] mootools.html Cycles:180 Average:9436.60 Median:2688.28 stddev:6913.14 (257.2%) stddev-sans-first:6905.73 03:15:03 INFO - PID 14326 | Values: 1334.1 1379.7 1380.1 1380.7 1390.1 14910.9 15536.0 15668.2 15674.9 15856.0 15973.7 16324.1 16372.8 16387.2 16394.4 2732.9 2763.3 2798.7 2822.7 2825.0 2742.2 2755.4 2757.4 2757.6 2759.6 2686.9 2689.7 2713.4 2714.8 2715.4 2673.1 2677.9 2678.8 2679.3 2686.9 2599.6 2622.2 2631.7 2640.8 2641.9 15009.5 15344.5 15372.5 15387.2 15428.1 8041.2 8309.4 8359.0 8362.0 8380.2 5386.4 5394.8 5553.8 5598.9 5637.5 1877.2 1898.5 1901.7 1908.9 1942.6 27416.7 27606.2 27625.3 27746.9 27812.7 6782.6 6795.2 6855.3 6976.9 7065.8 17415.3 17428.3 17445.6 17465.7 17475.6 7606.5 7714.4 7727.6 7734.2 7742.5 5704.9 6342.4 7114.1 7479.1 7490.1 4927.6 5065.5 5066.4 5116.2 5133.3 1389.6 1395.4 1397.2 1415.4 1420.0 905.2 923.5 935.2 941.8 943.5 7721.7 7793.8 7824.2 7899.3 7902.4 650.8 677.5 721.7 729.5 735.1 4729.7 4750.2 4761.7 4933.3 5259.4 21339.3 22044.7 22248.3 22263.7 22266.6 21484.2 21539.2 21994.5 22105.9 22196.8 11459.1 11509.7 11705.4 11823.1 11828.8 8277.8 8388.2 8484.2 8607.2 8652.7 18488.0 18924.4 19026.7 19415.3 19478.0 19596.9 19681.4 19800.3 19860.0 19892.1 11291.9 11479.4 11489.2 11490.3 11492.5 14249.2 14404.4 14489.3 14590.0 14615.9 10655.9 10750.2 10823.9 10959.3 11149.6 10382.4 10509.6 10544.7 10562.5 10789.4 9281.8 9562.7 9562.8 9564.7 9586.0 7249.7 7396.3 7445.4 7523.6 7581.7 7403.2 7412.7 7445.9 7500.8 7509.1 03:15:03 INFO - PID 14326 | 03:15:03 INFO - PID 14326 | [#4] prototype.html Cycles:180 Average:5571.36 Median:6257.30 stddev:1555.47 (24.9%) stddev-sans-first:1512.79 03:15:03 INFO - PID 14326 | Values: 513.4 525.6 537.5 538.8 540.9 6315.0 6326.6 6357.6 6362.7 6392.7 6180.4 6253.7 6260.9 6326.3 6348.7 5230.8 5239.8 5260.8 5281.6 5297.8 4898.5 5067.4 5202.2 5272.2 5284.9 4981.8 4998.5 5000.9 5038.7 5060.8 4853.0 4980.9 5002.9 5014.1 5017.6 4517.0 4529.1 4542.1 4546.2 4553.5 6032.6 6069.7 6109.8 6200.5 6266.6 5711.9 5728.4 5736.6 5778.7 5804.5 6614.2 6626.0 6645.7 6659.9 6666.7 4923.0 4924.8 4929.4 4933.2 4952.7 6607.3 6691.2 6886.7 6889.8 7065.9 4987.0 4987.8 5000.8 5018.6 5094.0 5110.4 5124.6 5129.6 5132.9 5199.8 5728.5 5737.8 5765.4 5765.9 5772.4 6612.6 6637.7 6690.0 6693.6 6697.8 1757.6 1776.8 1781.2 1789.8 1795.2 1161.0 1226.4 1240.4 1240.7 1241.6 5863.9 5899.5 5936.5 5943.7 5974.5 6749.3 6764.6 6793.6 6834.6 6944.0 5825.9 5828.6 5869.8 5938.4 5973.4 3531.3 3534.3 3599.3 3611.8 3635.5 6446.7 6540.6 6569.3 6580.5 6621.4 6426.1 6790.2 6856.1 6947.7 6985.7 6514.0 6590.4 6591.9 6680.9 6742.3 6712.3 6753.0 6797.4 6826.8 6865.5 6614.3 6655.8 6680.7 6686.0 6768.5 6583.3 6633.2 6657.2 6680.3 6688.9 4927.9 4958.2 4969.0 4969.5 4991.8 6531.8 6659.6 6674.2 6748.5 6842.6 6462.2 6529.1 6531.7 6556.9 6638.7 6565.0 6578.4 6595.6 6598.5 6643.9 6404.9 6520.2 6522.4 6565.9 6604.6 6536.9 6555.5 6619.8 6640.8 6652.6 6288.0 6328.9 6389.9 6419.3 6475.3 03:15:03 INFO - PID 14326 | 03:15:03 INFO - PID 14326 | [#5] yui.html Cycles:180 Average:23163.23 Median:18994.12 stddev:33064.55 (174.1%) stddev-sans-first:33114.95 03:15:03 INFO - PID 14326 | Values: 876.3 880.4 881.3 899.8 902.0 16773.9 17322.3 17369.4 17539.3 20946.2 20593.1 21445.0 21654.7 21812.2 21859.9 957.3 978.0 982.7 983.5 986.1 948.3 984.1 985.5 986.7 988.6 1037.7 1038.7 1038.9 1039.0 1049.0 1028.4 1032.9 1033.2 1033.7 1044.4 763.8 763.8 764.1 766.3 770.8 18921.6 19210.0 19495.1 19668.6 19698.5 18444.4 18459.2 18719.0 18822.9 19066.6 16226.6 16413.2 16526.3 16596.9 16599.2 3561.4 3642.1 3643.6 3644.8 3646.6 134729.0 136582.0 138973.6 139778.3 139911.0 16014.8 16300.4 16539.3 16629.7 16779.7 29826.0 29965.7 30237.4 30533.4 30596.8 7404.7 7925.2 8306.2 8722.3 8997.3 4141.3 4267.6 4269.0 4269.6 4271.4 5182.8 5259.5 5289.3 5331.1 5349.4 1041.3 1059.2 1067.4 1080.0 1081.1 653.5 660.3 668.2 674.7 683.5 11453.9 11494.8 11745.0 12200.5 12950.4 638.5 641.4 649.0 650.9 655.9 5548.4 5607.2 5632.7 5712.9 5872.0 105920.5 111130.0 111361.4 111939.0 112506.9 97639.5 98746.0 99903.0 101967.5 102813.0 85980.0 86561.6 86891.0 86895.0 88948.6 10354.0 10513.3 10515.4 10607.5 10678.4 40328.4 41782.8 41849.8 42076.6 43579.0 51537.7 52300.7 52886.2 53156.5 55102.7 15361.4 15610.1 15689.1 15736.1 15783.1 17102.9 17140.5 17166.3 17339.7 17405.9 15093.5 15154.2 15184.4 15190.0 15290.3 16355.8 16364.8 16452.1 16503.3 16659.5 15171.2 15246.1 15290.9 15374.5 15498.5 11474.7 11675.5 11825.5 12039.3 12055.7 11976.3 12573.9 12736.0 13814.0 14319.5 03:15:03 INFO - PID 14326 | -------- Summary: end -------- 03:15:03 INFO - PID 14326 | 03:15:04 INFO - TEST-INFO | 14326: exit 0 03:15:04 INFO - TEST-OK | dromaeo_css | took 1111791ms 03:15:04 INFO - TEST-START | kraken 03:15:04 INFO - Initialising browser for kraken test... 03:15:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37345/getInfo.html -profile /tmp/tmpJS9_Bm/profile 03:15:04 INFO - TEST-INFO | started process 14711 (/builds/slave/test/build/application/firefox/firefox http://localhost:37345/getInfo.html) 03:15:11 INFO - TEST-INFO | 14711: exit 0 03:15:11 INFO - Browser initialized. 03:15:11 INFO - Running cycle 1/1 for kraken test... 03:15:11 INFO - Using env: {'DISPLAY': ':0', 03:15:11 INFO - 'HOME': '/home/cltbld', 03:15:11 INFO - 'JSGC_DISABLE_POISONING': '1', 03:15:11 INFO - 'LANG': 'en_US.UTF-8', 03:15:11 INFO - 'LANGUAGE': 'en_US:en', 03:15:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:15:11 INFO - 'LOGNAME': 'cltbld', 03:15:11 INFO - 'MAIL': '/var/mail/cltbld', 03:15:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:15:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:15:11 INFO - 'MOZ_CRASHREPORTER': '1', 03:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:15:11 INFO - 'MOZ_NO_REMOTE': '1', 03:15:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:11 INFO - 'NO_EM_RESTART': '1', 03:15:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:11 INFO - 'PWD': '/builds/slave/test', 03:15:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:15:11 INFO - 'RUST_BACKTRACE': 'full', 03:15:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:15:11 INFO - 'SHELL': '/bin/bash', 03:15:11 INFO - 'SHLVL': '1', 03:15:11 INFO - 'STYLO_FORCE_ENABLED': '1', 03:15:11 INFO - 'TERM': 'linux', 03:15:11 INFO - 'TMOUT': '86400', 03:15:11 INFO - 'USER': 'cltbld', 03:15:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655', 03:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:11 INFO - '_': '/tools/buildbot/bin/python'} 03:15:11 INFO - TEST-INFO | started process 14911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJS9_Bm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:12 INFO - PID 14911 | 03:15:12 INFO - PID 14911 | (/builds/slave/test/build/application/firefox/firefox:14962): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:15:12 INFO - PID 14911 | 03:15:22 INFO - PID 14911 | RSS: Main: 171003904 03:15:22 INFO - PID 14911 | 03:15:25 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37345/tests/kraken/driver.html?testName=audio-beat-detection) 03:15:26 INFO - PID 14911 | RSS: Main: 175849472 03:15:26 INFO - PID 14911 | 03:15:28 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37345/tests/kraken/driver.html?testName=audio-dft) 03:15:29 INFO - PID 14911 | RSS: Main: 177217536 03:15:29 INFO - PID 14911 | 03:15:32 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37345/tests/kraken/driver.html?testName=audio-fft) 03:15:33 INFO - PID 14911 | RSS: Main: 171134976 03:15:33 INFO - PID 14911 | 03:15:35 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37345/tests/kraken/driver.html?testName=audio-oscillator) 03:15:35 INFO - PID 14911 | RSS: Main: 171614208 03:15:35 INFO - PID 14911 | 03:15:38 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37345/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:15:38 INFO - PID 14911 | RSS: Main: 172339200 03:15:38 INFO - PID 14911 | 03:15:41 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37345/tests/kraken/driver.html?testName=imaging-darkroom) 03:15:42 INFO - PID 14911 | RSS: Main: 174813184 03:15:42 INFO - PID 14911 | 03:15:45 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37345/tests/kraken/driver.html?testName=imaging-desaturate) 03:15:46 INFO - PID 14911 | RSS: Main: 174698496 03:15:46 INFO - PID 14911 | 03:15:49 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37345/tests/kraken/driver.html?testName=json-parse-financial) 03:15:50 INFO - PID 14911 | RSS: Main: 174477312 03:15:50 INFO - PID 14911 | 03:15:51 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37345/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:15:52 INFO - PID 14911 | RSS: Main: 174587904 03:15:52 INFO - PID 14911 | 03:15:53 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:15:54 INFO - PID 14911 | RSS: Main: 175304704 03:15:54 INFO - PID 14911 | 03:15:56 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:15:57 INFO - PID 14911 | RSS: Main: 172167168 03:15:57 INFO - PID 14911 | 03:15:59 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:16:00 INFO - PID 14911 | RSS: Main: 172240896 03:16:00 INFO - PID 14911 | 03:16:03 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:16:04 INFO - PID 14911 | RSS: Main: 172847104 03:16:04 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37345/tests/kraken/driver.html?testName=ai-astar) 03:16:06 INFO - PID 14911 | RSS: Main: 174280704 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | __start_tp_report 03:16:06 INFO - PID 14911 | _x_x_mozilla_page_load 03:16:06 INFO - PID 14911 | _x_x_mozilla_page_load_details 03:16:06 INFO - PID 14911 | |i|pagename|runs| 03:16:06 INFO - PID 14911 | |0;ai-astar;103;107;95;108;107;109;110;108;108;108 03:16:06 INFO - PID 14911 | |1;audio-beat-detection;148;118;145;186;120;150;148;120;164;119 03:16:06 INFO - PID 14911 | |2;audio-dft;163;163;164;163;162;162;168;166;163;162 03:16:06 INFO - PID 14911 | |3;audio-fft;78;79;74;175;74;74;76;87;98;76 03:16:06 INFO - PID 14911 | |4;audio-oscillator;80;80;131;79;80;79;127;79;80;137 03:16:06 INFO - PID 14911 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;114;113;114 03:16:06 INFO - PID 14911 | |6;imaging-darkroom;149;148;149;147;147;149;147;149;148;148 03:16:06 INFO - PID 14911 | |7;imaging-desaturate;94;95;94;94;94;94;95;94;94;93 03:16:06 INFO - PID 14911 | |8;json-parse-financial;56;55;52;52;52;52;53;51;53;53 03:16:06 INFO - PID 14911 | |9;json-stringify-tinderbox;38;39;38;38;37;38;38;38;38;38 03:16:06 INFO - PID 14911 | |10;stanford-crypto-aes;77;75;76;80;74;75;74;73;78;74 03:16:06 INFO - PID 14911 | |11;stanford-crypto-ccm;124;130;124;121;116;117;117;128;126;167 03:16:06 INFO - PID 14911 | |12;stanford-crypto-pbkdf2;182;170;182;177;172;177;173;170;171;172 03:16:06 INFO - PID 14911 | |13;stanford-crypto-sha256-iterative;66;65;65;65;71;65;68;63;65;64 03:16:06 INFO - PID 14911 | __end_tp_report 03:16:06 INFO - PID 14911 | __start_cc_report 03:16:06 INFO - PID 14911 | _x_x_mozilla_cycle_collect,942 03:16:06 INFO - PID 14911 | __end_cc_report 03:16:06 INFO - PID 14911 | __startTimestamp1504088166282__endTimestamp 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | ------- Summary: start ------- 03:16:06 INFO - PID 14911 | Number of tests: 14 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#0] ai-astar Cycles:10 Average:106.30 Median:108.00 stddev:4.37 (4.0%) stddev-sans-first:4.47 03:16:06 INFO - PID 14911 | Values: 103.0 107.0 95.0 108.0 107.0 109.0 110.0 108.0 108.0 108.0 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:148.00 stddev:22.70 (15.3%) stddev-sans-first:23.97 03:16:06 INFO - PID 14911 | Values: 148.0 118.0 145.0 186.0 120.0 150.0 148.0 120.0 164.0 119.0 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:1.96 (1.2%) stddev-sans-first:2.06 03:16:06 INFO - PID 14911 | Values: 163.0 163.0 164.0 163.0 162.0 162.0 168.0 166.0 163.0 162.0 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#3] audio-fft Cycles:10 Average:89.10 Median:77.00 stddev:31.12 (40.4%) stddev-sans-first:32.75 03:16:06 INFO - PID 14911 | Values: 78.0 79.0 74.0 175.0 74.0 74.0 76.0 87.0 98.0 76.0 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:79.50 stddev:25.28 (31.8%) stddev-sans-first:26.21 03:16:06 INFO - PID 14911 | Values: 80.0 80.0 131.0 79.0 80.0 79.0 127.0 79.0 80.0 137.0 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:16:06 INFO - PID 14911 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 114.0 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.50 stddev:0.88 (0.6%) stddev-sans-first:0.87 03:16:06 INFO - PID 14911 | Values: 149.0 148.0 149.0 147.0 147.0 149.0 147.0 149.0 148.0 148.0 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:16:06 INFO - PID 14911 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 93.0 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.52 (2.9%) stddev-sans-first:1.13 03:16:06 INFO - PID 14911 | Values: 56.0 55.0 52.0 52.0 52.0 52.0 53.0 51.0 53.0 53.0 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.47 (1.2%) stddev-sans-first:0.50 03:16:06 INFO - PID 14911 | Values: 38.0 39.0 38.0 38.0 37.0 38.0 38.0 38.0 38.0 38.0 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.50 stddev:2.17 (2.9%) stddev-sans-first:2.24 03:16:06 INFO - PID 14911 | Values: 77.0 75.0 76.0 80.0 74.0 75.0 74.0 73.0 78.0 74.0 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:125.00 stddev:14.85 (11.9%) stddev-sans-first:15.72 03:16:06 INFO - PID 14911 | Values: 124.0 130.0 124.0 121.0 116.0 117.0 117.0 128.0 126.0 167.0 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:175.00 stddev:4.62 (2.6%) stddev-sans-first:4.06 03:16:06 INFO - PID 14911 | Values: 182.0 170.0 182.0 177.0 172.0 177.0 173.0 170.0 171.0 172.0 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.00 stddev:2.26 (3.5%) stddev-sans-first:2.40 03:16:06 INFO - PID 14911 | Values: 66.0 65.0 65.0 65.0 71.0 65.0 68.0 63.0 65.0 64.0 03:16:06 INFO - PID 14911 | -------- Summary: end -------- 03:16:06 INFO - PID 14911 | 03:16:06 INFO - PID 14911 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:16:07 INFO - TEST-INFO | 14911: exit 0 03:16:07 INFO - TEST-OK | kraken | took 62453ms 03:16:07 INFO - SUITE-END | took 1174s 03:16:07 INFO - Completed test suite (00:19:34) 03:16:07 INFO - javascript benchmark 03:16:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8556.770881188453, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3208.5187221916694, 3362.0418180818456, 3384.458486642138, 3385.4583266677328, 3399.9150021249466, 6399.872002559958, 6482.286948435668, 6495.8700825983515, 6526.249481309651, 6565.573237739543, 6333.0, 6400.199975003125, 6403.3596640335945, 6409.0, 6436.645984470852, 5859.6484210947265, 5893.145493903381, 5893.292804863411, 5901.05583106703, 5906.438888305604, 5942.6137301075505, 5949.434803693643, 5968.343482216953, 6034.487068599153, 6072.05883088122, 5954.166416701643, 5992.610480318765, 6014.488768454665, 6023.879522409549, 6064.636121832682, 5740.5981581289325, 5806.1000544915605, 5832.591718579701, 5923.0, 5929.318128415244, 5875.8531036724, 5889.823305300848, 5900.498457631106, 5917.053271476543, 5929.169916211734, 6292.937070629327, 6377.744890204386, 6385.23377194735, 6408.487321014308, 6443.29123796382, 6856.965715171392, 6880.759173428956, 6893.276205998348, 6942.20164681058, 6974.0, 7002.929970700278, 7004.369606735368, 7012.0, 7016.929830701679, 7017.649117544153, 6476.060971159155, 6477.481801455872, 6484.513661475408, 6503.804885853432, 6509.511786615928, 6998.055262539492, 7089.255628159072, 7182.994380786694, 7186.568805871664, 7209.315115064061, 6778.8983165251575, 6798.830029249309, 6862.656867156722, 6876.037354770337, 6892.620905850226, 6757.594544327356, 6846.726130954806, 6913.827154321182, 7003.369696727319, 7006.929930700628, 6869.244383117953, 6926.307369263033, 6951.582905025714, 6962.721491140399, 6974.825629359205, 6912.343327383891, 6986.4061554767395, 7001.544899581511, 7007.754728584475, 7013.333733295329, 5094.133997220481, 5107.517521650256, 5195.376554813447, 5198.142306519458, 5198.662086964335, 4375.7374557526655, 4407.889802754893, 4435.6673249505775, 4473.955260447419, 4514.480834704051, 6094.39056094387, 6097.207363042865, 6106.389361063858, 6109.969450152721, 6112.052631842072, 6863.073485079551, 6876.17485901685, 6951.930480695129, 6959.547629404073, 6970.825729356807, 6041.456268935729, 6049.395060494004, 6118.418750218722, 6123.969380153071, 6141.6007959482495, 5731.885362292731, 5836.708164591753, 5864.501517370986, 5927.585069045212, 5929.495992840571, 6742.224644165885, 6783.728650853911, 6823.931760682429, 6829.043933849265, 6838.829029274308, 6940.0, 6946.44428445713, 6952.270011648704, 7005.754798582026, 7064.576125432491, 6584.868302633825, 6699.162604674416, 6747.392734653905, 6767.323267673391, 6839.350261725128, 6890.758823441155, 6908.689108990007, 6919.792406227822, 6930.792076237721, 6932.688029038806, 6852.486063545154, 7010.228874823663, 7033.402160816388, 7036.824079398056, 7039.6832142552685, 6682.431993280626, 6684.83287917806, 6691.866162676622, 6770.593764374154, 6798.8640227196165, 6484.967575162094, 6566.113574667359, 6622.238442579165, 6716.697748601422, 6719.294474080151, 6688.264290928091, 6697.631630260383, 6704.899426508508, 6712.060311556484, 6739.59562426256, 6671.799846004627, 6730.730770769114, 6736.427403670743, 6746.089277947414, 6798.388145066968, 6498.870022599616, 6503.772367967288, 6504.6747662615735, 6508.121403610452, 6508.349165083454], "value": 6295.624829290913, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.1191181391818, 837.9413441059128, 855.8202777416742, 884.3941899798639, 886.7650072730728, 40852.0, 41584.79207603965, 41591.37612935801, 41652.0, 41665.3750193747, 40199.0, 40605.0, 40676.59323406765, 40704.79647601758, 40741.0, 7591.24087591242, 7714.537127772323, 7725.0, 7741.3419859312025, 7751.457397982143, 7536.962315188416, 7744.148143704188, 7773.883391749128, 7774.689012439524, 7775.416843736714, 7721.49810262334, 7728.420368472387, 7745.380369570421, 7747.0, 7755.49589276698, 7730.961345193266, 7746.767596972099, 7794.10367807698, 7795.220477952216, 7797.844043119163, 7684.116326622398, 7742.8838567421535, 7743.883841742322, 7749.535027898344, 7751.186125456802, 36814.44778328327, 37062.07344816374, 37092.07269818249, 37107.257854843025, 37162.814185929165, 3626.1297288650535, 3653.451982202664, 3656.323580137683, 3659.3779057560014, 3660.0666829958454, 30710.846445767853, 30720.53919191214, 30942.845285773426, 31015.379692406026, 31025.37949241025, 5129.820456284012, 5148.073346797575, 5169.612279079047, 5191.195364718475, 5194.3247377840635, 182993.0, 185939.0, 186021.0, 186277.0, 187510.0, 48515.75742121267, 48910.510894891304, 48948.0, 49013.26480102801, 49304.506954929995, 50069.0, 50136.0, 50196.49803501991, 50279.24581131286, 50303.496965030616, 14232.430702771773, 14388.424463021362, 14401.495947641783, 14405.855941440452, 14591.927040364943, 11626.302421854547, 11632.88367116318, 11639.59261425846, 11644.010259128068, 11669.183157178915, 12790.424430900632, 12918.806217906738, 12941.223526588436, 12964.0, 13039.413226404835, 5214.061468935628, 5227.581793456515, 5229.555487783505, 5234.0, 5240.475952404805, 996.9601215951426, 1004.5479534209635, 1019.1184625299063, 1021.3514418344256, 1021.3718563083798, 22458.663120053214, 28069.438611227662, 29062.19367166077, 29134.708652913625, 29463.852680736887, 1062.8405739139191, 1087.2606627493221, 1094.600470828142, 1101.7576133250673, 1102.9834552481718, 12255.509779608894, 12326.198797078161, 12350.505979760888, 12359.62921112368, 12361.93819030917, 242565.0, 244192.0, 244495.0, 244509.0, 244728.0, 50124.99500019958, 50393.49606503962, 50442.0, 50479.74760126249, 50609.24086138711, 1372.1698372484502, 1437.7915202295608, 1440.7550716378241, 1448.037055358196, 1448.5437087317673, 21935.0, 22096.668549972084, 22463.876806159955, 22532.436689082904, 22856.31431057071, 37961.240775184895, 38146.0, 38245.617543824206, 38340.23319533649, 38348.42477362786, 213834.0, 214354.0, 214446.0, 214798.0, 215151.0, 32586.185345366557, 32855.67144328622, 35181.29637407289, 36857.63142368649, 36990.63009369872, 44455.0, 44484.11031779411, 44711.77644111759, 44926.32610510779, 45023.87440314018, 33452.330953381286, 33629.49555756715, 33912.15219619529, 34138.0, 34179.0, 33194.66805332012, 33271.66728332686, 33368.33263334671, 33668.32663346768, 33896.0, 36314.4552831713, 37228.0, 37543.061423464635, 37546.06134846651, 37819.24361512809, 32260.35479290354, 32830.507542386404, 33157.0, 34120.48819267763, 34251.31497369989, 24195.22999486131, 24361.26916192517, 24612.6308105375, 24733.134340298002, 25036.62445063362], "value": 17188.27822361702, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.6840233857555, 576.5646936562895, 591.3436085944603, 593.379917985705, 593.8485686150032, 21799.0, 22077.66883496747, 22794.88602556987, 22816.999999999978, 22847.200347987822, 24593.631095533583, 25196.0, 26376.472470550627, 26510.939562417527, 26683.599746003827, 6515.80452586422, 6650.667466626674, 6657.500687448436, 6661.766838160665, 6691.598504089746, 6182.72177752, 6438.903416448757, 6560.606363618198, 6579.868402631969, 6615.206175258975, 6410.67946602668, 6416.165898433197, 6419.03714442835, 6435.195600549931, 6446.226452825667, 6396.944504156809, 6401.391867772578, 6401.743930242785, 6402.167718196628, 6403.10356550081, 5892.23400957877, 5898.233229680114, 5903.645781253139, 5904.734286957054, 5905.763769449217, 28183.57724634132, 29280.121596352143, 29633.111006669835, 29905.0, 30009.549856752164, 2062.05145633009, 2107.8419118566167, 2108.7469503659504, 2108.968365474519, 2111.092230340953, 19970.301039463695, 20111.899440502704, 20426.591468170704, 20432.693509597368, 20434.182632694676, 2461.667674863906, 2480.751924807505, 2516.3709072731817, 2519.4205332773563, 2525.2929179829675, 137422.0, 141484.0, 141726.0, 141886.0, 142004.0, 14758.48345307909, 15031.699366012619, 15238.695226095417, 15270.541883743506, 15461.226938653022, 20838.37484875456, 20922.895385522974, 20929.790702093087, 20943.16227350889, 20945.37163885086, 9698.27262955267, 9711.514424278757, 9730.367526110922, 9739.56171972263, 9869.753256168653, 9209.217216536535, 9226.630934762668, 9306.86039709405, 9423.151916327564, 9424.575894084783, 7685.730999414994, 8877.689280875138, 8930.240929520933, 9011.324150688724, 9299.535023248945, 2584.224732580218, 2651.7745991590546, 2661.893524259047, 2764.226016715323, 2776.972230277712, 955.1928620315822, 980.6861804222581, 981.9410835349902, 985.9260555458369, 1006.5118417567473, 19483.415497535098, 19723.112459939337, 19961.500962476053, 19980.10089545974, 20381.490462738253, 1035.5805898611075, 1049.6693541534391, 1051.0750539525168, 1051.3429106808244, 1066.4561073852235, 11026.669199923856, 13150.671233219246, 14182.031778901644, 14206.0, 14423.567292981228, 556688.0, 559473.0, 570906.0, 572038.0, 579460.0, 114805.0, 119692.40153799175, 121570.39214803869, 121827.0, 122124.0, 1231.4027696567157, 1233.7224124571899, 1257.3398965543163, 1262.715888925003, 1265.3546691187375, 21573.568528629654, 21787.673184902556, 21817.454563636034, 21928.342149735534, 22222.22222222279, 59118.0, 60261.69869150626, 60696.696516517135, 61368.69315653393, 62559.37440625535, 72323.27676723376, 72547.63726181335, 72658.63670681613, 72720.27279727347, 73625.0, 14289.071210371292, 14437.133771973715, 14460.20468874222, 14486.565403037926, 14517.274136293354, 23027.07891684314, 23074.307770766904, 23159.884200579563, 23179.3046208614, 23211.0, 18365.449036528924, 18389.356372526898, 18647.81352186461, 18741.531461713566, 18768.7184692227, 16331.673366532841, 16451.341946322493, 16570.254338555034, 17016.744748829024, 17061.06164160983, 17691.38080167188, 18637.974911380003, 19138.330158444387, 19141.61716765685, 19162.904185478983, 14434.0, 14596.978211525091, 14607.85392146065, 14619.0, 14625.195614241318, 18148.364807231683, 18763.71854422212, 19534.413967580997, 19596.11817468246, 19605.70591441101], "value": 12206.670876755872, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.1061488802502, 1379.7033637767881, 1380.137414116178, 1380.7100508893132, 1390.0686540018187, 14910.850891491096, 15536.0, 15668.216589170524, 15674.921625391886, 15856.048637081783, 15973.680526389466, 16324.102174380405, 16372.83627163728, 16387.180640967963, 16394.426195083175, 2732.945341093187, 2763.295359683288, 2798.664160300767, 2822.6753923298775, 2824.957625635617, 2742.2321749909956, 2755.435135797167, 2757.379589592346, 2757.600147978542, 2759.572266298727, 2686.865656717166, 2689.690685571155, 2713.3894873653467, 2714.7556719895206, 2715.3618899558587, 2673.0777881630806, 2677.866106694677, 2678.7990900682526, 2679.289988153141, 2686.865656717166, 2599.5970624553224, 2622.1609085092778, 2631.6841978962457, 2640.762331390165, 2641.8546979916096, 15009.549713508612, 15344.539663810103, 15372.538823835303, 15387.230638468032, 15428.074315541104, 8041.236082572146, 8309.37679674021, 8358.955130608674, 8361.95819020901, 8380.20388063133, 5386.353637563518, 5394.7842086316505, 5553.8333849984565, 5598.860028499279, 5637.520810731093, 1877.2303355624128, 1898.5348589595499, 1901.6862217734058, 1908.9331873384365, 1942.6114777044506, 27416.725832741617, 27606.171814845588, 27625.309367265778, 27746.861265693744, 27812.721872781214, 6782.626955517395, 6795.18457785059, 6855.314468553204, 6976.895346569806, 7065.82335441618, 17415.303387864344, 17428.302867885144, 17445.563860903327, 17465.650686986442, 17475.56311092233, 7606.467547271638, 7714.382849372037, 7727.5749833758555, 7734.187910269453, 7742.535447873146, 5704.8859022819315, 6342.365763423621, 7114.110736157981, 7479.065116860393, 7490.1386340571535, 4927.605791536668, 5065.468125846806, 5066.36670416198, 5116.232565115188, 5133.332666753298, 1389.6317475868902, 1395.427874571421, 1397.210576024543, 1415.4267521653746, 1419.9503017394547, 905.2350763604743, 923.5243849417556, 935.1630290889616, 941.802221533472, 943.4622265308845, 7721.691132354643, 7793.766187014398, 7824.178461261599, 7899.289063984269, 7902.407319451064, 650.7884937395365, 677.4986509982676, 721.7257442172046, 729.5403895545772, 735.0554537419497, 4729.69256998294, 4750.192467280571, 4761.738104404221, 4933.28467372229, 5259.421463638997, 21339.253126140822, 22044.669329960063, 22248.332550023526, 22263.666045009337, 22266.55466890653, 21484.248051318442, 21539.2461263855, 21994.45013874634, 22105.889470552866, 22196.77803221947, 11459.08327333828, 11509.654710358702, 11705.414729263503, 11823.113266505046, 11828.763424731456, 8277.751667449986, 8388.161183881562, 8484.236418722345, 8607.18231767981, 8652.653893844175, 18488.0, 18924.43226703201, 19026.7145992813, 19415.3204637837, 19478.0, 19596.902015490403, 19681.40955771329, 19800.30698925588, 19860.0, 19892.104855281836, 11291.887081129084, 11479.4260286987, 11489.195756296978, 11490.310581365145, 11492.482838272465, 14249.216293103978, 14404.42382304696, 14489.347979340744, 14590.0, 14615.92692036533, 10655.922095191363, 10750.247482676137, 10823.945880270549, 10959.287646302964, 11149.609763658233, 10382.428966406618, 10509.632162874568, 10544.736381590521, 10562.471876405994, 10789.352638841694, 9281.814363712823, 9562.665306714232, 9562.760930976781, 9564.713058608253, 9585.952070239604, 7249.673764680497, 7396.297351751575, 7445.4415918805225, 7523.623818808928, 7581.658825352983, 7403.222661620668, 7412.740554080797, 7445.888311675221, 7500.812479688051, 7509.136449308399], "value": 6632.356316390967, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.407014897793, 525.5506541906667, 537.5323468582334, 538.8221886777362, 540.889117730865, 6314.968425157874, 6326.588771729835, 6357.55497115201, 6362.65005424702, 6392.680365981706, 6180.381961803829, 6253.656048917308, 6260.937390626093, 6326.272478664955, 6348.682565871711, 5230.783068412928, 5239.847233608619, 5260.843054347718, 5281.63028587999, 5297.761600727958, 4898.456986049401, 5067.366579177603, 5202.193659982709, 5272.209168624699, 5284.867878303035, 4981.825636102737, 4998.475160108191, 5000.874978125539, 5038.697678139305, 5060.7854115012315, 4852.951470485285, 4980.900381992376, 5002.949970500321, 5014.1225285575065, 5017.64876458648, 4517.0, 4529.09418116378, 4542.114287713897, 4546.249868771649, 4553.476350219701, 6032.577719559633, 6069.666168360783, 6109.808587325473, 6200.534959878028, 6266.561340706153, 5711.885762284731, 5728.424683212108, 5736.561961166488, 5778.739956701958, 5804.506616937565, 6614.206295244553, 6625.966870165618, 6645.700943457556, 6659.866802663968, 6666.666666666696, 4923.0, 4924.778384972685, 4929.408470983469, 4933.235348520985, 4952.678075925053, 6607.306232845578, 6691.159931019009, 6886.655667216669, 6889.827754306182, 7065.858682826366, 4986.950130498722, 4987.825426110068, 5000.774965126578, 5018.5985121190215, 5093.974530127326, 5110.415771110967, 5124.615653825978, 5129.615278854101, 5132.923006154911, 5199.818006369835, 5728.455796699391, 5737.77048918047, 5765.394633563499, 5765.88468230633, 5772.3938986406665, 6612.636305003271, 6637.701303441357, 6689.96305572637, 6693.631850248185, 6697.7655782047395, 1757.5957529768225, 1776.7956684981134, 1781.2429717370067, 1789.7762779652544, 1795.1921635264184, 1160.9593664221882, 1226.4113225651738, 1240.4356018011783, 1240.7332423528985, 1241.5654520917788, 5863.853403664943, 5899.46904778572, 5936.5066671997865, 5943.702814859326, 5974.462298393166, 6749.291324410964, 6764.627945462948, 6793.592384456949, 6834.555753875982, 6943.9931209974275, 5825.854353641193, 5828.59199856006, 5869.765209391662, 5938.435848594377, 5973.432523910308, 3531.256867720225, 3534.2578058607464, 3599.2981368632863, 3611.7652352596997, 3635.5455568053994, 6446.709898054599, 6540.607563546202, 6569.343065693488, 6580.506462015368, 6621.404073633396, 6426.132472116298, 6790.185177778698, 6856.108705868205, 6947.687354069079, 6985.6507174641065, 6514.013225966031, 6590.439812615981, 6591.934080659228, 6680.899786503303, 6742.292059333699, 6712.2616512184595, 6752.966235168793, 6797.388235058671, 6826.825526130373, 6865.519413641197, 6614.272430032789, 6655.833604159935, 6680.665966701743, 6685.966570167118, 6768.4585233182215, 6583.30875258091, 6633.170853643294, 6657.234418041987, 6680.331966803281, 6688.933110669026, 4927.852164435073, 4958.157113290821, 4968.950310496849, 4969.45336013031, 4991.825286114969, 6531.836704082436, 6659.567128136656, 6674.199096108304, 6748.527603067934, 6842.623655698984, 6462.192225971754, 6529.085927970183, 6531.706073226811, 6556.901646475402, 6638.734450622114, 6564.9671751640935, 6578.407943285128, 6595.571287866273, 6598.538102332791, 6643.867122657423, 6404.871902562016, 6520.2395353253405, 6522.445592124533, 6565.934340656532, 6604.603723776589, 6536.934630653633, 6555.475561955128, 6619.768308109193, 6640.83397915056, 6652.634105124071, 6288.0, 6328.873422531616, 6389.93610063912, 6419.2938776735455, 6475.255345635123], "value": 5114.9553046118235, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [876.2814492116465, 880.3617377401381, 881.3213825354474, 899.7615631857557, 901.9729408117755, 16773.916130419362, 17322.307107715707, 17369.392071277493, 17539.298428062877, 20946.16215351388, 20593.073311700973, 21445.0, 21654.675179872316, 21812.236571719994, 21859.890700546515, 957.3298690916351, 977.9853302200472, 982.6658935961772, 983.5082458770614, 986.0977205856633, 948.340903072365, 984.1290457944699, 985.5072463768116, 986.6842610364686, 988.5897352598663, 1037.6938803053117, 1038.678009816959, 1038.9220808439397, 1039.018127869164, 1049.0139269087072, 1028.4086650176105, 1032.8708911386077, 1033.1631378583334, 1033.705393962717, 1044.3838135500052, 763.8052296664371, 763.8090477380655, 764.1174443517746, 766.2988365645427, 770.7803276066351, 18921.62156756871, 19210.0, 19495.12271947766, 19668.606627867506, 19698.50753731154, 18444.35444759427, 18459.16933737985, 18719.0, 18822.905885470624, 19066.61866762657, 16226.594335141715, 16413.17934103302, 16526.256318465697, 16596.917015414965, 16599.170041497997, 3561.4301711726, 3642.0894776305922, 3643.635636436335, 3644.7995360255177, 3646.6353364663587, 134729.0, 136582.0, 138973.61026389708, 139778.30110849484, 139911.0, 16014.759778603331, 16300.42948496797, 16539.338426463048, 16629.6674066518, 16779.748303775454, 29826.0, 29965.70034299629, 30237.395252094833, 30533.389332213676, 30596.84701576478, 7404.740834070782, 7925.167857374892, 8306.169383061646, 8722.258608018263, 8997.325200609981, 4141.295979683461, 4267.637250833652, 4269.03946612016, 4269.637080848162, 4271.380649805761, 5182.844514664566, 5259.47405259471, 5289.259503669489, 5331.093714068617, 5349.438308977579, 1041.2815157541272, 1059.2479339668766, 1067.3595842494442, 1080.0387654987069, 1081.1350919264557, 653.4804830160034, 660.2572106380322, 668.1514476614672, 674.7098747538605, 683.5147045597582, 11453.885461145448, 11494.770104597861, 11745.0, 12200.511979520898, 12950.445946486481, 638.450932198309, 641.403494749887, 648.967551622417, 650.9153810004669, 655.9147310849559, 5548.445155484419, 5607.186957891165, 5632.690202038927, 5712.942870571241, 5872.031114866085, 105920.47039764751, 111130.0, 111361.44319278514, 111939.0, 112506.87493124964, 97639.51180244054, 98746.0, 99902.99999999854, 101967.4901625502, 102813.0, 85980.0, 86561.56719216364, 86891.0, 86895.0, 88948.5552572233, 10354.016368444985, 10513.264071514921, 10515.421651809223, 10607.469626518488, 10678.359298442118, 40328.39507407333, 41782.79108604437, 41849.79075104605, 42076.57923420727, 43579.0, 51537.7423112882, 52300.73849630728, 52886.20670689866, 53156.468435316696, 55102.72448637731, 15361.385544578092, 15610.141442220787, 15689.137097459748, 15736.05583664938, 15783.131927744083, 17102.914485427493, 17140.485785426456, 17166.31334746646, 17339.739903901704, 17405.912970435067, 15093.54719358421, 15154.16652084146, 15184.392624294904, 15190.0, 15290.311935962685, 16355.836441635907, 16364.754528682317, 16452.095134767704, 16503.33986640521, 16659.500214993568, 15171.16558589244, 15246.085234885943, 15290.923545382202, 15374.461893833663, 15498.5350439487, 11474.655760327203, 11675.474603642686, 11825.46785394642, 12039.277643341427, 12055.698607534881, 11976.28142311464, 12573.93713031429, 12735.98112151007, 13814.0, 14319.498817541336], "value": 8759.029937885758, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1485.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 107.0, 95.0, 108.0, 107.0, 109.0, 110.0, 108.0, 108.0, 108.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 145.0, 186.0, 120.0, 150.0, 148.0, 120.0, 164.0, 119.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 162.0, 162.0, 168.0, 166.0, 163.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 74.0, 175.0, 74.0, 74.0, 76.0, 87.0, 98.0, 76.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 131.0, 79.0, 80.0, 79.0, 127.0, 79.0, 80.0, 137.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 147.0, 147.0, 149.0, 147.0, 149.0, 148.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 52.0, 52.0, 52.0, 52.0, 53.0, 51.0, 53.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 80.0, 74.0, 75.0, 74.0, 73.0, 78.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 130.0, 124.0, 121.0, 116.0, 117.0, 117.0, 128.0, 126.0, 167.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 170.0, 182.0, 177.0, 172.0, 177.0, 173.0, 170.0, 171.0, 172.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 71.0, 65.0, 68.0, 63.0, 65.0, 64.0], "value": 65.7, "unit": "score"}]}]} 03:16:07 INFO - Return code: 0 03:16:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:16:07 INFO - # TBPL SUCCESS # 03:16:07 INFO - Running post-action listener: _package_coverage_data 03:16:07 INFO - Running post-action listener: _resource_record_post_action 03:16:07 INFO - [mozharness: 2017-08-30 10:16:07.565509Z] Finished run-tests step (success) 03:16:07 INFO - Running post-run listener: _resource_record_post_run 03:16:07 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 386633728; Read time: 428; Write time: 753408 03:16:07 INFO - TinderboxPrint: CPU usage
13.1% 03:16:07 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 428 03:16:07 INFO - TinderboxPrint: I/O write bytes / time
386,633,728 / 753,408 03:16:07 INFO - TinderboxPrint: CPU idle
8,246.2 (86.8%) 03:16:07 INFO - TinderboxPrint: CPU user
1,193.3 (12.6%) 03:16:07 INFO - TinderboxPrint: Swap in / out
0 / 0 03:16:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 88408064; Read time: 0; Write time: 123660 03:16:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:16:07 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 279986176; Read time: 428; Write time: 521328 03:16:08 INFO - Running post-run listener: _upload_blobber_files 03:16:08 INFO - Blob upload gear active. 03:16:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:16:08 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 03:16:08 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'] 03:16:08 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 03:16:08 INFO - (blobuploader) - INFO - Open directory for files ... 03:16:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:16:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:16:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:15 INFO - (blobuploader) - INFO - Done attempting. 03:16:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:16:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:17 INFO - (blobuploader) - INFO - Done attempting. 03:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:18 INFO - (blobuploader) - INFO - Done attempting. 03:16:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:16:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:18 INFO - (blobuploader) - INFO - Done attempting. 03:16:18 INFO - (blobuploader) - INFO - Iteration through files over. 03:16:18 INFO - Return code: 0 03:16:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:16:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:16:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8afa41010d29466e4d2ab4b10d9efcea8a739af48997a58b86f88af70393dc83c49a89b2821e088b11367183c4d871742560b484af5640cd1e687f195d21d565", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ddf01012ae90c575d7a1e603377f88acbd66148a35465415eeaf9a78eca79ee14110816dc594954f451ba191279c14ea9145130e8240eca0a53875bbfda4736", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9273907d707531c1b58feac9bc0e4bd4f9e8de11f328220433bdbdb46ac3e89f330ff6efae2d0956ae49be68fcb6b724bf8f2337ade043172c78842cade93f77", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cf0ed381fde53c38a712d1687b290c85278a3add176993d40b1a528c9588f179f1417d0ac45f376194182ea707087ab1598fe097bf2df911c164835fdf39e8a"} 03:16:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:16:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:16:18 INFO - Contents: 03:16:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8afa41010d29466e4d2ab4b10d9efcea8a739af48997a58b86f88af70393dc83c49a89b2821e088b11367183c4d871742560b484af5640cd1e687f195d21d565", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ddf01012ae90c575d7a1e603377f88acbd66148a35465415eeaf9a78eca79ee14110816dc594954f451ba191279c14ea9145130e8240eca0a53875bbfda4736", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9273907d707531c1b58feac9bc0e4bd4f9e8de11f328220433bdbdb46ac3e89f330ff6efae2d0956ae49be68fcb6b724bf8f2337ade043172c78842cade93f77", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cf0ed381fde53c38a712d1687b290c85278a3add176993d40b1a528c9588f179f1417d0ac45f376194182ea707087ab1598fe097bf2df911c164835fdf39e8a"} 03:16:18 INFO - Running post-run listener: copy_logs_to_upload_dir 03:16:18 INFO - Copying logs to upload dir... 03:16:18 INFO - mkdir: /builds/slave/test/build/upload/logs 03:16:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.439760 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-30 03:16:18.989058) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 03:16:18.996163) ========= 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=af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655 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/8afa41010d29466e4d2ab4b10d9efcea8a739af48997a58b86f88af70393dc83c49a89b2821e088b11367183c4d871742560b484af5640cd1e687f195d21d565", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ddf01012ae90c575d7a1e603377f88acbd66148a35465415eeaf9a78eca79ee14110816dc594954f451ba191279c14ea9145130e8240eca0a53875bbfda4736", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9273907d707531c1b58feac9bc0e4bd4f9e8de11f328220433bdbdb46ac3e89f330ff6efae2d0956ae49be68fcb6b724bf8f2337ade043172c78842cade93f77", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cf0ed381fde53c38a712d1687b290c85278a3add176993d40b1a528c9588f179f1417d0ac45f376194182ea707087ab1598fe097bf2df911c164835fdf39e8a"} build_url:https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8afa41010d29466e4d2ab4b10d9efcea8a739af48997a58b86f88af70393dc83c49a89b2821e088b11367183c4d871742560b484af5640cd1e687f195d21d565", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ddf01012ae90c575d7a1e603377f88acbd66148a35465415eeaf9a78eca79ee14110816dc594954f451ba191279c14ea9145130e8240eca0a53875bbfda4736", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9273907d707531c1b58feac9bc0e4bd4f9e8de11f328220433bdbdb46ac3e89f330ff6efae2d0956ae49be68fcb6b724bf8f2337ade043172c78842cade93f77", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cf0ed381fde53c38a712d1687b290c85278a3add176993d40b1a528c9588f179f1417d0ac45f376194182ea707087ab1598fe097bf2df911c164835fdf39e8a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 03:16:19.024627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 03:16:19.024955) ========= 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=af724c981e2a0f424dbabf99000001e7-1504085199.909754-1216867655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 03:16:19.108138) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 03:16:19.108458) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 03:16:19.108778) ========= ========= Total master_lag: 0.30 =========