builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-041 starttime: 1504724340.49 results: success (0) revision: 93dd2e456c0ecca00fb4d28744e88078a77deaf7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 11:59:00.490343) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 11:59:00.490719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 11:59:00.491003) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 11:59:00.507881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 11:59:00.508153) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-06 11:59:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 45.7M=0s 2017-09-06 11:59:00 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089623 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 11:59:00.614503) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 11:59:00.617838) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018258 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 11:59:00.667395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-06 11:59:00.670744) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 93dd2e456c0ecca00fb4d28744e88078a77deaf7 --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 93dd2e456c0ecca00fb4d28744e88078a77deaf7 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-06 11:59:00,713 truncating revision to first 12 chars 2017-09-06 11:59:00,713 Setting DEBUG logging. 2017-09-06 11:59:00,713 attempt 1/10 2017-09-06 11:59:00,713 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/93dd2e456c0e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-06 11:59:02,098 unpacking tar archive at: mozilla-central-93dd2e456c0e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.777703 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-06 11:59:02.467942) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 11:59:02.468256) ========= script_repo_revision: 93dd2e456c0ecca00fb4d28744e88078a77deaf7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 11:59:02.468682) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 11:59:02.468949) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 11:59:02.482159) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-06 11:59:02.482427) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:59:02 INFO - MultiFileLogger online at 20170906 11:59:02 in /builds/slave/test 11:59:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:59:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:59:02 INFO - {'append_to_log': False, 11:59:02 INFO - 'base_work_dir': '/builds/slave/test', 11:59:02 INFO - 'blob_upload_branch': 'Firefox', 11:59:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:59:02 INFO - 'branch': 'Firefox', 11:59:02 INFO - 'buildbot_json_path': 'buildprops.json', 11:59:02 INFO - 'code_coverage': False, 11:59:02 INFO - 'config_files': ('talos/linux_config.py',), 11:59:02 INFO - 'default_actions': ('clobber', 11:59:02 INFO - 'read-buildbot-config', 11:59:02 INFO - 'download-and-extract', 11:59:02 INFO - 'populate-webroot', 11:59:02 INFO - 'create-virtualenv', 11:59:02 INFO - 'install', 11:59:02 INFO - 'setup-mitmproxy', 11:59:02 INFO - 'run-tests'), 11:59:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:59:02 INFO - 'disable_ccov_upload': False, 11:59:02 INFO - 'disable_stylo': False, 11:59:02 INFO - 'download_minidump_stackwalk': True, 11:59:02 INFO - 'download_symbols': 'ondemand', 11:59:02 INFO - 'enable_stylo': False, 11:59:02 INFO - 'enable_webrender': False, 11:59:02 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:59:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:59:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:59:02 INFO - 'gecko_profile': False, 11:59:02 INFO - 'gecko_profile_interval': 0, 11:59:02 INFO - 'installer_path': 'installer.exe', 11:59:02 INFO - 'log_level': 'info', 11:59:02 INFO - 'log_name': 'talos', 11:59:02 INFO - 'log_to_console': True, 11:59:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:59:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:59:02 INFO - 'opt_config_files': (), 11:59:02 INFO - 'pip_index': False, 11:59:02 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:59:02 INFO - 'system_bits': '32', 11:59:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:59:02 INFO - 'title': 'talos-linux64-ix-041', 11:59:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:59:02 INFO - 'use_talos_json': True, 11:59:02 INFO - 'verify': 'False', 11:59:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:59:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:59:02 INFO - 'work_dir': 'build'} 11:59:02 INFO - [mozharness: 2017-09-06 18:59:02.655734Z] Running clobber step. 11:59:02 INFO - Running pre-action listener: _resource_record_pre_action 11:59:02 INFO - Running main action method: clobber 11:59:02 INFO - rmtree: /builds/slave/test/build 11:59:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:59:04 INFO - Running post-action listener: _resource_record_post_action 11:59:04 INFO - [mozharness: 2017-09-06 18:59:04.190729Z] Finished clobber step (success) 11:59:04 INFO - [mozharness: 2017-09-06 18:59:04.190826Z] Running read-buildbot-config step. 11:59:04 INFO - Running pre-action listener: _resource_record_pre_action 11:59:04 INFO - Running main action method: read_buildbot_config 11:59:04 INFO - Using buildbot properties: 11:59:04 INFO - { 11:59:04 INFO - "project": "", 11:59:04 INFO - "product": "firefox", 11:59:04 INFO - "who": "ffxbld@noreply.mozilla.org", 11:59:04 INFO - "installer_path": "public/build/target.tar.bz2", 11:59:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:59:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:59:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 11:59:04 INFO - "stage_platform": "linux64-pgo", 11:59:04 INFO - "basedir": "/builds/slave/test", 11:59:04 INFO - "buildnumber": 0, 11:59:04 INFO - "platform": "ubuntu64_hw", 11:59:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:59:04 INFO - "slavebuilddir": "test", 11:59:04 INFO - "taskId": "UBdb10tBRAiEF0PchQSxkg", 11:59:04 INFO - "branch": "mozilla-central", 11:59:04 INFO - "script_repo_revision": "production", 11:59:04 INFO - "revision": "93dd2e456c0ecca00fb4d28744e88078a77deaf7", 11:59:04 INFO - "slavename": "talos-linux64-ix-041", 11:59:04 INFO - "repo_path": "mozilla-central" 11:59:04 INFO - } 11:59:04 INFO - Finding installer, test and symbols from parent task. 11:59:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UBdb10tBRAiEF0PchQSxkg'}, attempt #1 11:59:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UBdb10tBRAiEF0PchQSxkg'}, attempt #1 11:59:05 INFO - Task dependencies: W4Q8jKTfQTCMMexkCM748g 11:59:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g'}, attempt #1 11:59:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.tar.bz2 11:59:05 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.test_packages.json 11:59:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.crashreporter-symbols.zip 11:59:05 INFO - Running post-action listener: _resource_record_post_action 11:59:05 INFO - [mozharness: 2017-09-06 18:59:05.682077Z] Finished read-buildbot-config step (success) 11:59:05 INFO - [mozharness: 2017-09-06 18:59:05.682294Z] Running download-and-extract step. 11:59:05 INFO - Running pre-action listener: _resource_record_pre_action 11:59:05 INFO - Running main action method: download_and_extract 11:59:05 INFO - mkdir: /builds/slave/test/build/tests 11:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:05 INFO - trying https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.test_packages.json 11:59:05 INFO - Downloading https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:59:06 INFO - Downloaded 989 bytes. 11:59:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:59:06 INFO - Using the following test package requirements: 11:59:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:59:06 INFO - u'common': [u'target.common.tests.zip'], 11:59:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:59:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:59:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:59:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:59:06 INFO - u'mozbase': [u'target.common.tests.zip'], 11:59:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:59:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:59:06 INFO - u'web-platform': [u'target.common.tests.zip', 11:59:06 INFO - u'target.web-platform.tests.tar.gz'], 11:59:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:59:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:59:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.common.tests.zip 11:59:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:59:06 INFO - Fetch https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.common.tests.zip into memory 11:59:07 INFO - Content-Length response header: 55686998 11:59:07 INFO - Bytes received: 55686998 11:59:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:59:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.common.tests.zip 11:59:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:59:18 INFO - Fetch https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.common.tests.zip into memory 11:59:19 INFO - Content-Length response header: 55686998 11:59:19 INFO - Bytes received: 55686998 11:59:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.talos.tests.zip 11:59:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:59:31 INFO - Fetch https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.talos.tests.zip into memory 11:59:32 INFO - Content-Length response header: 14496665 11:59:32 INFO - Bytes received: 14496665 11:59: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')]} 11:59:32 INFO - trying https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.tar.bz2 11:59:32 INFO - Downloading https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:59:33 INFO - Downloaded 63613473 bytes. 11:59:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.tar.bz2 11:59:33 INFO - mkdir: /builds/slave/test/properties 11:59:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:59:33 INFO - Writing to file /builds/slave/test/properties/build_url 11:59:33 INFO - Contents: 11:59:33 INFO - build_url:https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.tar.bz2 11:59:33 INFO - Running post-action listener: _resource_record_post_action 11:59:33 INFO - Running post-action listener: find_tests_for_verification 11:59:33 INFO - Running post-action listener: set_extra_try_arguments 11:59:33 INFO - [mozharness: 2017-09-06 18:59:33.697432Z] Finished download-and-extract step (success) 11:59:33 INFO - [mozharness: 2017-09-06 18:59:33.697529Z] Running populate-webroot step. 11:59:33 INFO - Running pre-action listener: _resource_record_pre_action 11:59:33 INFO - Running main action method: populate_webroot 11:59:33 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:59:33 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:59:33 INFO - 'tests': ['tresize', 11:59:33 INFO - 'tcanvasmark']}, 11:59:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:59:33 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:59:33 INFO - 'tests': ['dromaeo_css', 11:59:33 INFO - 'kraken']}, 11:59:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:59:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:59:33 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:59:33 INFO - 'talos_options': ['--disable-stylo'], 11:59:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:59:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:59:33 INFO - 'tests': ['damp', 'tps']}, 11:59:33 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:59:33 INFO - 'talos_options': ['--disable-stylo'], 11:59:33 INFO - 'tests': ['damp', 'tps']}, 11:59:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:59:33 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:59:33 INFO - 'tests': ['dromaeo_dom']}, 11:59:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:59:33 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:59:33 INFO - 'tests': ['basic_compositor_video', 11:59:33 INFO - 'glvideo']}, 11:59:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:59:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:59:33 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:59:33 INFO - 'talos_options': ['--disable-stylo'], 11:59:33 INFO - 'tests': ['ts_paint_webext', 11:59:33 INFO - 'tp5o_webext']}, 11:59:33 INFO - 'other-e10s': {'tests': ['a11yr', 11:59:33 INFO - 'ts_paint', 11:59:33 INFO - 'tpaint', 11:59:33 INFO - 'sessionrestore', 11:59:33 INFO - 'sessionrestore_many_windows', 11:59:33 INFO - 'sessionrestore_no_auto_restore', 11:59:33 INFO - 'tabpaint']}, 11:59:33 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:59:33 INFO - 'tests': ['a11yr', 11:59:33 INFO - 'ts_paint', 11:59:33 INFO - 'tpaint', 11:59:33 INFO - 'sessionrestore', 11:59:33 INFO - 'sessionrestore_many_windows', 11:59:33 INFO - 'sessionrestore_no_auto_restore', 11:59:33 INFO - 'tabpaint']}, 11:59:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:59:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:59:33 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:59:33 INFO - 'tests': ['bloom_basic_singleton']}, 11:59:33 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:59:33 INFO - 'tests': ['bloom_basic']}, 11:59:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:59:33 INFO - 'tsvgr_opacity', 11:59:33 INFO - 'tart', 11:59:33 INFO - 'tscrollx', 11:59:33 INFO - 'tsvg_static']}, 11:59:33 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:59:33 INFO - 'tests': ['tsvgx', 11:59:33 INFO - 'tsvgr_opacity', 11:59:33 INFO - 'tart', 11:59:33 INFO - 'tscrollx', 11:59:33 INFO - 'tsvg_static']}, 11:59:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:59:33 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:59:33 INFO - 'talos_options': ['--disable-stylo'], 11:59:33 INFO - 'tests': ['tp5o']}, 11:59:33 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:59:33 INFO - 'talos_options': ['--mitmproxy', 11:59:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:59:33 INFO - '--firstNonBlankPaint'], 11:59:33 INFO - 'tests': ['tp6_google', 11:59:33 INFO - 'tp6_youtube', 11:59:33 INFO - 'tp6_amazon', 11:59:33 INFO - 'tp6_facebook']}, 11:59:33 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:59:33 INFO - 'talos_options': ['--disable-stylo', 11:59:33 INFO - '--mitmproxy', 11:59:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:59:33 INFO - '--firstNonBlankPaint'], 11:59:33 INFO - 'tests': ['tp6_google', 11:59:33 INFO - 'tp6_youtube', 11:59:33 INFO - 'tp6_amazon', 11:59:33 INFO - 'tp6_facebook']}, 11:59:33 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:59:33 INFO - 'talos_options': ['--stylo-threads=1', 11:59:33 INFO - '--mitmproxy', 11:59:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:59:33 INFO - '--firstNonBlankPaint'], 11:59:33 INFO - 'tests': ['tp6_google', 11:59:33 INFO - 'tp6_youtube', 11:59:33 INFO - 'tp6_amazon', 11:59:33 INFO - 'tp6_facebook']}, 11:59:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:59:33 INFO - 'talos_options': ['--xperf_path', 11:59:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:59:33 INFO - 'tests': ['tp5n']}, 11:59:33 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:59:33 INFO - 'talos_options': ['--disable-stylo', 11:59:33 INFO - '--xperf_path', 11:59:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:59:33 INFO - 'tests': ['tp5n']}}} 11:59:33 INFO - Running post-action listener: _resource_record_post_action 11:59:33 INFO - [mozharness: 2017-09-06 18:59:33.712534Z] Finished populate-webroot step (success) 11:59:33 INFO - [mozharness: 2017-09-06 18:59:33.712623Z] Running create-virtualenv step. 11:59:33 INFO - Running pre-action listener: _resource_record_pre_action 11:59:33 INFO - Running main action method: create_virtualenv 11:59:33 INFO - Creating virtualenv /builds/slave/test/build/venv 11:59:33 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:59:33 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:59:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:59:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:59:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:59:34 INFO - Installing distribute.............................................................................................................................................................................................done. 11:59:34 INFO - Installing pip...............done. 11:59:34 INFO - Return code: 0 11:59:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:59:34 INFO - Reading from file tmpfile_stdout 11:59:34 INFO - Output received: 11:59:34 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:59:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:34 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 0x10b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423090>, '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 0x1423d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141df90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', '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 11:59:34 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 11:59:34 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 11:59:34 INFO - Using env: {'DISPLAY': ':0', 11:59:34 INFO - 'HOME': '/home/cltbld', 11:59:34 INFO - 'LANG': 'en_US.UTF-8', 11:59:34 INFO - 'LANGUAGE': 'en_US:en', 11:59:34 INFO - 'LOGNAME': 'cltbld', 11:59:34 INFO - 'MAIL': '/var/mail/cltbld', 11:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:34 INFO - 'MOZ_NO_REMOTE': '1', 11:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:34 INFO - 'NO_EM_RESTART': '1', 11:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:34 INFO - 'PWD': '/builds/slave/test', 11:59:34 INFO - 'SHELL': '/bin/bash', 11:59:34 INFO - 'SHLVL': '1', 11:59:34 INFO - 'TERM': 'linux', 11:59:34 INFO - 'TMOUT': '86400', 11:59:34 INFO - 'USER': 'cltbld', 11:59:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', 11:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:34 INFO - '_': '/tools/buildbot/bin/python'} 11:59:36 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:59:36 INFO - Downloading/unpacking pip>=1.5 11:59:36 INFO - Running setup.py egg_info for package pip 11:59:36 INFO - warning: no files found matching 'pip/cacert.pem' 11:59:36 INFO - warning: no files found matching '*.html' under directory 'docs' 11:59:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:59:36 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:59:36 INFO - Installing collected packages: pip 11:59:36 INFO - Found existing installation: pip 1.1 11:59:36 INFO - Uninstalling pip: 11:59:36 INFO - Successfully uninstalled pip 11:59:36 INFO - Running setup.py install for pip 11:59:36 INFO - warning: no files found matching 'pip/cacert.pem' 11:59:36 INFO - warning: no files found matching '*.html' under directory 'docs' 11:59:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:59:36 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:59:36 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:59:36 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:59:36 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:59:36 INFO - Successfully installed pip 11:59:36 INFO - Cleaning up... 11:59:36 INFO - Return code: 0 11:59:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:36 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 0x10b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423090>, '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 0x1423d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141df90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', '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 11:59:36 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 11:59:36 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 11:59:36 INFO - Using env: {'DISPLAY': ':0', 11:59:36 INFO - 'HOME': '/home/cltbld', 11:59:36 INFO - 'LANG': 'en_US.UTF-8', 11:59:36 INFO - 'LANGUAGE': 'en_US:en', 11:59:36 INFO - 'LOGNAME': 'cltbld', 11:59:36 INFO - 'MAIL': '/var/mail/cltbld', 11:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:36 INFO - 'MOZ_NO_REMOTE': '1', 11:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:36 INFO - 'NO_EM_RESTART': '1', 11:59:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:36 INFO - 'PWD': '/builds/slave/test', 11:59:36 INFO - 'SHELL': '/bin/bash', 11:59:36 INFO - 'SHLVL': '1', 11:59:36 INFO - 'TERM': 'linux', 11:59:36 INFO - 'TMOUT': '86400', 11:59:36 INFO - 'USER': 'cltbld', 11:59:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', 11:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:36 INFO - '_': '/tools/buildbot/bin/python'} 11:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:36 INFO - Downloading/unpacking psutil>=3.1.1 11:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:59:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:59:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:59:37 INFO - Installing collected packages: psutil 11:59:37 INFO - Running setup.py install for psutil 11:59:37 INFO - building 'psutil._psutil_linux' extension 11:59:37 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 11:59:37 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 11:59:37 INFO - building 'psutil._psutil_posix' extension 11:59:37 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 11:59:37 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 11:59:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:59:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:59:38 INFO - Successfully installed psutil 11:59:38 INFO - Cleaning up... 11:59:38 INFO - Return code: 0 11:59:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:59:38 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')]} 11:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:38 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')]} 11:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:38 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 0x10b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423090>, '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 0x1423d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141df90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', '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 11:59:38 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 11:59:38 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 11:59:38 INFO - Using env: {'DISPLAY': ':0', 11:59:38 INFO - 'HOME': '/home/cltbld', 11:59:38 INFO - 'LANG': 'en_US.UTF-8', 11:59:38 INFO - 'LANGUAGE': 'en_US:en', 11:59:38 INFO - 'LOGNAME': 'cltbld', 11:59:38 INFO - 'MAIL': '/var/mail/cltbld', 11:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:38 INFO - 'MOZ_NO_REMOTE': '1', 11:59:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:38 INFO - 'NO_EM_RESTART': '1', 11:59:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:38 INFO - 'PWD': '/builds/slave/test', 11:59:38 INFO - 'SHELL': '/bin/bash', 11:59:38 INFO - 'SHLVL': '1', 11:59:38 INFO - 'TERM': 'linux', 11:59:38 INFO - 'TMOUT': '86400', 11:59:38 INFO - 'USER': 'cltbld', 11:59:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', 11:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:38 INFO - '_': '/tools/buildbot/bin/python'} 11:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:59:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:59:39 INFO - Installing collected packages: mozsystemmonitor 11:59:39 INFO - Running setup.py install for mozsystemmonitor 11:59:39 INFO - Successfully installed mozsystemmonitor 11:59:39 INFO - Cleaning up... 11:59:39 INFO - Return code: 0 11:59:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:39 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 0x10b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423090>, '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 0x1423d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141df90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', '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 11:59:39 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 11:59:39 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 11:59:39 INFO - Using env: {'DISPLAY': ':0', 11:59:39 INFO - 'HOME': '/home/cltbld', 11:59:39 INFO - 'LANG': 'en_US.UTF-8', 11:59:39 INFO - 'LANGUAGE': 'en_US:en', 11:59:39 INFO - 'LOGNAME': 'cltbld', 11:59:39 INFO - 'MAIL': '/var/mail/cltbld', 11:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:39 INFO - 'MOZ_NO_REMOTE': '1', 11:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:39 INFO - 'NO_EM_RESTART': '1', 11:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:39 INFO - 'PWD': '/builds/slave/test', 11:59:39 INFO - 'SHELL': '/bin/bash', 11:59:39 INFO - 'SHLVL': '1', 11:59:39 INFO - 'TERM': 'linux', 11:59:39 INFO - 'TMOUT': '86400', 11:59:39 INFO - 'USER': 'cltbld', 11:59:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', 11:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:39 INFO - '_': '/tools/buildbot/bin/python'} 11:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:39 INFO - Downloading/unpacking jsonschema==2.5.1 11:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:59:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:41 INFO - Downloading functools32-3.2.3-2.tar.gz 11:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:59:41 INFO - warning: no files found matching '*.txt' 11:59:41 INFO - no previously-included directories found matching 'build' 11:59:41 INFO - no previously-included directories found matching 'dist' 11:59:41 INFO - no previously-included directories found matching '.git*' 11:59:41 INFO - Installing collected packages: jsonschema, functools32 11:59:41 INFO - Running setup.py install for functools32 11:59:41 INFO - warning: no files found matching '*.txt' 11:59:41 INFO - no previously-included directories found matching 'build' 11:59:41 INFO - no previously-included directories found matching 'dist' 11:59:41 INFO - no previously-included directories found matching '.git*' 11:59:41 INFO - Successfully installed jsonschema functools32 11:59:41 INFO - Cleaning up... 11:59:41 INFO - Return code: 0 11:59:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423090>, '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 0x1423d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141df90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', '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 11:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:59:41 INFO - Using env: {'DISPLAY': ':0', 11:59:41 INFO - 'HOME': '/home/cltbld', 11:59:41 INFO - 'LANG': 'en_US.UTF-8', 11:59:41 INFO - 'LANGUAGE': 'en_US:en', 11:59:41 INFO - 'LOGNAME': 'cltbld', 11:59:41 INFO - 'MAIL': '/var/mail/cltbld', 11:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:41 INFO - 'MOZ_NO_REMOTE': '1', 11:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:41 INFO - 'NO_EM_RESTART': '1', 11:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:41 INFO - 'PWD': '/builds/slave/test', 11:59:41 INFO - 'SHELL': '/bin/bash', 11:59:41 INFO - 'SHLVL': '1', 11:59:41 INFO - 'TERM': 'linux', 11:59:41 INFO - 'TMOUT': '86400', 11:59:41 INFO - 'USER': 'cltbld', 11:59:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', 11:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:41 INFO - '_': '/tools/buildbot/bin/python'} 11:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:59:41 INFO - Cleaning up... 11:59:41 INFO - Return code: 0 11:59:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423090>, '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 0x1423d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141df90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', '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 11:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:59:41 INFO - Using env: {'DISPLAY': ':0', 11:59:41 INFO - 'HOME': '/home/cltbld', 11:59:41 INFO - 'LANG': 'en_US.UTF-8', 11:59:41 INFO - 'LANGUAGE': 'en_US:en', 11:59:41 INFO - 'LOGNAME': 'cltbld', 11:59:41 INFO - 'MAIL': '/var/mail/cltbld', 11:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:41 INFO - 'MOZ_NO_REMOTE': '1', 11:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:41 INFO - 'NO_EM_RESTART': '1', 11:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:41 INFO - 'PWD': '/builds/slave/test', 11:59:41 INFO - 'SHELL': '/bin/bash', 11:59:41 INFO - 'SHLVL': '1', 11:59:41 INFO - 'TERM': 'linux', 11:59:41 INFO - 'TMOUT': '86400', 11:59:41 INFO - 'USER': 'cltbld', 11:59:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', 11:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:41 INFO - '_': '/tools/buildbot/bin/python'} 11:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:41 INFO - Downloading/unpacking blobuploader==1.2.4 11:59:41 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 11:59:41 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 11:59:41 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 11:59:41 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 11:59:42 INFO - Downloading blobuploader-1.2.4.tar.gz 11:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:59:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:59:42 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 11:59:42 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 11:59:42 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 11:59:42 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 11:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:59:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:59:43 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 11:59:43 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 11:59:43 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 11:59:43 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 11:59:43 INFO - Downloading docopt-0.6.1.tar.gz 11:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:59:43 INFO - Installing collected packages: blobuploader, requests, docopt 11:59:43 INFO - Running setup.py install for blobuploader 11:59:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:59:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:59:43 INFO - Running setup.py install for requests 11:59:43 INFO - Running setup.py install for docopt 11:59:44 INFO - Successfully installed blobuploader requests docopt 11:59:44 INFO - Cleaning up... 11:59:44 INFO - Return code: 0 11:59:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:44 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 0x10b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423090>, '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 0x1423d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141df90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', '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 11:59:44 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 11:59:44 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 11:59:44 INFO - Using env: {'DISPLAY': ':0', 11:59:44 INFO - 'HOME': '/home/cltbld', 11:59:44 INFO - 'LANG': 'en_US.UTF-8', 11:59:44 INFO - 'LANGUAGE': 'en_US:en', 11:59:44 INFO - 'LOGNAME': 'cltbld', 11:59:44 INFO - 'MAIL': '/var/mail/cltbld', 11:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:44 INFO - 'MOZ_NO_REMOTE': '1', 11:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:44 INFO - 'NO_EM_RESTART': '1', 11:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:44 INFO - 'PWD': '/builds/slave/test', 11:59:44 INFO - 'SHELL': '/bin/bash', 11:59:44 INFO - 'SHLVL': '1', 11:59:44 INFO - 'TERM': 'linux', 11:59:44 INFO - 'TMOUT': '86400', 11:59:44 INFO - 'USER': 'cltbld', 11:59:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', 11:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:44 INFO - '_': '/tools/buildbot/bin/python'} 11:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:44 INFO - Running setup.py (path:/tmp/pip-Juw0Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:44 INFO - Running setup.py (path:/tmp/pip-e6HJ3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:44 INFO - Running setup.py (path:/tmp/pip-noMagT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:44 INFO - Running setup.py (path:/tmp/pip-roEP9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:44 INFO - Running setup.py (path:/tmp/pip-q4cLnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:44 INFO - Running setup.py (path:/tmp/pip-JnDtVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:44 INFO - Running setup.py (path:/tmp/pip-N9syYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:44 INFO - Running setup.py (path:/tmp/pip-qR_8Wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:44 INFO - Running setup.py (path:/tmp/pip-BYRDtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:44 INFO - Running setup.py (path:/tmp/pip-sl9qCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:45 INFO - Running setup.py (path:/tmp/pip-14sKCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:45 INFO - Running setup.py (path:/tmp/pip-lb7f9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:45 INFO - Running setup.py (path:/tmp/pip-ZtOoiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:45 INFO - Running setup.py (path:/tmp/pip-LBi4PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:45 INFO - Running setup.py (path:/tmp/pip-PiyuEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:45 INFO - Running setup.py (path:/tmp/pip-ZBLgqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:45 INFO - Running setup.py (path:/tmp/pip-DC0Fpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:59:45 INFO - Running setup.py install for manifestparser 11:59:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:59:45 INFO - Running setup.py install for mozcrash 11:59:45 INFO - Running setup.py install for mozdebug 11:59:45 INFO - Running setup.py install for mozdevice 11:59:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:59:45 INFO - Running setup.py install for mozfile 11:59:46 INFO - Running setup.py install for mozhttpd 11:59:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Running setup.py install for mozinfo 11:59:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Running setup.py install for mozInstall 11:59:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Running setup.py install for mozleak 11:59:46 INFO - Running setup.py install for mozlog 11:59:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Running setup.py install for moznetwork 11:59:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Running setup.py install for mozprocess 11:59:46 INFO - Running setup.py install for mozprofile 11:59:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Running setup.py install for mozrunner 11:59:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:59:47 INFO - Running setup.py install for mozscreenshot 11:59:47 INFO - Running setup.py install for moztest 11:59:47 INFO - Running setup.py install for mozversion 11:59:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:59:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:59:47 INFO - Cleaning up... 11:59:47 INFO - Return code: 0 11:59:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:47 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')]} 11:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:47 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')]} 11:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:47 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 0x10b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423090>, '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 0x1423d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141df90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', '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 11:59:47 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 11:59:47 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 11:59:47 INFO - Using env: {'DISPLAY': ':0', 11:59:47 INFO - 'HOME': '/home/cltbld', 11:59:47 INFO - 'LANG': 'en_US.UTF-8', 11:59:47 INFO - 'LANGUAGE': 'en_US:en', 11:59:47 INFO - 'LOGNAME': 'cltbld', 11:59:47 INFO - 'MAIL': '/var/mail/cltbld', 11:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:47 INFO - 'MOZ_NO_REMOTE': '1', 11:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:47 INFO - 'NO_EM_RESTART': '1', 11:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:47 INFO - 'PWD': '/builds/slave/test', 11:59:47 INFO - 'SHELL': '/bin/bash', 11:59:47 INFO - 'SHLVL': '1', 11:59:47 INFO - 'TERM': 'linux', 11:59:47 INFO - 'TMOUT': '86400', 11:59:47 INFO - 'USER': 'cltbld', 11:59:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', 11:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:47 INFO - '_': '/tools/buildbot/bin/python'} 11:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:47 INFO - Running setup.py (path:/tmp/pip-TKUh6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:47 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)) 11:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:47 INFO - Running setup.py (path:/tmp/pip-8aPIu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:47 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)) 11:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:47 INFO - Running setup.py (path:/tmp/pip-HwM9RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:47 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)) 11:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:47 INFO - Running setup.py (path:/tmp/pip-VAI3wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:47 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)) 11:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:47 INFO - Running setup.py (path:/tmp/pip-qjvVBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:47 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)) 11:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:47 INFO - Running setup.py (path:/tmp/pip-ewu2Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:47 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)) 11:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:47 INFO - Running setup.py (path:/tmp/pip-bQHtQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:48 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)) 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:48 INFO - Running setup.py (path:/tmp/pip-ybHCqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:48 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)) 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:48 INFO - Running setup.py (path:/tmp/pip-jxFPTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:48 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)) 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:48 INFO - Running setup.py (path:/tmp/pip-SRv0S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:48 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)) 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:48 INFO - Running setup.py (path:/tmp/pip-sXLZ0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:48 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)) 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:48 INFO - Running setup.py (path:/tmp/pip-pLvIYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:48 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)) 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:48 INFO - Running setup.py (path:/tmp/pip-ECUiAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:48 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)) 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:48 INFO - Running setup.py (path:/tmp/pip-XYWcqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:48 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)) 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:48 INFO - Running setup.py (path:/tmp/pip-EIPb1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:48 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)) 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:48 INFO - Running setup.py (path:/tmp/pip-FnzxSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:48 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)) 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:48 INFO - Running setup.py (path:/tmp/pip-nGFzlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:48 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)) 11:59:48 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)) 11:59:48 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)) 11:59:48 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)) 11:59:48 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)) 11:59:48 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)) 11:59:48 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)) 11:59:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:59:48 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 11:59:48 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 11:59:48 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 11:59:48 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 11:59:49 INFO - Downloading blessings-1.6.tar.gz 11:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:59:49 INFO - Installing collected packages: blessings 11:59:49 INFO - Running setup.py install for blessings 11:59:50 INFO - Successfully installed blessings 11:59:50 INFO - Cleaning up... 11:59:50 INFO - Return code: 0 11:59:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:59:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:50 INFO - Reading from file tmpfile_stdout 11:59:50 INFO - Current package versions: 11:59:50 INFO - argparse == 1.2.1 11:59:50 INFO - blessings == 1.6 11:59:50 INFO - blobuploader == 1.2.4 11:59:50 INFO - docopt == 0.6.1 11:59:50 INFO - functools32 == 3.2.3-2 11:59:50 INFO - jsonschema == 2.5.1 11:59:50 INFO - manifestparser == 1.1 11:59:50 INFO - mozInstall == 1.13 11:59:50 INFO - mozcrash == 1.0 11:59:50 INFO - mozdebug == 0.1 11:59:50 INFO - mozdevice == 0.51 11:59:50 INFO - mozfile == 1.2 11:59:50 INFO - mozhttpd == 0.7 11:59:50 INFO - mozinfo == 0.10 11:59:50 INFO - mozleak == 0.1 11:59:50 INFO - mozlog == 3.5 11:59:50 INFO - moznetwork == 0.27 11:59:50 INFO - mozprocess == 0.25 11:59:50 INFO - mozprofile == 0.28 11:59:50 INFO - mozrunner == 6.13 11:59:50 INFO - mozscreenshot == 0.1 11:59:50 INFO - mozsystemmonitor == 0.3 11:59:50 INFO - moztest == 0.8 11:59:50 INFO - mozversion == 1.4 11:59:50 INFO - psutil == 3.1.1 11:59:50 INFO - requests == 1.2.3 11:59:50 INFO - wsgiref == 0.1.2 11:59:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:50 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 0x10b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423090>, '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 0x1423d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141df90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', '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 11:59:50 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 11:59:50 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 11:59:50 INFO - Using env: {'DISPLAY': ':0', 11:59:50 INFO - 'HOME': '/home/cltbld', 11:59:50 INFO - 'LANG': 'en_US.UTF-8', 11:59:50 INFO - 'LANGUAGE': 'en_US:en', 11:59:50 INFO - 'LOGNAME': 'cltbld', 11:59:50 INFO - 'MAIL': '/var/mail/cltbld', 11:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:50 INFO - 'MOZ_NO_REMOTE': '1', 11:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:50 INFO - 'NO_EM_RESTART': '1', 11:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:50 INFO - 'PWD': '/builds/slave/test', 11:59:50 INFO - 'SHELL': '/bin/bash', 11:59:50 INFO - 'SHLVL': '1', 11:59:50 INFO - 'TERM': 'linux', 11:59:50 INFO - 'TMOUT': '86400', 11:59:50 INFO - 'USER': 'cltbld', 11:59:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', 11:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:50 INFO - '_': '/tools/buildbot/bin/python'} 11:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:50 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)) 11:59:50 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)) 11:59:50 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)) 11:59:50 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)) 11:59:50 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)) 11:59:50 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)) 11:59:50 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)) 11:59:50 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)) 11:59:50 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)) 11:59:50 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:59:51 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)) 11:59:51 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)) 11:59:51 INFO - Installing collected packages: simplejson 11:59:51 INFO - Running setup.py install for simplejson 11:59:51 INFO - building 'simplejson._speedups' extension 11:59:51 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 11:59:52 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 11:59:52 INFO - Successfully installed simplejson 11:59:52 INFO - Cleaning up... 11:59:52 INFO - Return code: 0 11:59:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423090>, '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 0x1423d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141df90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', '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 11:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:59:52 INFO - Using env: {'DISPLAY': ':0', 11:59:52 INFO - 'HOME': '/home/cltbld', 11:59:52 INFO - 'LANG': 'en_US.UTF-8', 11:59:52 INFO - 'LANGUAGE': 'en_US:en', 11:59:52 INFO - 'LOGNAME': 'cltbld', 11:59:52 INFO - 'MAIL': '/var/mail/cltbld', 11:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:52 INFO - 'MOZ_NO_REMOTE': '1', 11:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:52 INFO - 'NO_EM_RESTART': '1', 11:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:52 INFO - 'PWD': '/builds/slave/test', 11:59:52 INFO - 'SHELL': '/bin/bash', 11:59:52 INFO - 'SHLVL': '1', 11:59:52 INFO - 'TERM': 'linux', 11:59:52 INFO - 'TMOUT': '86400', 11:59:52 INFO - 'USER': 'cltbld', 11:59:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', 11:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:52 INFO - '_': '/tools/buildbot/bin/python'} 11:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:59:52 INFO - Cleaning up... 11:59:53 INFO - Return code: 0 11:59:53 INFO - Running post-action listener: _resource_record_post_action 11:59:53 INFO - Running post-action listener: _start_resource_monitoring 11:59:53 INFO - Starting resource monitoring. 11:59:53 INFO - [mozharness: 2017-09-06 18:59:53.039325Z] Finished create-virtualenv step (success) 11:59:53 INFO - [mozharness: 2017-09-06 18:59:53.039835Z] Running install step. 11:59:53 INFO - Running pre-action listener: _resource_record_pre_action 11:59:53 INFO - Running main action method: install 11:59:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:53 INFO - Reading from file tmpfile_stdout 11:59:53 INFO - Detecting whether we're running mozinstall >=1.0... 11:59:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:59:53 INFO - Reading from file tmpfile_stdout 11:59:53 INFO - Output received: 11:59:53 INFO - Usage: mozinstall [options] installer 11:59:53 INFO - Options: 11:59:53 INFO - -h, --help show this help message and exit 11:59:53 INFO - -d DEST, --destination=DEST 11:59:53 INFO - Directory to install application into. [default: 11:59:53 INFO - "/builds/slave/test"] 11:59:53 INFO - --app=APP Application being installed. [default: firefox] 11:59:53 INFO - mkdir: /builds/slave/test/build/application 11:59:53 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'] 11:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:00:10 INFO - Reading from file tmpfile_stdout 12:00:10 INFO - Output received: 12:00:10 INFO - /builds/slave/test/build/application/firefox/firefox 12:00:10 INFO - Running post-action listener: _resource_record_post_action 12:00:10 INFO - [mozharness: 2017-09-06 19:00:10.199904Z] Finished install step (success) 12:00:10 INFO - [mozharness: 2017-09-06 19:00:10.200048Z] Running setup-mitmproxy step. 12:00:10 INFO - Running pre-action listener: _resource_record_pre_action 12:00:10 INFO - Running main action method: setup_mitmproxy 12:00:10 INFO - Skipping: mitmproxy is not required 12:00:10 INFO - Running post-action listener: _resource_record_post_action 12:00:10 INFO - [mozharness: 2017-09-06 19:00:10.201152Z] Finished setup-mitmproxy step (success) 12:00:10 INFO - [mozharness: 2017-09-06 19:00:10.201369Z] Running run-tests step. 12:00:10 INFO - Running pre-action listener: _resource_record_pre_action 12:00:10 INFO - Running pre-action listener: _set_gcov_prefix 12:00:10 INFO - Running main action method: run_tests 12:00:10 WARNING - Try message not found. 12:00:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:00:10 INFO - Python 2.7.3 12:00:10 INFO - Return code: 0 12:00:10 INFO - grabbing minidump binary from tooltool 12:00:10 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')]} 12:00:10 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 0x1423090>, '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 0x1423d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:00:10 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 12:00:10 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 12:00:10 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 12:00:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:00:10 INFO - Return code: 0 12:00:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:00:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:00:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:00:10 INFO - ENV: RUST_BACKTRACE is now full 12:00:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:00:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:00:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 12:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 12:00:10 INFO - Using env: {'DISPLAY': ':0', 12:00:10 INFO - 'HOME': '/home/cltbld', 12:00:10 INFO - 'LANG': 'en_US.UTF-8', 12:00:10 INFO - 'LANGUAGE': 'en_US:en', 12:00:10 INFO - 'LOGNAME': 'cltbld', 12:00:10 INFO - 'MAIL': '/var/mail/cltbld', 12:00:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:00:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:10 INFO - 'MOZ_NO_REMOTE': '1', 12:00:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:10 INFO - 'NO_EM_RESTART': '1', 12:00:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:10 INFO - 'PWD': '/builds/slave/test', 12:00:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:00:10 INFO - 'RUST_BACKTRACE': 'full', 12:00:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:00:10 INFO - 'SHELL': '/bin/bash', 12:00:10 INFO - 'SHLVL': '1', 12:00:10 INFO - 'TERM': 'linux', 12:00:10 INFO - 'TMOUT': '86400', 12:00:10 INFO - 'USER': 'cltbld', 12:00:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', 12:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:10 INFO - '_': '/tools/buildbot/bin/python'} 12:00:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 12:00:10 INFO - mozversion application_buildid: 20170906173802 12:00:10 INFO - mozversion application_changeset: 93dd2e456c0ecca00fb4d28744e88078a77deaf7 12:00:10 INFO - mozversion application_display_name: Nightly 12:00:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:00:10 INFO - mozversion application_name: Firefox 12:00:10 INFO - mozversion application_remotingname: firefox 12:00:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:00:10 INFO - mozversion application_vendor: Mozilla 12:00:10 INFO - mozversion application_version: 57.0a1 12:00:10 INFO - mozversion platform_buildid: 20170906173802 12:00:10 INFO - mozversion platform_changeset: 93dd2e456c0ecca00fb4d28744e88078a77deaf7 12:00:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:00:10 INFO - mozversion platform_version: 57.0a1 12:00:10 INFO - using testdate: 1504724410 12:00:10 INFO - actual date: 1504724410 12:00:10 INFO - starting webserver on 'localhost:35104' 12:00:10 INFO - SUITE-START | Running 2 tests 12:00:10 INFO - TEST-START | dromaeo_css 12:00:10 INFO - Initialising browser for dromaeo_css test... 12:00:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35104/getInfo.html -profile /tmp/tmpqT8WJI/profile 12:00:10 INFO - TEST-INFO | started process 12371 (/builds/slave/test/build/application/firefox/firefox http://localhost:35104/getInfo.html) 12:00:16 INFO - TEST-INFO | 12371: exit 0 12:00:16 INFO - Browser initialized. 12:00:16 INFO - Running cycle 1/1 for dromaeo_css test... 12:00:16 INFO - Using env: {'DISPLAY': ':0', 12:00:16 INFO - 'HOME': '/home/cltbld', 12:00:16 INFO - 'JSGC_DISABLE_POISONING': '1', 12:00:16 INFO - 'LANG': 'en_US.UTF-8', 12:00:16 INFO - 'LANGUAGE': 'en_US:en', 12:00:16 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:00:16 INFO - 'LOGNAME': 'cltbld', 12:00:16 INFO - 'MAIL': '/var/mail/cltbld', 12:00:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:00:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:00:16 INFO - 'MOZ_CRASHREPORTER': '1', 12:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:16 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:00:16 INFO - 'MOZ_NO_REMOTE': '1', 12:00:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:16 INFO - 'NO_EM_RESTART': '1', 12:00:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:16 INFO - 'PWD': '/builds/slave/test', 12:00:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:00:16 INFO - 'RUST_BACKTRACE': 'full', 12:00:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:00:16 INFO - 'SHELL': '/bin/bash', 12:00:16 INFO - 'SHLVL': '1', 12:00:16 INFO - 'STYLO_FORCE_DISABLED': '1', 12:00:16 INFO - 'TERM': 'linux', 12:00:16 INFO - 'TMOUT': '86400', 12:00:16 INFO - 'USER': 'cltbld', 12:00:16 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', 12:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:16 INFO - '_': '/tools/buildbot/bin/python'} 12:00:16 INFO - TEST-INFO | started process 12574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqT8WJI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:00:17 INFO - PID 12574 | 12:00:17 INFO - PID 12574 | (/builds/slave/test/build/application/firefox/firefox:12627): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:00:17 INFO - PID 12574 | 12:00:27 INFO - PID 12574 | RSS: Main: 161972224 12:00:27 INFO - PID 12574 | 12:03:25 INFO - PID 12574 | Cycle 1(1): loaded http://localhost:35104/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35104/tests/dromaeo/cssquery-ext.html) 12:03:26 INFO - PID 12574 | RSS: Main: 166354944 12:03:26 INFO - PID 12574 | 12:06:28 INFO - PID 12574 | Cycle 1(1): loaded http://localhost:35104/tests/dromaeo/cssquery-ext.html (next: http://localhost:35104/tests/dromaeo/cssquery-jquery.html) 12:06:28 INFO - PID 12574 | RSS: Main: 162816000 12:06:28 INFO - PID 12574 | 12:09:30 INFO - PID 12574 | Cycle 1(1): loaded http://localhost:35104/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35104/tests/dromaeo/cssquery-mootools.html) 12:09:30 INFO - PID 12574 | RSS: Main: 164896768 12:09:30 INFO - PID 12574 | 12:12:32 INFO - PID 12574 | Cycle 1(1): loaded http://localhost:35104/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35104/tests/dromaeo/cssquery-prototype.html) 12:12:33 INFO - PID 12574 | RSS: Main: 163610624 12:12:33 INFO - PID 12574 | 12:15:36 INFO - PID 12574 | Cycle 1(1): loaded http://localhost:35104/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35104/tests/dromaeo/cssquery-yui.html) 12:15:36 INFO - PID 12574 | RSS: Main: 165175296 12:15:36 INFO - PID 12574 | 12:18:38 INFO - PID 12574 | Cycle 1(1): loaded http://localhost:35104/tests/dromaeo/cssquery-yui.html (next: http://localhost:35104/tests/dromaeo/cssquery-dojo.html) 12:18:38 INFO - PID 12574 | RSS: Main: 166510592 12:18:38 INFO - PID 12574 | 12:18:38 INFO - PID 12574 | __start_tp_report 12:18:38 INFO - PID 12574 | _x_x_mozilla_page_load 12:18:38 INFO - PID 12574 | _x_x_mozilla_page_load_details 12:18:38 INFO - PID 12574 | |i|pagename|runs| 12:18:38 INFO - PID 12574 | |0;dojo.html;3874.709396795241;3907.7655340679557;3916.4712763776884;3925.7840818754976;3928.135810121772;6367.5542712010065;6388.552801303905;6424.646644434554;6438.098666186737;6504.642244676541;6348.746050157988;6392.776252831151;6424.068510066038;6428.164338635971;6432.5497215194955;5731.627444216113;5741.856453588652;5753.137029445575;5763.9135412968835;5768.509676677488;5645.971770141144;5732.197492351074;5758.9424105759035;5788.363280039192;5790.334111577159;5772.5670574707065;5780.2196703444915;5812.854678633047;5821.3305469870875;5826.300843898738;5680.204771332017;5703.77184912603;5737.598368114233;5786.537077033849;5794;5358.785648574052;5594.049011668027;5655.462731040545;5687.516561092312;5727.169560413717;6327.5254355923025;6364.809055728336;6382.457491113261;6396.93603063968;6415;6857.965710171417;6872.518923675345;6930.584164950119;6971.511994160411;6999.440044796455;7030.964845175741;7031.19141298752;7049.506534542584;7092.822679433004;7095.361417472401;6462.224533056064;6494.1232933553365;6540.051692504608;6548.246951600579;6549.443297319734;7122.71509139639;7128.465365097639;7138.821529461701;7211.639418029183;7240.239774823673;6923.6192009438955;6974.337437943387;6982.33667801558;6986.336298051677;6992.79021629352;7001.824954376181;7004.719811207597;7014.018037474758;7080.822979425556;7096.361327480551;6773.254941956381;6827.351401616838;6927.965360173167;6932.064171336906;7001.29987001306;6898.551594146365;6964.338387853146;6972.825679357955;6976.616286104211;6976.930230697628;5027.069992051483;5036.84889453317;5040.042391945592;5050.368703912011;5066.012127635149;4431.889202769957;4568.200564901195;4581.908361832745;4592;4596.770161491912;6329.082283068929;6384.744610215632;6411.711472983727;6416.262129855033;6451.580647258007;6885.449164066863;6904.447644188453;6906.792796216121;6913.654317284217;6924.896126558106;6290.748370065146;6321.399467050623;6332.335104813928;6334;6336.904946425807;5577.44225577439;5645.294338207724;5655.095184770499;5655.321361436571;5665.433456654384;7057.7176912922905;7060.3292687194635;7087.114110736158;7185.03002094721;7196.352328290374;6814.761483348258;6896.862062758616;6951.721931122901;6955.547889387173;7059.2234854166;7188.353048225685;7194.748183813542;7210.315020073084;7217.639118043971;7223.1693355264815;6878.449724022166;6937.202221744564;6948.722051118101;6955.130608673916;6972.895406568804;6964.895526567004;6984.161900571964;6989.405900498515;7077.575345479082;7085.078939737801;6568.343165683394;6640.667966601554;6645.1361323027695;6649.368310010541;6659.600423974577;6705;6706.027625994301;6708.6981085850275;6762.628055456997;6775.93224067753;6715.294894036251;6774.729010839511;6803.013563033432;6812.761553345807;6824.181098268041;6716.361945615159;6722.865542689021;6767.0526126341365;6796.830079248059;6873.965630171817;6483.481321494363;6553.672316384257;6598.868022639424;6632.668366581748;6668.166479190101 12:18:38 INFO - PID 12574 | |1;ext.html;897.8159477307153;923.4459324405353;968.7965527239279;982.4252812104918;984.709510694346;42060.158796824086;42599.57400425995;42902.785486072564;42914.78542607291;42942.14115717684;39490;39777.60222397775;39814.800925995405;39817.606383776576;39852.60147398533;7123.287671232887;7234.095738032746;7245.239249878766;7247;7251.021112149871;7043.823904402405;7128.536645118077;7133.964330178342;7138.571685698848;7150.606716630583;7828.804279892991;8010.759677209693;8013.07849597295;8018.719344822933;8019.238172373615;7938.047434307891;7964.8805267921025;7996.4002699797165;7999.120096789348;8004.479708818937;7682.692692292301;7942.960285198595;7944.086430060502;7946.682132714743;7950.880736788953;39523.604763952564;39744;39772.20455590872;39782;39876.800615997025;3724.087598538348;3772.3021241070214;3772.660460558563;3779.3197224499577;3780.3951367781297;33201.833990830135;33301;33304.33391332184;33374.6662533374;33378.6662133378;4702.6002789762915;4728.976355118237;4751.477337492873;4780.545848144421;4803.78382972767;210568;213429;218478;219428;223268;50321.74839125781;50524.74737626289;50728;50830;50846.49153508492;51894.74052629713;52460.47539524556;52778.73610631922;52891.47108528866;52920;16357.83642163587;16609.750853737205;16613.0862802547;16617.41839035628;16629.91685041567;13610.59168224955;13631.113977591425;13636.590902272948;13638.863611363959;13642.93178534101;14473.638159046108;14493.347799349054;14517.927410363092;14564;14588.781168282272;5629.521490673257;5654.943450565524;5735.598508104476;5815.680137592473;5817.912731309034;1060.9893901061046;1074.2748644664975;1074.6453670288786;1089.4498278369372;1102.795982743195;25156.496870062496;25254.873725631624;25258.494830103296;25360.492790144093;25405.61891571628;1182.8876256755595;1192.5170306026073;1198.748262864808;1199.7240634654079;1218.774526712561;13156.342182891009;13186.274754888382;13256.40346184424;13316;17680;290629;293671;293816;293948;293954;59929.101063484086;60320.58717651333;60367.69816150979;60414;60488.697556512816;1500.9549713508393;1516.3707061569326;1540.7765873948215;1554.1452201289246;1555.5566663500847;30421.239469012566;30655.846720766254;31082.4855595306;31119;31903.521447178777;54398.45601544092;54799;54894.451055488935;54895.451045490634;54905.72547137398;260245;263248;263363;263497;264172;37213.44179837359;37960;39338.80330598329;39505.80247098746;39508.40737388884;47767.28349074836;49416;49483.50516494789;49936.25095623496;49953.25070123879;36300;36644.45033324556;36741.44887826738;37061.814690926374;37517.81241093777;36007.45988810118;36210;36336.81831590931;36380.81809591041;37215.62784372122;41816;41860.79069604632;42571.36142957796;42750.57249427466;42873;34892.82553587216;34958.30083398369;35213;35221.82389088038;35665.64334356727;26105.89261243304;26255.343616409744;26863.462730744886;26943.86528067347;27407.45185096327 12:18:38 INFO - PID 12574 | |2;jquery.html;603.1616053685381;607.8055022392834;612.773273888661;615.7536985205915;622.2129006806389;22458.88770556149;22460.66309005364;23422.180223692154;23466.76533234669;23489.999999999956;25942;26379.604305935427;26511;26545.336366590844;26566.07018754344;6415.326390728965;6631.171103612049;6639.904415771416;6640.833979150536;6646.8005959821285;6326.968365158168;6682.331766823328;6686.866262674744;6691.364320389555;6691.732330706766;6621.834454138661;6626.072349871022;6638.302978187293;6658.4673226141795;6661.633610151464;6621.93378066218;6624.93375066248;6630.469562435042;6644.734210631593;6663.733450661967;6154.292256390528;6191.4118158774845;6227.283862355842;6229.688515574248;6234.438900498932;29428.11715648534;30074.398512029857;30527.236819079477;30797.384052318826;30830.53754193689;2231.386368748591;2322.5354929014097;2332.685087513181;2335.97664023361;2336.1473062332298;19622.70565941512;20145.8992705037;20167.394978150678;20167.596648066956;20170.092345844474;2467.383154211447;2540.9872950635126;2566.9486610267877;2582.496413199427;2596.493683731673;154196;156261;157488;157738;157810.99999999886;15832;16099.390060994041;16499.67000660004;16774.412895548598;16959.236834342486;25386.619200711633;25751;25864;26209.213723588324;26286.21141365762;10804.67585972422;11034.282771619819;11174.161937854693;11203.71990700239;11243.212975091665;9963.750906227402;10074.74813129663;10083.697489075339;10172.745681358025;10264.846027309597;9947.651832185838;10196.38821670702;10222.619946307303;10225.386476811414;10232.64185753495;2834.8157369770897;2888.4511942730815;2895.131460561823;2952.9704702952695;3030.9090727278217;1042.2183362478142;1050.485262221506;1061.2624226162743;1072.8819829818713;1074.8065348237235;21224;21308.78691213068;21448.785512144677;21630.35108946734;21958.341249762532;1074.2694967422071;1122.2537012886503;1129.2158389744184;1129.943502824872;1140.7832511822894;11466.77066458683;11790;12013.159078864395;12085.154039217347;12196.51213951432;686061;691604;692755;693398;696182;138030;141601.29199353937;142657;142729.99999999793;143128;1287.3434548380394;1299.844018717741;1317.7693903567028;1334.733053389326;1337.9732405352033;18745.875247485194;19226.32707855218;19237.615247694688;19564.510887227934;20026.399208023784;64490.677546611965;66541;69448.30551694418;69835;69960.65019674868;82878;84453.57773211095;84829.57585212034;84843.5757821207;85525.1447485542;15561.377544898078;16070.19649017521;16181.67636647284;16232.513024609281;16239.18804059816;24969.87515062413;25330.1134460293;25607.6158857621;25681.357966050997;25731.742682572934;20403.4899127523;20621.484462888548;20642.17431302731;20835.479113022295;20863.478413039797;16509.422170223985;17329.65340693154;17682.5579360517;18302.99333536615;18755.81244187595;20584.27955021567;20728.792712072685;20809.1676332945;20811.583768324246;20997;16023.278952446935;16118.516444506684;16136.919315403347;16150.919245403698;16198.352065917703;20214.797852021293;20286.188552457737;20366.18535258573;20379.388618341472;20421.285255016002 12:18:38 INFO - PID 12574 | |3;mootools.html;1409.3023953143195;1456.9271536423175;1471.602667279835;1481.570344600066;1481.6221863424828;16664;16708.66582668346;17351.739723904153;17442.476725698216;17457.912710436445;17058;17305.567360815985;17327.480175594752;17370.82629173711;17383.47849564512;2776.541870591355;2823.153054083777;2824;2826.7173282671774;2835.1636267301196;2722.5099482093215;2807.6350074490288;2808.6348774659264;2811.184756420646;2811.6063751074867;2718.619393284942;2748.807583469158;2750.931226719338;2752.119321817019;2756.1593713917246;2716.891324347034;2829.108830718317;2855.35754455248;2860.985695071511;2866.7706583473273;2718.8504632245217;2721.91834244971;2751.339678477151;2752.2568906395163;2753.9724602753918;16258.83741162597;16428.260728267138;16582.917085414618;16706.91646541772;16708.832911670972;8263.421560490768;8534.487930724177;8544.401891867572;8545.145485451467;8546.102659220755;5257.553107985826;5484.670919744788;5595.608307418483;5600.299962504687;5605.467480589337;1990.8407327413772;2023.1098316740588;2028.9695654565194;2070.3167954574956;2072.968905466419;29705;29916.850415748;29925.102246932627;29999.400011999856;30009;7190.96404517974;7232.891506627405;7300.342969132804;7356.1172659280155;7411.777646670608;19435.12541935616;19583.608327833364;19612.411627651192;19618.50953726168;19632.60734785296;7914.881276780853;8077.63650635711;8493.575321233913;8498.447600905922;8526.74419767408;6583.407493325623;6730.158730158731;6853.554518956252;6965.756198533027;7751.992241008633;5538.280023596906;5704.914426283609;5749.367569567428;5767.106098554731;5802.854928626733;1646.4813583721088;1661.6427468094419;1672.4062957650103;1680.4538524979187;1684.6967545841621;975.8731364922514;981.8478135888806;985.3890587835444;986.5264672957021;1006.4112494190834;8663.913360866436;8682.34882383811;8873.378863479495;10637.787244255227;10640.78718425627;1030.407515678488;1057.7567159553346;1058.872935247775;1059.904608585231;1063.4204358624568;5548.472895074961;5652.830415087554;5691.516221121168;5775.364709881909;6034.0043892758085;24528.632070518957;24641.63037554438;24657.137000205264;25124.371890702514;25145;24799.752002480105;24871.253862384157;25147.874260628945;25174.496510069697;25207.369815754388;12083.335416552174;12198.817017744741;12283.93858030722;12317.260964342167;12545.937270313772;9390.342676012613;10057.396556206651;10136;10278.33190842593;10451.581936722447;20023.29918452847;20238.19047238094;20927.37217883466;20932.58134837264;21052.47368815792;20497.897510512354;21108.15567377349;21113.894430527747;22038.779612204315;22046.228382006553;13408.262545560088;13820.86179138236;13828.101173423694;13829.79255311151;13833.30833458303;15587.76618350703;15669.373225071326;15687.529374118794;15774.211289435252;15830.050196988217;12319.137660364047;12334.259944403364;12865.871341286467;13017.088803784023;13020.41408136655;12437.502499899903;12546.1844980076;12549.184303020274;12771.489140434278;13011.089223754247;10588.311759735592;10707.5181616829;10788.838167427339;10859.34843909368;10987.725306867393;7951.403644726553;8203.220694034057;8220.83558328818;8221.79445513843;8227.71203007892;8815.867761983447;8980.146886045815;8987.101289871222;9059.818803624023;9066.95466522663 12:18:38 INFO - PID 12574 | |4;prototype.html;550.4220568403177;556.4935908323426;576.1885129865938;586.3842964886868;586.9383714709955;6313.210848643919;6347.17486726726;6362.681865906704;6368;6453.225612926443;6195.5663103582765;6201.379862013797;6222.906656400158;6254.155688981986;6288.779892703757;4901.705897646153;5092.770825312851;5124.0776660201245;5149.536541711245;5156.896862062757;4930.704157750546;4950;4956.900861982758;5006.699598024112;5007.624428167884;4954.878426591243;4984.551390374865;4988.850334489953;4989.351384320052;5014.874628134307;4949.8020079196785;4953.7367971167305;4954.455009948902;4972.279019542182;5013.623978201649;4537.205988951953;4552.977235113836;4585.495595484494;4604.309353596954;4611.423572053493;6065.272167339947;6092.9695351523405;6197.969010154966;6239.594426362272;6283.8743225135695;5861.970690146564;5882.441168089024;5899.1446240295345;5899.852503687443;5902.822915312548;6569.343065693441;6623.701933413008;6701.1623547056615;6701.664916754192;6714.6306953117555;5072.036313100499;5084.262781896604;5089.465606111342;5136.332276804029;5157.277981082614;6577.93422065778;6777.356151165632;6808.659567021678;6813.3527314905;6992.580445173306;5206.448840068339;5232.73836308183;5235.73821308933;5252.789888404497;5254.789808407697;5291.100512912737;5328.653637513549;5334.5732341412595;5347.51872331492;5370.355557333145;5882.147088672119;5890.617109887844;5909.763609455659;5919.881602367928;5920.934231838224;6658.4673226141795;6711.161104861892;6743.426808721216;6766.391024807791;6788.830279243059;1829.9935035730296;1834.339637730416;1845.3633496443706;1848.5655870870335;1854.2304943448319;1226.5458869268837;1250.7686078075585;1278.725074109071;1298.3832679477173;1302.3943866102309;6161.353057928943;6214.8135555933395;6231.626102433868;6251.156093927261;6275.780347687809;6768.5513161904155;6826.965865170642;6855.143107111611;6874.690638921261;6905.512716078349;6008.909866352008;6009.248843894513;6100.23747031621;6137.631742095488;6187.288461826947;3512.964870351315;3542.2561262134723;3588.9102772430374;3611.963880361215;3613.385724426854;6817.716065118142;6898.862022759517;6923.896141557881;6941.826454338682;6966.233714291424;6858.485613579001;6878.43109830111;6884.793456196322;6953.548019378724;6970.721171153097;6936.965315173392;6944.4097251734165;6988.860222795617;6991;7023.543469674455;6653.933460665331;6692.163479565054;6704.296048914794;6730.081926650881;6759.425448836707;6702.229243637044;6764.154480689914;6803.93196068033;6805.183377994672;6808.659567021728;6876.865317222602;6934.631182355084;6980.267071957372;6989.266127056586;7031.578105313698;5204.479552044765;5234.52889239955;5249.580033597226;5258.789648414021;5287.920681189708;6665;6701.463882889259;6858.8285292866085;6871.793846184622;6903.308689371136;6586.637734924625;6609.933900660932;6635.933640663531;6639.800805975829;6653.73385064592;6612.272650008399;6618.139641846722;6631.403173714389;6664.966675166593;6673.799786006428;6466.644334561456;6515.153030106056;6576.80269591913;6581.6709164540625;6639.136912201576;6609.339066093352;6636.966815165893;6676.259855502453;6700.631465269457;6705.357187489097;6355.173827402593;6422.32565580626;6446.194225721785;6468.8059358219325;6501.317361676955 12:18:38 INFO - PID 12574 | |5;yui.html;987.6790043235949;989.9257555683321;1008.9596416143346;1021.0708255487508;1022.3201570955315;20526.076326565304;20555.691664625025;20771.896140519297;20863.165473381083;22082.33752987409;21817.23639672612;21868.562628747415;22000.33998980033;22047;22054.228102016434;1022.4121130350042;1041.0838462153333;1041.5625437316346;1043.8695163104612;1044.0812085364869;1082.5290998415676;1082.5994382078643;1083.0252772504768;1083.5936523803573;1084.3710647824282;1077.6820837852813;1131.247720266022;1138.3966497756162;1138.4421633399656;1140.0366690146855;1134.1663877050362;1134.8978591926725;1135.6536256441782;1135.8750537440917;1135.9261647992853;817.8486979908736;819.9508029518248;820.24127681894;820.913804050578;822.4201937633953;18990.145443455076;19589.118489668;21150.15399384038;21332.46668833276;21483.892580537155;20788;21238.681419778717;21249.468763281042;22583.661245081337;23208.767912321;18374.816251837445;18483.445496635122;18596.721049184274;18928.33750818715;19088.23647054116;4028.697847661437;4063;4063.045184381668;4091.5499295077516;4094;140751.99999999898;140899;141277;141957;142036;17807.376741813976;17958;18432.262709491737;18476.445706628554;18498;32735.181620459203;32748.67251327504;33085.83457082699;33306.3338733224;33322.333553329285;9154.038825923315;9369.578368973413;9373.48445835472;9391.530423478798;9393.389429687186;4509.977450112729;4548.249538826123;4558.97720511402;4576.88557786058;4581.702189357681;5981.282246130492;6114.174586430775;6176.4441200292185;6209.658468784261;6232.937670623326;1073.4203530093662;1109.9667009989714;1113.832925061231;1120.8991190792867;1134.744682446443;762.1387831750197;768.5196752029981;786.2059320086754;793.6983946100445;796.2356138107482;13046.217226966412;13287.800682989762;13621.727565448635;13974.371153298125;14020;724.3408498266552;727.9344858962719;728.420905380224;732.6666366803091;740.1081696555746;6244.2819075806865;6249.406306400884;6392.648404337713;6404.359564043559;6441.194850643669;134742;138453;139263.91714444265;139503;141710;120490;123296;124214;126227.36886315509;128895;102196.48901755444;102428.46357304647;105454.47272763588;105733;105769.94230057755;11780.646580602595;11804.055675545764;11830.763384732085;11852.34812085309;12008.819867702166;50406;50571.24143137782;50636.74681626568;51502;52433.7378313106;86492;89783.55108224417;90121.54939225262;90157.54921225352;90295.09704903129;20957.371278861658;20981.160753570297;21076.683849742574;21486.67769983483;21522.139114435875;19659.60680786405;20259.29092481756;22631;22770.65844012374;23077.307680769605;20543.8972805135;20736;20781.376558702657;20802.167913283298;21385.67921481148;19839.801601983796;19925.202991880164;20251.696224556938;20293.391198264075;20597.79402205959;19995.200191992157;20628.07173677158;20668.896655516626;20682.27612033632;20688.79311206929;13409.865901340861;13870.4451821926;13949.16305021702;14830.62923426923;15756.369745210062;15913.840861591236;16009.03945763258;16227.432039878548;16827.7475837865;17180.484585462455 12:18:38 INFO - PID 12574 | __end_tp_report 12:18:38 INFO - PID 12574 | __start_cc_report 12:18:38 INFO - PID 12574 | _x_x_mozilla_cycle_collect,361 12:18:38 INFO - PID 12574 | __end_cc_report 12:18:38 INFO - PID 12574 | __startTimestamp1504725518551__endTimestamp 12:18:38 INFO - PID 12574 | 12:18:38 INFO - PID 12574 | ------- Summary: start ------- 12:18:38 INFO - PID 12574 | Number of tests: 6 12:18:38 INFO - PID 12574 | 12:18:38 INFO - PID 12574 | [#0] dojo.html Cycles:165 Average:6390.73 Median:6649.37 stddev:778.08 (11.7%) stddev-sans-first:755.02 12:18:38 INFO - PID 12574 | Values: 3874.7 3907.8 3916.5 3925.8 3928.1 6367.6 6388.6 6424.6 6438.1 6504.6 6348.7 6392.8 6424.1 6428.2 6432.5 5731.6 5741.9 5753.1 5763.9 5768.5 5646.0 5732.2 5758.9 5788.4 5790.3 5772.6 5780.2 5812.9 5821.3 5826.3 5680.2 5703.8 5737.6 5786.5 5794.0 5358.8 5594.0 5655.5 5687.5 5727.2 6327.5 6364.8 6382.5 6396.9 6415.0 6858.0 6872.5 6930.6 6971.5 6999.4 7031.0 7031.2 7049.5 7092.8 7095.4 6462.2 6494.1 6540.1 6548.2 6549.4 7122.7 7128.5 7138.8 7211.6 7240.2 6923.6 6974.3 6982.3 6986.3 6992.8 7001.8 7004.7 7014.0 7080.8 7096.4 6773.3 6827.4 6928.0 6932.1 7001.3 6898.6 6964.3 6972.8 6976.6 6976.9 5027.1 5036.8 5040.0 5050.4 5066.0 4431.9 4568.2 4581.9 4592.0 4596.8 6329.1 6384.7 6411.7 6416.3 6451.6 6885.4 6904.4 6906.8 6913.7 6924.9 6290.7 6321.4 6332.3 6334.0 6336.9 5577.4 5645.3 5655.1 5655.3 5665.4 7057.7 7060.3 7087.1 7185.0 7196.4 6814.8 6896.9 6951.7 6955.5 7059.2 7188.4 7194.7 7210.3 7217.6 7223.2 6878.4 6937.2 6948.7 6955.1 6972.9 6964.9 6984.2 6989.4 7077.6 7085.1 6568.3 6640.7 6645.1 6649.4 6659.6 6705.0 6706.0 6708.7 6762.6 6775.9 6715.3 6774.7 6803.0 6812.8 6824.2 6716.4 6722.9 6767.1 6796.8 6874.0 6483.5 6553.7 6598.9 6632.7 6668.2 12:18:38 INFO - PID 12574 | 12:18:38 INFO - PID 12574 | [#1] ext.html Cycles:180 Average:44025.10 Median:20870.20 stddev:67623.06 (324.0%) stddev-sans-first:67735.22 12:18:38 INFO - PID 12574 | Values: 897.8 923.4 968.8 982.4 984.7 42060.2 42599.6 42902.8 42914.8 42942.1 39490.0 39777.6 39814.8 39817.6 39852.6 7123.3 7234.1 7245.2 7247.0 7251.0 7043.8 7128.5 7134.0 7138.6 7150.6 7828.8 8010.8 8013.1 8018.7 8019.2 7938.0 7964.9 7996.4 7999.1 8004.5 7682.7 7943.0 7944.1 7946.7 7950.9 39523.6 39744.0 39772.2 39782.0 39876.8 3724.1 3772.3 3772.7 3779.3 3780.4 33201.8 33301.0 33304.3 33374.7 33378.7 4702.6 4729.0 4751.5 4780.5 4803.8 210568.0 213429.0 218478.0 219428.0 223268.0 50321.7 50524.7 50728.0 50830.0 50846.5 51894.7 52460.5 52778.7 52891.5 52920.0 16357.8 16609.8 16613.1 16617.4 16629.9 13610.6 13631.1 13636.6 13638.9 13642.9 14473.6 14493.3 14517.9 14564.0 14588.8 5629.5 5654.9 5735.6 5815.7 5817.9 1061.0 1074.3 1074.6 1089.4 1102.8 25156.5 25254.9 25258.5 25360.5 25405.6 1182.9 1192.5 1198.7 1199.7 1218.8 13156.3 13186.3 13256.4 13316.0 17680.0 290629.0 293671.0 293816.0 293948.0 293954.0 59929.1 60320.6 60367.7 60414.0 60488.7 1501.0 1516.4 1540.8 1554.1 1555.6 30421.2 30655.8 31082.5 31119.0 31903.5 54398.5 54799.0 54894.5 54895.5 54905.7 260245.0 263248.0 263363.0 263497.0 264172.0 37213.4 37960.0 39338.8 39505.8 39508.4 47767.3 49416.0 49483.5 49936.3 49953.3 36300.0 36644.5 36741.4 37061.8 37517.8 36007.5 36210.0 36336.8 36380.8 37215.6 41816.0 41860.8 42571.4 42750.6 42873.0 34892.8 34958.3 35213.0 35221.8 35665.6 26105.9 26255.3 26863.5 26943.9 27407.5 12:18:38 INFO - PID 12574 | 12:18:38 INFO - PID 12574 | [#2] jquery.html Cycles:180 Average:43082.02 Median:21539.57 stddev:115338.61 (535.5%) stddev-sans-first:115618.06 12:18:38 INFO - PID 12574 | Values: 603.2 607.8 612.8 615.8 622.2 22458.9 22460.7 23422.2 23466.8 23490.0 25942.0 26379.6 26511.0 26545.3 26566.1 6415.3 6631.2 6639.9 6640.8 6646.8 6327.0 6682.3 6686.9 6691.4 6691.7 6621.8 6626.1 6638.3 6658.5 6661.6 6621.9 6624.9 6630.5 6644.7 6663.7 6154.3 6191.4 6227.3 6229.7 6234.4 29428.1 30074.4 30527.2 30797.4 30830.5 2231.4 2322.5 2332.7 2336.0 2336.1 19622.7 20145.9 20167.4 20167.6 20170.1 2467.4 2541.0 2566.9 2582.5 2596.5 154196.0 156261.0 157488.0 157738.0 157811.0 15832.0 16099.4 16499.7 16774.4 16959.2 25386.6 25751.0 25864.0 26209.2 26286.2 10804.7 11034.3 11174.2 11203.7 11243.2 9963.8 10074.7 10083.7 10172.7 10264.8 9947.7 10196.4 10222.6 10225.4 10232.6 2834.8 2888.5 2895.1 2953.0 3030.9 1042.2 1050.5 1061.3 1072.9 1074.8 21224.0 21308.8 21448.8 21630.4 21958.3 1074.3 1122.3 1129.2 1129.9 1140.8 11466.8 11790.0 12013.2 12085.2 12196.5 686061.0 691604.0 692755.0 693398.0 696182.0 138030.0 141601.3 142657.0 142730.0 143128.0 1287.3 1299.8 1317.8 1334.7 1338.0 18745.9 19226.3 19237.6 19564.5 20026.4 64490.7 66541.0 69448.3 69835.0 69960.7 82878.0 84453.6 84829.6 84843.6 85525.1 15561.4 16070.2 16181.7 16232.5 16239.2 24969.9 25330.1 25607.6 25681.4 25731.7 20403.5 20621.5 20642.2 20835.5 20863.5 16509.4 17329.7 17682.6 18303.0 18755.8 20584.3 20728.8 20809.2 20811.6 20997.0 16023.3 16118.5 16136.9 16150.9 16198.4 20214.8 20286.2 20366.2 20379.4 20421.3 12:18:38 INFO - PID 12574 | 12:18:38 INFO - PID 12574 | [#3] mootools.html Cycles:180 Average:10446.05 Median:24835.50 stddev:7650.21 (30.8%) stddev-sans-first:7641.54 12:18:38 INFO - PID 12574 | Values: 1409.3 1456.9 1471.6 1481.6 1481.6 16664.0 16708.7 17351.7 17442.5 17457.9 17058.0 17305.6 17327.5 17370.8 17383.5 2776.5 2823.2 2824.0 2826.7 2835.2 2722.5 2807.6 2808.6 2811.2 2811.6 2718.6 2748.8 2750.9 2752.1 2756.2 2716.9 2829.1 2855.4 2861.0 2866.8 2718.9 2721.9 2751.3 2752.3 2754.0 16258.8 16428.3 16582.9 16706.9 16708.8 8263.4 8534.5 8544.4 8545.1 8546.1 5257.6 5484.7 5595.6 5600.3 5605.5 1990.8 2023.1 2029.0 2070.3 2073.0 29705.0 29916.9 29925.1 29999.4 30009.0 7191.0 7232.9 7300.3 7356.1 7411.8 19435.1 19583.6 19612.4 19618.5 19632.6 7914.9 8077.6 8493.6 8498.4 8526.7 6583.4 6730.2 6853.6 6965.8 7752.0 5538.3 5704.9 5749.4 5767.1 5802.9 1646.5 1661.6 1672.4 1680.5 1684.7 975.9 981.8 985.4 986.5 1006.4 8663.9 8682.3 8873.4 10637.8 10640.8 1030.4 1057.8 1058.9 1059.9 1063.4 5548.5 5652.8 5691.5 5775.4 6034.0 24528.6 24641.6 24657.1 25124.4 25145.0 24799.8 24871.3 25147.9 25174.5 25207.4 12083.3 12198.8 12283.9 12317.3 12545.9 9390.3 10057.4 10136.0 10278.3 10451.6 20023.3 20238.2 20927.4 20932.6 21052.5 20497.9 21108.2 21113.9 22038.8 22046.2 13408.3 13820.9 13828.1 13829.8 13833.3 15587.8 15669.4 15687.5 15774.2 15830.1 12319.1 12334.3 12865.9 13017.1 13020.4 12437.5 12546.2 12549.2 12771.5 13011.1 10588.3 10707.5 10788.8 10859.3 10987.7 7951.4 8203.2 8220.8 8221.8 8227.7 8815.9 8980.1 8987.1 9059.8 9067.0 12:18:38 INFO - PID 12574 | 12:18:38 INFO - PID 12574 | [#4] prototype.html Cycles:180 Average:5657.38 Median:6252.66 stddev:1575.94 (25.2%) stddev-sans-first:1533.04 12:18:38 INFO - PID 12574 | Values: 550.4 556.5 576.2 586.4 586.9 6313.2 6347.2 6362.7 6368.0 6453.2 6195.6 6201.4 6222.9 6254.2 6288.8 4901.7 5092.8 5124.1 5149.5 5156.9 4930.7 4950.0 4956.9 5006.7 5007.6 4954.9 4984.6 4988.9 4989.4 5014.9 4949.8 4953.7 4954.5 4972.3 5013.6 4537.2 4553.0 4585.5 4604.3 4611.4 6065.3 6093.0 6198.0 6239.6 6283.9 5862.0 5882.4 5899.1 5899.9 5902.8 6569.3 6623.7 6701.2 6701.7 6714.6 5072.0 5084.3 5089.5 5136.3 5157.3 6577.9 6777.4 6808.7 6813.4 6992.6 5206.4 5232.7 5235.7 5252.8 5254.8 5291.1 5328.7 5334.6 5347.5 5370.4 5882.1 5890.6 5909.8 5919.9 5920.9 6658.5 6711.2 6743.4 6766.4 6788.8 1830.0 1834.3 1845.4 1848.6 1854.2 1226.5 1250.8 1278.7 1298.4 1302.4 6161.4 6214.8 6231.6 6251.2 6275.8 6768.6 6827.0 6855.1 6874.7 6905.5 6008.9 6009.2 6100.2 6137.6 6187.3 3513.0 3542.3 3588.9 3612.0 3613.4 6817.7 6898.9 6923.9 6941.8 6966.2 6858.5 6878.4 6884.8 6953.5 6970.7 6937.0 6944.4 6988.9 6991.0 7023.5 6653.9 6692.2 6704.3 6730.1 6759.4 6702.2 6764.2 6803.9 6805.2 6808.7 6876.9 6934.6 6980.3 6989.3 7031.6 5204.5 5234.5 5249.6 5258.8 5287.9 6665.0 6701.5 6858.8 6871.8 6903.3 6586.6 6609.9 6635.9 6639.8 6653.7 6612.3 6618.1 6631.4 6665.0 6673.8 6466.6 6515.2 6576.8 6581.7 6639.1 6609.3 6637.0 6676.3 6700.6 6705.4 6355.2 6422.3 6446.2 6468.8 6501.3 12:18:38 INFO - PID 12574 | 12:18:38 INFO - PID 12574 | [#5] yui.html Cycles:180 Average:27908.80 Median:20612.93 stddev:39203.30 (190.2%) stddev-sans-first:39261.16 12:18:38 INFO - PID 12574 | Values: 987.7 989.9 1009.0 1021.1 1022.3 20526.1 20555.7 20771.9 20863.2 22082.3 21817.2 21868.6 22000.3 22047.0 22054.2 1022.4 1041.1 1041.6 1043.9 1044.1 1082.5 1082.6 1083.0 1083.6 1084.4 1077.7 1131.2 1138.4 1138.4 1140.0 1134.2 1134.9 1135.7 1135.9 1135.9 817.8 820.0 820.2 820.9 822.4 18990.1 19589.1 21150.2 21332.5 21483.9 20788.0 21238.7 21249.5 22583.7 23208.8 18374.8 18483.4 18596.7 18928.3 19088.2 4028.7 4063.0 4063.0 4091.5 4094.0 140752.0 140899.0 141277.0 141957.0 142036.0 17807.4 17958.0 18432.3 18476.4 18498.0 32735.2 32748.7 33085.8 33306.3 33322.3 9154.0 9369.6 9373.5 9391.5 9393.4 4510.0 4548.2 4559.0 4576.9 4581.7 5981.3 6114.2 6176.4 6209.7 6232.9 1073.4 1110.0 1113.8 1120.9 1134.7 762.1 768.5 786.2 793.7 796.2 13046.2 13287.8 13621.7 13974.4 14020.0 724.3 727.9 728.4 732.7 740.1 6244.3 6249.4 6392.6 6404.4 6441.2 134742.0 138453.0 139263.9 139503.0 141710.0 120490.0 123296.0 124214.0 126227.4 128895.0 102196.5 102428.5 105454.5 105733.0 105769.9 11780.6 11804.1 11830.8 11852.3 12008.8 50406.0 50571.2 50636.7 51502.0 52433.7 86492.0 89783.6 90121.5 90157.5 90295.1 20957.4 20981.2 21076.7 21486.7 21522.1 19659.6 20259.3 22631.0 22770.7 23077.3 20543.9 20736.0 20781.4 20802.2 21385.7 19839.8 19925.2 20251.7 20293.4 20597.8 19995.2 20628.1 20668.9 20682.3 20688.8 13409.9 13870.4 13949.2 14830.6 15756.4 15913.8 16009.0 16227.4 16827.7 17180.5 12:18:38 INFO - PID 12574 | -------- Summary: end -------- 12:18:38 INFO - PID 12574 | 12:18:39 INFO - TEST-INFO | 12574: exit 0 12:18:39 INFO - TEST-OK | dromaeo_css | took 1108653ms 12:18:39 INFO - TEST-START | kraken 12:18:39 INFO - Initialising browser for kraken test... 12:18:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35104/getInfo.html -profile /tmp/tmpeDzgLT/profile 12:18:39 INFO - TEST-INFO | started process 12955 (/builds/slave/test/build/application/firefox/firefox http://localhost:35104/getInfo.html) 12:18:44 INFO - TEST-INFO | 12955: exit 0 12:18:45 INFO - Browser initialized. 12:18:45 INFO - Running cycle 1/1 for kraken test... 12:18:45 INFO - Using env: {'DISPLAY': ':0', 12:18:45 INFO - 'HOME': '/home/cltbld', 12:18:45 INFO - 'JSGC_DISABLE_POISONING': '1', 12:18:45 INFO - 'LANG': 'en_US.UTF-8', 12:18:45 INFO - 'LANGUAGE': 'en_US:en', 12:18:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:18:45 INFO - 'LOGNAME': 'cltbld', 12:18:45 INFO - 'MAIL': '/var/mail/cltbld', 12:18:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:18:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:18:45 INFO - 'MOZ_CRASHREPORTER': '1', 12:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:18:45 INFO - 'MOZ_NO_REMOTE': '1', 12:18:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:45 INFO - 'NO_EM_RESTART': '1', 12:18:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:45 INFO - 'PWD': '/builds/slave/test', 12:18:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:18:45 INFO - 'RUST_BACKTRACE': 'full', 12:18:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:18:45 INFO - 'SHELL': '/bin/bash', 12:18:45 INFO - 'SHLVL': '1', 12:18:45 INFO - 'STYLO_FORCE_DISABLED': '1', 12:18:45 INFO - 'TERM': 'linux', 12:18:45 INFO - 'TMOUT': '86400', 12:18:45 INFO - 'USER': 'cltbld', 12:18:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826', 12:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:45 INFO - '_': '/tools/buildbot/bin/python'} 12:18:45 INFO - TEST-INFO | started process 13157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeDzgLT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:45 INFO - PID 13157 | 12:18:45 INFO - PID 13157 | (/builds/slave/test/build/application/firefox/firefox:13210): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:18:45 INFO - PID 13157 | 12:18:56 INFO - PID 13157 | RSS: Main: 162443264 12:18:56 INFO - PID 13157 | 12:18:58 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35104/tests/kraken/driver.html?testName=audio-beat-detection) 12:18:59 INFO - PID 13157 | RSS: Main: 167825408 12:18:59 INFO - PID 13157 | 12:19:02 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35104/tests/kraken/driver.html?testName=audio-dft) 12:19:02 INFO - PID 13157 | RSS: Main: 172965888 12:19:02 INFO - PID 13157 | 12:19:05 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35104/tests/kraken/driver.html?testName=audio-fft) 12:19:06 INFO - PID 13157 | RSS: Main: 165769216 12:19:06 INFO - PID 13157 | 12:19:08 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35104/tests/kraken/driver.html?testName=audio-oscillator) 12:19:08 INFO - PID 13157 | RSS: Main: 167251968 12:19:08 INFO - PID 13157 | 12:19:11 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35104/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:19:11 INFO - PID 13157 | RSS: Main: 166776832 12:19:11 INFO - PID 13157 | 12:19:14 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35104/tests/kraken/driver.html?testName=imaging-darkroom) 12:19:15 INFO - PID 13157 | RSS: Main: 166825984 12:19:15 INFO - PID 13157 | 12:19:18 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35104/tests/kraken/driver.html?testName=imaging-desaturate) 12:19:19 INFO - PID 13157 | RSS: Main: 168460288 12:19:19 INFO - PID 13157 | 12:19:22 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35104/tests/kraken/driver.html?testName=json-parse-financial) 12:19:22 INFO - PID 13157 | RSS: Main: 168562688 12:19:22 INFO - PID 13157 | 12:19:24 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35104/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:19:24 INFO - PID 13157 | RSS: Main: 168394752 12:19:24 INFO - PID 13157 | 12:19:26 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35104/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:19:27 INFO - PID 13157 | RSS: Main: 168415232 12:19:27 INFO - PID 13157 | 12:19:29 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35104/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:19:29 INFO - PID 13157 | RSS: Main: 165072896 12:19:29 INFO - PID 13157 | 12:19:32 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:19:32 INFO - PID 13157 | RSS: Main: 165195776 12:19:32 INFO - PID 13157 | 12:19:35 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:19:36 INFO - PID 13157 | RSS: Main: 165462016 12:19:36 INFO - PID 13157 | 12:19:37 INFO - PID 13157 | Cycle 1(1): loaded http://localhost:35104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35104/tests/kraken/driver.html?testName=ai-astar) 12:19:38 INFO - PID 13157 | RSS: Main: 167424000 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | __start_tp_report 12:19:38 INFO - PID 13157 | _x_x_mozilla_page_load 12:19:38 INFO - PID 13157 | _x_x_mozilla_page_load_details 12:19:38 INFO - PID 13157 | |i|pagename|runs| 12:19:38 INFO - PID 13157 | |0;ai-astar;97;107;100;105;106;107;105;99;106;105 12:19:38 INFO - PID 13157 | |1;audio-beat-detection;136;111;140;184;113;142;138;114;164;115 12:19:38 INFO - PID 13157 | |2;audio-dft;164;161;162;164;163;161;159;163;162;169 12:19:38 INFO - PID 13157 | |3;audio-fft;73;74;74;181;74;74;72;73;148;75 12:19:38 INFO - PID 13157 | |4;audio-oscillator;79;78;129;78;78;77;128;79;78;124 12:19:38 INFO - PID 13157 | |5;imaging-gaussian-blur;116;120;114;113;114;114;113;113;114;114 12:19:38 INFO - PID 13157 | |6;imaging-darkroom;150;149;150;149;151;150;150;149;149;151 12:19:38 INFO - PID 13157 | |7;imaging-desaturate;98;99;94;93;94;94;94;94;94;94 12:19:38 INFO - PID 13157 | |8;json-parse-financial;46;52;45;43;43;44;44;43;43;45 12:19:38 INFO - PID 13157 | |9;json-stringify-tinderbox;40;39;40;40;40;40;40;39;39;39 12:19:38 INFO - PID 13157 | |10;stanford-crypto-aes;73;72;74;82;76;73;73;76;74;76 12:19:38 INFO - PID 13157 | |11;stanford-crypto-ccm;121;116;117;115;112;112;116;118;112;150 12:19:38 INFO - PID 13157 | |12;stanford-crypto-pbkdf2;156;161;168;161;155;158;165;164;157;156 12:19:38 INFO - PID 13157 | |13;stanford-crypto-sha256-iterative;60;61;65;60;61;62;59;59;61;58 12:19:38 INFO - PID 13157 | __end_tp_report 12:19:38 INFO - PID 13157 | __start_cc_report 12:19:38 INFO - PID 13157 | _x_x_mozilla_cycle_collect,878 12:19:38 INFO - PID 13157 | __end_cc_report 12:19:38 INFO - PID 13157 | __startTimestamp1504725578167__endTimestamp 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | ------- Summary: start ------- 12:19:38 INFO - PID 13157 | Number of tests: 14 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#0] ai-astar Cycles:10 Average:103.70 Median:106.50 stddev:3.62 (3.4%) stddev-sans-first:2.92 12:19:38 INFO - PID 13157 | Values: 97.0 107.0 100.0 105.0 106.0 107.0 105.0 99.0 106.0 105.0 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:139.00 stddev:24.09 (17.3%) stddev-sans-first:25.55 12:19:38 INFO - PID 13157 | Values: 136.0 111.0 140.0 184.0 113.0 142.0 138.0 114.0 164.0 115.0 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:2.66 (1.6%) stddev-sans-first:2.78 12:19:38 INFO - PID 13157 | Values: 164.0 161.0 162.0 164.0 163.0 161.0 159.0 163.0 162.0 169.0 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#3] audio-fft Cycles:10 Average:91.80 Median:74.00 stddev:39.11 (52.8%) stddev-sans-first:40.88 12:19:38 INFO - PID 13157 | Values: 73.0 74.0 74.0 181.0 74.0 74.0 72.0 73.0 148.0 75.0 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:78.00 stddev:23.64 (30.3%) stddev-sans-first:24.54 12:19:38 INFO - PID 13157 | Values: 79.0 78.0 129.0 78.0 78.0 77.0 128.0 79.0 78.0 124.0 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:2.12 (1.9%) stddev-sans-first:2.18 12:19:38 INFO - PID 13157 | Values: 116.0 120.0 114.0 113.0 114.0 114.0 113.0 113.0 114.0 114.0 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 12:19:38 INFO - PID 13157 | Values: 150.0 149.0 150.0 149.0 151.0 150.0 150.0 149.0 149.0 151.0 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:1.99 (2.1%) stddev-sans-first:1.74 12:19:38 INFO - PID 13157 | Values: 98.0 99.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#8] json-parse-financial Cycles:10 Average:44.80 Median:44.50 stddev:2.74 (6.2%) stddev-sans-first:2.87 12:19:38 INFO - PID 13157 | Values: 46.0 52.0 45.0 43.0 43.0 44.0 44.0 43.0 43.0 45.0 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#9] json-stringify-tinderbox Cycles:10 Average:39.60 Median:40.00 stddev:0.52 (1.3%) stddev-sans-first:0.53 12:19:38 INFO - PID 13157 | Values: 40.0 39.0 40.0 40.0 40.0 40.0 40.0 39.0 39.0 39.0 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.00 stddev:2.88 (3.8%) stddev-sans-first:2.98 12:19:38 INFO - PID 13157 | Values: 73.0 72.0 74.0 82.0 76.0 73.0 73.0 76.0 74.0 76.0 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:116.50 stddev:11.31 (9.7%) stddev-sans-first:11.97 12:19:38 INFO - PID 13157 | Values: 121.0 116.0 117.0 115.0 112.0 112.0 116.0 118.0 112.0 150.0 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:161.00 stddev:4.43 (2.8%) stddev-sans-first:4.45 12:19:38 INFO - PID 13157 | Values: 156.0 161.0 168.0 161.0 155.0 158.0 165.0 164.0 157.0 156.0 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:61.00 stddev:1.96 (3.2%) stddev-sans-first:2.06 12:19:38 INFO - PID 13157 | Values: 60.0 61.0 65.0 60.0 61.0 62.0 59.0 59.0 61.0 58.0 12:19:38 INFO - PID 13157 | -------- Summary: end -------- 12:19:38 INFO - PID 13157 | 12:19:38 INFO - PID 13157 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:19:38 INFO - TEST-INFO | 13157: exit 0 12:19:38 INFO - TEST-OK | kraken | took 59612ms 12:19:38 INFO - SUITE-END | took 1168s 12:19:39 INFO - Completed test suite (00:19:28) 12:19:39 INFO - javascript benchmark 12:19:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9194.207548010343, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3874.709396795241, 3907.7655340679557, 3916.4712763776884, 3925.7840818754976, 3928.135810121772, 6367.5542712010065, 6388.552801303905, 6424.646644434554, 6438.098666186737, 6504.642244676541, 6348.746050157988, 6392.776252831151, 6424.068510066038, 6428.164338635971, 6432.5497215194955, 5731.627444216113, 5741.856453588652, 5753.137029445575, 5763.9135412968835, 5768.509676677488, 5645.971770141144, 5732.197492351074, 5758.9424105759035, 5788.363280039192, 5790.334111577159, 5772.5670574707065, 5780.2196703444915, 5812.854678633047, 5821.3305469870875, 5826.300843898738, 5680.204771332017, 5703.77184912603, 5737.598368114233, 5786.537077033849, 5794.0, 5358.785648574052, 5594.049011668027, 5655.462731040545, 5687.516561092312, 5727.169560413717, 6327.5254355923025, 6364.809055728336, 6382.457491113261, 6396.93603063968, 6415.0, 6857.965710171417, 6872.518923675345, 6930.584164950119, 6971.511994160411, 6999.440044796455, 7030.964845175741, 7031.19141298752, 7049.506534542584, 7092.822679433004, 7095.361417472401, 6462.224533056064, 6494.1232933553365, 6540.051692504608, 6548.246951600579, 6549.443297319734, 7122.71509139639, 7128.465365097639, 7138.821529461701, 7211.639418029183, 7240.239774823673, 6923.6192009438955, 6974.337437943387, 6982.33667801558, 6986.336298051677, 6992.79021629352, 7001.824954376181, 7004.719811207597, 7014.018037474758, 7080.822979425556, 7096.361327480551, 6773.254941956381, 6827.351401616838, 6927.965360173167, 6932.064171336906, 7001.29987001306, 6898.551594146365, 6964.338387853146, 6972.825679357955, 6976.616286104211, 6976.930230697628, 5027.069992051483, 5036.84889453317, 5040.042391945592, 5050.368703912011, 5066.012127635149, 4431.889202769957, 4568.200564901195, 4581.908361832745, 4592.0, 4596.770161491912, 6329.082283068929, 6384.744610215632, 6411.711472983727, 6416.262129855033, 6451.580647258007, 6885.449164066863, 6904.447644188453, 6906.792796216121, 6913.654317284217, 6924.896126558106, 6290.748370065146, 6321.399467050623, 6332.335104813928, 6334.0, 6336.904946425807, 5577.44225577439, 5645.294338207724, 5655.095184770499, 5655.321361436571, 5665.433456654384, 7057.7176912922905, 7060.3292687194635, 7087.114110736158, 7185.03002094721, 7196.352328290374, 6814.761483348258, 6896.862062758616, 6951.721931122901, 6955.547889387173, 7059.2234854166, 7188.353048225685, 7194.748183813542, 7210.315020073084, 7217.639118043971, 7223.1693355264815, 6878.449724022166, 6937.202221744564, 6948.722051118101, 6955.130608673916, 6972.895406568804, 6964.895526567004, 6984.161900571964, 6989.405900498515, 7077.575345479082, 7085.078939737801, 6568.343165683394, 6640.667966601554, 6645.1361323027695, 6649.368310010541, 6659.600423974577, 6705.0, 6706.027625994301, 6708.6981085850275, 6762.628055456997, 6775.93224067753, 6715.294894036251, 6774.729010839511, 6803.013563033432, 6812.761553345807, 6824.181098268041, 6716.361945615159, 6722.865542689021, 6767.0526126341365, 6796.830079248059, 6873.965630171817, 6483.481321494363, 6553.672316384257, 6598.868022639424, 6632.668366581748, 6668.166479190101], "value": 6336.305412374785, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.8159477307153, 923.4459324405353, 968.7965527239279, 982.4252812104918, 984.709510694346, 42060.158796824086, 42599.57400425995, 42902.785486072564, 42914.78542607291, 42942.14115717684, 39490.0, 39777.60222397775, 39814.800925995405, 39817.606383776576, 39852.60147398533, 7123.287671232887, 7234.095738032746, 7245.239249878766, 7247.0, 7251.021112149871, 7043.823904402405, 7128.536645118077, 7133.964330178342, 7138.571685698848, 7150.606716630583, 7828.804279892991, 8010.759677209693, 8013.07849597295, 8018.719344822933, 8019.238172373615, 7938.047434307891, 7964.8805267921025, 7996.4002699797165, 7999.120096789348, 8004.479708818937, 7682.692692292301, 7942.960285198595, 7944.086430060502, 7946.682132714743, 7950.880736788953, 39523.604763952564, 39744.0, 39772.20455590872, 39782.0, 39876.800615997025, 3724.087598538348, 3772.3021241070214, 3772.660460558563, 3779.3197224499577, 3780.3951367781297, 33201.833990830135, 33301.0, 33304.33391332184, 33374.6662533374, 33378.6662133378, 4702.6002789762915, 4728.976355118237, 4751.477337492873, 4780.545848144421, 4803.78382972767, 210568.0, 213429.0, 218478.0, 219428.0, 223268.0, 50321.74839125781, 50524.74737626289, 50728.0, 50830.0, 50846.49153508492, 51894.74052629713, 52460.47539524556, 52778.73610631922, 52891.47108528866, 52920.0, 16357.83642163587, 16609.750853737205, 16613.0862802547, 16617.41839035628, 16629.91685041567, 13610.59168224955, 13631.113977591425, 13636.590902272948, 13638.863611363959, 13642.93178534101, 14473.638159046108, 14493.347799349054, 14517.927410363092, 14564.0, 14588.781168282272, 5629.521490673257, 5654.943450565524, 5735.598508104476, 5815.680137592473, 5817.912731309034, 1060.9893901061046, 1074.2748644664975, 1074.6453670288786, 1089.4498278369372, 1102.795982743195, 25156.496870062496, 25254.873725631624, 25258.494830103296, 25360.492790144093, 25405.61891571628, 1182.8876256755595, 1192.5170306026073, 1198.748262864808, 1199.7240634654079, 1218.774526712561, 13156.342182891009, 13186.274754888382, 13256.40346184424, 13316.0, 17680.0, 290629.0, 293671.0, 293816.0, 293948.0, 293954.0, 59929.101063484086, 60320.58717651333, 60367.69816150979, 60414.0, 60488.697556512816, 1500.9549713508393, 1516.3707061569326, 1540.7765873948215, 1554.1452201289246, 1555.5566663500847, 30421.239469012566, 30655.846720766254, 31082.4855595306, 31119.0, 31903.521447178777, 54398.45601544092, 54799.0, 54894.451055488935, 54895.451045490634, 54905.72547137398, 260245.0, 263248.0, 263363.0, 263497.0, 264172.0, 37213.44179837359, 37960.0, 39338.80330598329, 39505.80247098746, 39508.40737388884, 47767.28349074836, 49416.0, 49483.50516494789, 49936.25095623496, 49953.25070123879, 36300.0, 36644.45033324556, 36741.44887826738, 37061.814690926374, 37517.81241093777, 36007.45988810118, 36210.0, 36336.81831590931, 36380.81809591041, 37215.62784372122, 41816.0, 41860.79069604632, 42571.36142957796, 42750.57249427466, 42873.0, 34892.82553587216, 34958.30083398369, 35213.0, 35221.82389088038, 35665.64334356727, 26105.89261243304, 26255.343616409744, 26863.462730744886, 26943.86528067347, 27407.45185096327], "value": 18704.37995607951, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.1616053685381, 607.8055022392834, 612.773273888661, 615.7536985205915, 622.2129006806389, 22458.88770556149, 22460.66309005364, 23422.180223692154, 23466.76533234669, 23489.999999999956, 25942.0, 26379.604305935427, 26511.0, 26545.336366590844, 26566.07018754344, 6415.326390728965, 6631.171103612049, 6639.904415771416, 6640.833979150536, 6646.8005959821285, 6326.968365158168, 6682.331766823328, 6686.866262674744, 6691.364320389555, 6691.732330706766, 6621.834454138661, 6626.072349871022, 6638.302978187293, 6658.4673226141795, 6661.633610151464, 6621.93378066218, 6624.93375066248, 6630.469562435042, 6644.734210631593, 6663.733450661967, 6154.292256390528, 6191.4118158774845, 6227.283862355842, 6229.688515574248, 6234.438900498932, 29428.11715648534, 30074.398512029857, 30527.236819079477, 30797.384052318826, 30830.53754193689, 2231.386368748591, 2322.5354929014097, 2332.685087513181, 2335.97664023361, 2336.1473062332298, 19622.70565941512, 20145.8992705037, 20167.394978150678, 20167.596648066956, 20170.092345844474, 2467.383154211447, 2540.9872950635126, 2566.9486610267877, 2582.496413199427, 2596.493683731673, 154196.0, 156261.0, 157488.0, 157738.0, 157810.99999999886, 15832.0, 16099.390060994041, 16499.67000660004, 16774.412895548598, 16959.236834342486, 25386.619200711633, 25751.0, 25864.0, 26209.213723588324, 26286.21141365762, 10804.67585972422, 11034.282771619819, 11174.161937854693, 11203.71990700239, 11243.212975091665, 9963.750906227402, 10074.74813129663, 10083.697489075339, 10172.745681358025, 10264.846027309597, 9947.651832185838, 10196.38821670702, 10222.619946307303, 10225.386476811414, 10232.64185753495, 2834.8157369770897, 2888.4511942730815, 2895.131460561823, 2952.9704702952695, 3030.9090727278217, 1042.2183362478142, 1050.485262221506, 1061.2624226162743, 1072.8819829818713, 1074.8065348237235, 21224.0, 21308.78691213068, 21448.785512144677, 21630.35108946734, 21958.341249762532, 1074.2694967422071, 1122.2537012886503, 1129.2158389744184, 1129.943502824872, 1140.7832511822894, 11466.77066458683, 11790.0, 12013.159078864395, 12085.154039217347, 12196.51213951432, 686061.0, 691604.0, 692755.0, 693398.0, 696182.0, 138030.0, 141601.29199353937, 142657.0, 142729.99999999793, 143128.0, 1287.3434548380394, 1299.844018717741, 1317.7693903567028, 1334.733053389326, 1337.9732405352033, 18745.875247485194, 19226.32707855218, 19237.615247694688, 19564.510887227934, 20026.399208023784, 64490.677546611965, 66541.0, 69448.30551694418, 69835.0, 69960.65019674868, 82878.0, 84453.57773211095, 84829.57585212034, 84843.5757821207, 85525.1447485542, 15561.377544898078, 16070.19649017521, 16181.67636647284, 16232.513024609281, 16239.18804059816, 24969.87515062413, 25330.1134460293, 25607.6158857621, 25681.357966050997, 25731.742682572934, 20403.4899127523, 20621.484462888548, 20642.17431302731, 20835.479113022295, 20863.478413039797, 16509.422170223985, 17329.65340693154, 17682.5579360517, 18302.99333536615, 18755.81244187595, 20584.27955021567, 20728.792712072685, 20809.1676332945, 20811.583768324246, 20997.0, 16023.278952446935, 16118.516444506684, 16136.919315403347, 16150.919245403698, 16198.352065917703, 20214.797852021293, 20286.188552457737, 20366.18535258573, 20379.388618341472, 20421.285255016002], "value": 13082.030543288029, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.3023953143195, 1456.9271536423175, 1471.602667279835, 1481.570344600066, 1481.6221863424828, 16664.0, 16708.66582668346, 17351.739723904153, 17442.476725698216, 17457.912710436445, 17058.0, 17305.567360815985, 17327.480175594752, 17370.82629173711, 17383.47849564512, 2776.541870591355, 2823.153054083777, 2824.0, 2826.7173282671774, 2835.1636267301196, 2722.5099482093215, 2807.6350074490288, 2808.6348774659264, 2811.184756420646, 2811.6063751074867, 2718.619393284942, 2748.807583469158, 2750.931226719338, 2752.119321817019, 2756.1593713917246, 2716.891324347034, 2829.108830718317, 2855.35754455248, 2860.985695071511, 2866.7706583473273, 2718.8504632245217, 2721.91834244971, 2751.339678477151, 2752.2568906395163, 2753.9724602753918, 16258.83741162597, 16428.260728267138, 16582.917085414618, 16706.91646541772, 16708.832911670972, 8263.421560490768, 8534.487930724177, 8544.401891867572, 8545.145485451467, 8546.102659220755, 5257.553107985826, 5484.670919744788, 5595.608307418483, 5600.299962504687, 5605.467480589337, 1990.8407327413772, 2023.1098316740588, 2028.9695654565194, 2070.3167954574956, 2072.968905466419, 29705.0, 29916.850415748, 29925.102246932627, 29999.400011999856, 30009.0, 7190.96404517974, 7232.891506627405, 7300.342969132804, 7356.1172659280155, 7411.777646670608, 19435.12541935616, 19583.608327833364, 19612.411627651192, 19618.50953726168, 19632.60734785296, 7914.881276780853, 8077.63650635711, 8493.575321233913, 8498.447600905922, 8526.74419767408, 6583.407493325623, 6730.158730158731, 6853.554518956252, 6965.756198533027, 7751.992241008633, 5538.280023596906, 5704.914426283609, 5749.367569567428, 5767.106098554731, 5802.854928626733, 1646.4813583721088, 1661.6427468094419, 1672.4062957650103, 1680.4538524979187, 1684.6967545841621, 975.8731364922514, 981.8478135888806, 985.3890587835444, 986.5264672957021, 1006.4112494190834, 8663.913360866436, 8682.34882383811, 8873.378863479495, 10637.787244255227, 10640.78718425627, 1030.407515678488, 1057.7567159553346, 1058.872935247775, 1059.904608585231, 1063.4204358624568, 5548.472895074961, 5652.830415087554, 5691.516221121168, 5775.364709881909, 6034.0043892758085, 24528.632070518957, 24641.63037554438, 24657.137000205264, 25124.371890702514, 25145.0, 24799.752002480105, 24871.253862384157, 25147.874260628945, 25174.496510069697, 25207.369815754388, 12083.335416552174, 12198.817017744741, 12283.93858030722, 12317.260964342167, 12545.937270313772, 9390.342676012613, 10057.396556206651, 10136.0, 10278.33190842593, 10451.581936722447, 20023.29918452847, 20238.19047238094, 20927.37217883466, 20932.58134837264, 21052.47368815792, 20497.897510512354, 21108.15567377349, 21113.894430527747, 22038.779612204315, 22046.228382006553, 13408.262545560088, 13820.86179138236, 13828.101173423694, 13829.79255311151, 13833.30833458303, 15587.76618350703, 15669.373225071326, 15687.529374118794, 15774.211289435252, 15830.050196988217, 12319.137660364047, 12334.259944403364, 12865.871341286467, 13017.088803784023, 13020.41408136655, 12437.502499899903, 12546.1844980076, 12549.184303020274, 12771.489140434278, 13011.089223754247, 10588.311759735592, 10707.5181616829, 10788.838167427339, 10859.34843909368, 10987.725306867393, 7951.403644726553, 8203.220694034057, 8220.83558328818, 8221.79445513843, 8227.71203007892, 8815.867761983447, 8980.146886045815, 8987.101289871222, 9059.818803624023, 9066.95466522663], "value": 7334.5858843183705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.4220568403177, 556.4935908323426, 576.1885129865938, 586.3842964886868, 586.9383714709955, 6313.210848643919, 6347.17486726726, 6362.681865906704, 6368.0, 6453.225612926443, 6195.5663103582765, 6201.379862013797, 6222.906656400158, 6254.155688981986, 6288.779892703757, 4901.705897646153, 5092.770825312851, 5124.0776660201245, 5149.536541711245, 5156.896862062757, 4930.704157750546, 4950.0, 4956.900861982758, 5006.699598024112, 5007.624428167884, 4954.878426591243, 4984.551390374865, 4988.850334489953, 4989.351384320052, 5014.874628134307, 4949.8020079196785, 4953.7367971167305, 4954.455009948902, 4972.279019542182, 5013.623978201649, 4537.205988951953, 4552.977235113836, 4585.495595484494, 4604.309353596954, 4611.423572053493, 6065.272167339947, 6092.9695351523405, 6197.969010154966, 6239.594426362272, 6283.8743225135695, 5861.970690146564, 5882.441168089024, 5899.1446240295345, 5899.852503687443, 5902.822915312548, 6569.343065693441, 6623.701933413008, 6701.1623547056615, 6701.664916754192, 6714.6306953117555, 5072.036313100499, 5084.262781896604, 5089.465606111342, 5136.332276804029, 5157.277981082614, 6577.93422065778, 6777.356151165632, 6808.659567021678, 6813.3527314905, 6992.580445173306, 5206.448840068339, 5232.73836308183, 5235.73821308933, 5252.789888404497, 5254.789808407697, 5291.100512912737, 5328.653637513549, 5334.5732341412595, 5347.51872331492, 5370.355557333145, 5882.147088672119, 5890.617109887844, 5909.763609455659, 5919.881602367928, 5920.934231838224, 6658.4673226141795, 6711.161104861892, 6743.426808721216, 6766.391024807791, 6788.830279243059, 1829.9935035730296, 1834.339637730416, 1845.3633496443706, 1848.5655870870335, 1854.2304943448319, 1226.5458869268837, 1250.7686078075585, 1278.725074109071, 1298.3832679477173, 1302.3943866102309, 6161.353057928943, 6214.8135555933395, 6231.626102433868, 6251.156093927261, 6275.780347687809, 6768.5513161904155, 6826.965865170642, 6855.143107111611, 6874.690638921261, 6905.512716078349, 6008.909866352008, 6009.248843894513, 6100.23747031621, 6137.631742095488, 6187.288461826947, 3512.964870351315, 3542.2561262134723, 3588.9102772430374, 3611.963880361215, 3613.385724426854, 6817.716065118142, 6898.862022759517, 6923.896141557881, 6941.826454338682, 6966.233714291424, 6858.485613579001, 6878.43109830111, 6884.793456196322, 6953.548019378724, 6970.721171153097, 6936.965315173392, 6944.4097251734165, 6988.860222795617, 6991.0, 7023.543469674455, 6653.933460665331, 6692.163479565054, 6704.296048914794, 6730.081926650881, 6759.425448836707, 6702.229243637044, 6764.154480689914, 6803.93196068033, 6805.183377994672, 6808.659567021728, 6876.865317222602, 6934.631182355084, 6980.267071957372, 6989.266127056586, 7031.578105313698, 5204.479552044765, 5234.52889239955, 5249.580033597226, 5258.789648414021, 5287.920681189708, 6665.0, 6701.463882889259, 6858.8285292866085, 6871.793846184622, 6903.308689371136, 6586.637734924625, 6609.933900660932, 6635.933640663531, 6639.800805975829, 6653.73385064592, 6612.272650008399, 6618.139641846722, 6631.403173714389, 6664.966675166593, 6673.799786006428, 6466.644334561456, 6515.153030106056, 6576.80269591913, 6581.6709164540625, 6639.136912201576, 6609.339066093352, 6636.966815165893, 6676.259855502453, 6700.631465269457, 6705.357187489097, 6355.173827402593, 6422.32565580626, 6446.194225721785, 6468.8059358219325, 6501.317361676955], "value": 5204.340862806822, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [987.6790043235949, 989.9257555683321, 1008.9596416143346, 1021.0708255487508, 1022.3201570955315, 20526.076326565304, 20555.691664625025, 20771.896140519297, 20863.165473381083, 22082.33752987409, 21817.23639672612, 21868.562628747415, 22000.33998980033, 22047.0, 22054.228102016434, 1022.4121130350042, 1041.0838462153333, 1041.5625437316346, 1043.8695163104612, 1044.0812085364869, 1082.5290998415676, 1082.5994382078643, 1083.0252772504768, 1083.5936523803573, 1084.3710647824282, 1077.6820837852813, 1131.247720266022, 1138.3966497756162, 1138.4421633399656, 1140.0366690146855, 1134.1663877050362, 1134.8978591926725, 1135.6536256441782, 1135.8750537440917, 1135.9261647992853, 817.8486979908736, 819.9508029518248, 820.24127681894, 820.913804050578, 822.4201937633953, 18990.145443455076, 19589.118489668, 21150.15399384038, 21332.46668833276, 21483.892580537155, 20788.0, 21238.681419778717, 21249.468763281042, 22583.661245081337, 23208.767912321, 18374.816251837445, 18483.445496635122, 18596.721049184274, 18928.33750818715, 19088.23647054116, 4028.697847661437, 4063.0, 4063.045184381668, 4091.5499295077516, 4094.0, 140751.99999999898, 140899.0, 141277.0, 141957.0, 142036.0, 17807.376741813976, 17958.0, 18432.262709491737, 18476.445706628554, 18498.0, 32735.181620459203, 32748.67251327504, 33085.83457082699, 33306.3338733224, 33322.333553329285, 9154.038825923315, 9369.578368973413, 9373.48445835472, 9391.530423478798, 9393.389429687186, 4509.977450112729, 4548.249538826123, 4558.97720511402, 4576.88557786058, 4581.702189357681, 5981.282246130492, 6114.174586430775, 6176.4441200292185, 6209.658468784261, 6232.937670623326, 1073.4203530093662, 1109.9667009989714, 1113.832925061231, 1120.8991190792867, 1134.744682446443, 762.1387831750197, 768.5196752029981, 786.2059320086754, 793.6983946100445, 796.2356138107482, 13046.217226966412, 13287.800682989762, 13621.727565448635, 13974.371153298125, 14020.0, 724.3408498266552, 727.9344858962719, 728.420905380224, 732.6666366803091, 740.1081696555746, 6244.2819075806865, 6249.406306400884, 6392.648404337713, 6404.359564043559, 6441.194850643669, 134742.0, 138453.0, 139263.91714444265, 139503.0, 141710.0, 120490.0, 123296.0, 124214.0, 126227.36886315509, 128895.0, 102196.48901755444, 102428.46357304647, 105454.47272763588, 105733.0, 105769.94230057755, 11780.646580602595, 11804.055675545764, 11830.763384732085, 11852.34812085309, 12008.819867702166, 50406.0, 50571.24143137782, 50636.74681626568, 51502.0, 52433.7378313106, 86492.0, 89783.55108224417, 90121.54939225262, 90157.54921225352, 90295.09704903129, 20957.371278861658, 20981.160753570297, 21076.683849742574, 21486.67769983483, 21522.139114435875, 19659.60680786405, 20259.29092481756, 22631.0, 22770.65844012374, 23077.307680769605, 20543.8972805135, 20736.0, 20781.376558702657, 20802.167913283298, 21385.67921481148, 19839.801601983796, 19925.202991880164, 20251.696224556938, 20293.391198264075, 20597.79402205959, 19995.200191992157, 20628.07173677158, 20668.896655516626, 20682.27612033632, 20688.79311206929, 13409.865901340861, 13870.4451821926, 13949.16305021702, 14830.62923426923, 15756.369745210062, 15913.840861591236, 16009.03945763258, 16227.432039878548, 16827.7475837865, 17180.484585462455], "value": 10206.178524751162, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1444.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 100.0, 105.0, 106.0, 107.0, 105.0, 99.0, 106.0, 105.0], "value": 103.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 111.0, 140.0, 184.0, 113.0, 142.0, 138.0, 114.0, 164.0, 115.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 162.0, 164.0, 163.0, 161.0, 159.0, 163.0, 162.0, 169.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 181.0, 74.0, 74.0, 72.0, 73.0, 148.0, 75.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 129.0, 78.0, 78.0, 77.0, 128.0, 79.0, 78.0, 124.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 120.0, 114.0, 113.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 149.0, 151.0, 150.0, 150.0, 149.0, 149.0, 151.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 52.0, 45.0, 43.0, 43.0, 44.0, 44.0, 43.0, 43.0, 45.0], "value": 44.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 39.0, 40.0, 40.0, 40.0, 40.0, 40.0, 39.0, 39.0, 39.0], "value": 39.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 74.0, 82.0, 76.0, 73.0, 73.0, 76.0, 74.0, 76.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 116.0, 117.0, 115.0, 112.0, 112.0, 116.0, 118.0, 112.0, 150.0], "value": 118.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 161.0, 168.0, 161.0, 155.0, 158.0, 165.0, 164.0, 157.0, 156.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 65.0, 60.0, 61.0, 62.0, 59.0, 59.0, 61.0, 58.0], "value": 60.6, "unit": "score"}]}]} 12:19:39 INFO - Return code: 0 12:19:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:19:39 INFO - # TBPL SUCCESS # 12:19:39 INFO - Running post-action listener: _package_coverage_data 12:19:39 INFO - Running post-action listener: _resource_record_post_action 12:19:39 INFO - [mozharness: 2017-09-06 19:19:39.483680Z] Finished run-tests step (success) 12:19:39 INFO - Running post-run listener: _resource_record_post_run 12:19:39 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 16384; Write bytes: 385978368; Read time: 208; Write time: 215028 12:19:39 INFO - TinderboxPrint: CPU usage
13.1% 12:19:39 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 208 12:19:39 INFO - TinderboxPrint: I/O write bytes / time
385,978,368 / 215,028 12:19:39 INFO - TinderboxPrint: CPU idle
8,220.1 (86.9%) 12:19:39 INFO - TinderboxPrint: CPU user
1,184.9 (12.5%) 12:19:39 INFO - TinderboxPrint: Swap in / out
0 / 0 12:19:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 104112128; Read time: 72; Write time: 84540 12:19:39 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:19:39 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 8192; Write bytes: 276082688; Read time: 132; Write time: 129472 12:19:40 INFO - Running post-run listener: _upload_blobber_files 12:19:40 INFO - Blob upload gear active. 12:19:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:19:40 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 12:19:40 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'] 12:19:40 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 12:19:40 INFO - (blobuploader) - INFO - Open directory for files ... 12:19:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:19:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:19:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:44 INFO - (blobuploader) - INFO - Done attempting. 12:19:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:19:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:19:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:45 INFO - (blobuploader) - INFO - Done attempting. 12:19:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:19:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:19:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:46 INFO - (blobuploader) - INFO - Done attempting. 12:19:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:19:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:19:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:47 INFO - (blobuploader) - INFO - Done attempting. 12:19:47 INFO - (blobuploader) - INFO - Iteration through files over. 12:19:47 INFO - Return code: 0 12:19:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:19:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:19:47 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd9b4dcaf71f6c3c9ca1977f395126acc6ff6c55c9ea99e24805d9a614aee305cdd2568059fc63995f114ba1279de4a0534b4ea65dd6ad9417820449bae43626", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d51790cc89b218ad33197948aea77837eb0133108c6979e2c432a54ff58a24916e88adf7865b3e3b8ca6088bd6d6630b5a42d40f4d39894ad0eba4bdf985240", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc866b2940ff86df1b6e6173c7c75f2669a4fbcec7916324b9911fdd766cc81585d43987e8ccb3bb60cbe7ebdf1f8b35f21fff6b1afdae2195b879e625de7923", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ac9f90bcc4c599828a58b48a720dbee4123d3f4d9710250240cf22b019c98483ff879969c24c56a02f71a233f12a527bab33fb71b3a44ad537ed5dbc2147ee4"} 12:19:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:19:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:19:47 INFO - Contents: 12:19:47 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd9b4dcaf71f6c3c9ca1977f395126acc6ff6c55c9ea99e24805d9a614aee305cdd2568059fc63995f114ba1279de4a0534b4ea65dd6ad9417820449bae43626", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d51790cc89b218ad33197948aea77837eb0133108c6979e2c432a54ff58a24916e88adf7865b3e3b8ca6088bd6d6630b5a42d40f4d39894ad0eba4bdf985240", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc866b2940ff86df1b6e6173c7c75f2669a4fbcec7916324b9911fdd766cc81585d43987e8ccb3bb60cbe7ebdf1f8b35f21fff6b1afdae2195b879e625de7923", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ac9f90bcc4c599828a58b48a720dbee4123d3f4d9710250240cf22b019c98483ff879969c24c56a02f71a233f12a527bab33fb71b3a44ad537ed5dbc2147ee4"} 12:19:47 INFO - Running post-run listener: copy_logs_to_upload_dir 12:19:47 INFO - Copying logs to upload dir... 12:19:47 INFO - mkdir: /builds/slave/test/build/upload/logs 12:19:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.660732 ========= master_lag: 0.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-06 12:19:47.541350) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 12:19:47.549064) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826 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/cd9b4dcaf71f6c3c9ca1977f395126acc6ff6c55c9ea99e24805d9a614aee305cdd2568059fc63995f114ba1279de4a0534b4ea65dd6ad9417820449bae43626", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d51790cc89b218ad33197948aea77837eb0133108c6979e2c432a54ff58a24916e88adf7865b3e3b8ca6088bd6d6630b5a42d40f4d39894ad0eba4bdf985240", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc866b2940ff86df1b6e6173c7c75f2669a4fbcec7916324b9911fdd766cc81585d43987e8ccb3bb60cbe7ebdf1f8b35f21fff6b1afdae2195b879e625de7923", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ac9f90bcc4c599828a58b48a720dbee4123d3f4d9710250240cf22b019c98483ff879969c24c56a02f71a233f12a527bab33fb71b3a44ad537ed5dbc2147ee4"} build_url:https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/W4Q8jKTfQTCMMexkCM748g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd9b4dcaf71f6c3c9ca1977f395126acc6ff6c55c9ea99e24805d9a614aee305cdd2568059fc63995f114ba1279de4a0534b4ea65dd6ad9417820449bae43626", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d51790cc89b218ad33197948aea77837eb0133108c6979e2c432a54ff58a24916e88adf7865b3e3b8ca6088bd6d6630b5a42d40f4d39894ad0eba4bdf985240", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc866b2940ff86df1b6e6173c7c75f2669a4fbcec7916324b9911fdd766cc81585d43987e8ccb3bb60cbe7ebdf1f8b35f21fff6b1afdae2195b879e625de7923", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ac9f90bcc4c599828a58b48a720dbee4123d3f4d9710250240cf22b019c98483ff879969c24c56a02f71a233f12a527bab33fb71b3a44ad537ed5dbc2147ee4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 12:19:47.576535) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 12:19:47.579838) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1504724339.405040-127093826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 12:19:47.661253) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 12:19:47.661553) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 12:19:47.664848) ========= ========= Total master_lag: 0.56 =========