builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-067 starttime: 1507058424.6 results: success (0) revision: 9be05b2177667ed8221f9da4fdcc200dbdf3de62 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:24.597561) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:24.598008) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:24.598293) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:24.616572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:24.616963) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-03 12:20:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.1M=0.001s 2017-10-03 12:20:24 (23.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148532 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:24.782621) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:24.785976) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020853 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:24.835376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:24.835700) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9be05b2177667ed8221f9da4fdcc200dbdf3de62 --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 9be05b2177667ed8221f9da4fdcc200dbdf3de62 --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=e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-03 12:20:24,885 truncating revision to first 12 chars 2017-10-03 12:20:24,885 Setting DEBUG logging. 2017-10-03 12:20:24,885 attempt 1/10 2017-10-03 12:20:24,885 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9be05b217766?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-03 12:20:25,250 unpacking tar archive at: mozilla-central-9be05b217766/testing/mozharness/ program finished with exit code 0 elapsedTime=0.688940 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:25.544073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:25.544387) ========= script_repo_revision: 9be05b2177667ed8221f9da4fdcc200dbdf3de62 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:25.544810) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:25.545069) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 12:20:25.558346) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-10-03 12:20:25.558773) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:20:25 INFO - MultiFileLogger online at 20171003 12:20:25 in /builds/slave/test 12:20:25 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 12:20:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:20:25 INFO - {'append_to_log': False, 12:20:25 INFO - 'base_work_dir': '/builds/slave/test', 12:20:25 INFO - 'blob_upload_branch': 'Firefox', 12:20:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:20:25 INFO - 'branch': 'Firefox', 12:20:25 INFO - 'buildbot_json_path': 'buildprops.json', 12:20:25 INFO - 'code_coverage': False, 12:20:25 INFO - 'config_files': ('talos/linux_config.py',), 12:20:25 INFO - 'default_actions': ('clobber', 12:20:25 INFO - 'read-buildbot-config', 12:20:25 INFO - 'download-and-extract', 12:20:25 INFO - 'populate-webroot', 12:20:25 INFO - 'create-virtualenv', 12:20:25 INFO - 'install', 12:20:25 INFO - 'setup-mitmproxy', 12:20:25 INFO - 'run-tests'), 12:20:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:20:25 INFO - 'disable_ccov_upload': False, 12:20:25 INFO - 'disable_stylo': False, 12:20:25 INFO - 'download_minidump_stackwalk': True, 12:20:25 INFO - 'download_symbols': 'ondemand', 12:20:25 INFO - 'enable_stylo': False, 12:20:25 INFO - 'enable_webrender': False, 12:20:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:20:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:20:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:20:25 INFO - 'gecko_profile': False, 12:20:25 INFO - 'gecko_profile_interval': 0, 12:20:25 INFO - 'installer_path': 'installer.exe', 12:20:25 INFO - 'log_level': 'info', 12:20:25 INFO - 'log_name': 'talos', 12:20:25 INFO - 'log_to_console': True, 12:20:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:20:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:20:25 INFO - 'opt_config_files': (), 12:20:25 INFO - 'pip_index': False, 12:20:25 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 12:20:25 INFO - 'system_bits': '32', 12:20:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:20:25 INFO - 'title': 'talos-linux64-ix-067', 12:20:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:20:25 INFO - 'use_talos_json': True, 12:20:25 INFO - 'verify': 'False', 12:20:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:20:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:20:25 INFO - 'work_dir': 'build'} 12:20:25 INFO - [mozharness: 2017-10-03 19:20:25.744085Z] Running clobber step. 12:20:25 INFO - Running pre-action listener: _resource_record_pre_action 12:20:25 INFO - Running main action method: clobber 12:20:25 INFO - rmtree: /builds/slave/test/build 12:20:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:20:27 INFO - Running post-action listener: _resource_record_post_action 12:20:27 INFO - [mozharness: 2017-10-03 19:20:27.355375Z] Finished clobber step (success) 12:20:27 INFO - [mozharness: 2017-10-03 19:20:27.355472Z] Running read-buildbot-config step. 12:20:27 INFO - Running pre-action listener: _resource_record_pre_action 12:20:27 INFO - Running main action method: read_buildbot_config 12:20:27 INFO - Using buildbot properties: 12:20:27 INFO - { 12:20:27 INFO - "project": "", 12:20:27 INFO - "product": "firefox", 12:20:27 INFO - "who": "ffxbld@noreply.mozilla.org", 12:20:27 INFO - "installer_path": "public/build/target.tar.bz2", 12:20:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 12:20:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:20:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 12:20:27 INFO - "stage_platform": "linux64-pgo", 12:20:27 INFO - "basedir": "/builds/slave/test", 12:20:27 INFO - "buildnumber": 12, 12:20:27 INFO - "platform": "ubuntu64_hw", 12:20:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:20:27 INFO - "slavebuilddir": "test", 12:20:27 INFO - "taskId": "KdGhAM-XQaWMkcL5PLkkkw", 12:20:27 INFO - "branch": "mozilla-central", 12:20:27 INFO - "script_repo_revision": "production", 12:20:27 INFO - "revision": "9be05b2177667ed8221f9da4fdcc200dbdf3de62", 12:20:27 INFO - "slavename": "talos-linux64-ix-067", 12:20:27 INFO - "repo_path": "mozilla-central" 12:20:27 INFO - } 12:20:27 INFO - Finding installer, test and symbols from parent task. 12:20:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KdGhAM-XQaWMkcL5PLkkkw'}, attempt #1 12:20:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KdGhAM-XQaWMkcL5PLkkkw'}, attempt #1 12:20:28 INFO - Task dependencies: Dq8jydmSRL6tZ237UTvWrg 12:20:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg'}, attempt #1 12:20:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.tar.bz2 12:20:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.test_packages.json 12:20:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.crashreporter-symbols.zip 12:20:28 INFO - Running post-action listener: _resource_record_post_action 12:20:28 INFO - [mozharness: 2017-10-03 19:20:28.816783Z] Finished read-buildbot-config step (success) 12:20:28 INFO - [mozharness: 2017-10-03 19:20:28.817001Z] Running download-and-extract step. 12:20:28 INFO - Running pre-action listener: _resource_record_pre_action 12:20:28 INFO - Running main action method: download_and_extract 12:20:28 INFO - mkdir: /builds/slave/test/build/tests 12:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:28 INFO - trying https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.test_packages.json 12:20:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:20:29 INFO - Downloaded 989 bytes. 12:20:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:20:29 INFO - Using the following test package requirements: 12:20:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:20:29 INFO - u'common': [u'target.common.tests.zip'], 12:20:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:20:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:20:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:20:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:20:29 INFO - u'mozbase': [u'target.common.tests.zip'], 12:20:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:20:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:20:29 INFO - u'web-platform': [u'target.common.tests.zip', 12:20:29 INFO - u'target.web-platform.tests.tar.gz'], 12:20:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:20:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:20:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.common.tests.zip 12:20:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:20:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.common.tests.zip into memory 12:20:30 INFO - Content-Length response header: 55872803 12:20:30 INFO - Bytes received: 55872803 12:20:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.talos.tests.zip 12:20:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:20:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.talos.tests.zip into memory 12:20:42 INFO - Content-Length response header: 14522427 12:20:42 INFO - Bytes received: 14522427 12:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:42 INFO - trying https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.tar.bz2 12:20:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:20:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:20:43 INFO - Downloaded 62327451 bytes. 12:20:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.tar.bz2 12:20:43 INFO - mkdir: /builds/slave/test/properties 12:20:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:20:43 INFO - Writing to file /builds/slave/test/properties/build_url 12:20:43 INFO - Contents: 12:20:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.tar.bz2 12:20:43 INFO - Running post-action listener: _resource_record_post_action 12:20:43 INFO - Running post-action listener: find_tests_for_verification 12:20:43 INFO - Running post-action listener: set_extra_try_arguments 12:20:43 INFO - [mozharness: 2017-10-03 19:20:43.797173Z] Finished download-and-extract step (success) 12:20:43 INFO - [mozharness: 2017-10-03 19:20:43.797273Z] Running populate-webroot step. 12:20:43 INFO - Running pre-action listener: _resource_record_pre_action 12:20:43 INFO - Running main action method: populate_webroot 12:20:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:20:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:20:43 INFO - 'tests': ['tresize', 12:20:43 INFO - 'tcanvasmark']}, 12:20:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:20:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:20:43 INFO - 'tests': ['dromaeo_css', 12:20:43 INFO - 'kraken']}, 12:20:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:20:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:20:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:20:43 INFO - 'talos_options': ['--disable-stylo'], 12:20:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:20:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:20:43 INFO - 'tests': ['damp', 'tps']}, 12:20:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:20:43 INFO - 'talos_options': ['--disable-stylo'], 12:20:43 INFO - 'tests': ['damp', 'tps']}, 12:20:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:20:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:20:43 INFO - 'tests': ['dromaeo_dom']}, 12:20:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:20:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:20:43 INFO - 'tests': ['basic_compositor_video', 12:20:43 INFO - 'glvideo']}, 12:20:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:20:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:20:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:20:43 INFO - 'talos_options': ['--disable-stylo'], 12:20:43 INFO - 'tests': ['ts_paint_webext', 12:20:43 INFO - 'tp5o_webext']}, 12:20:43 INFO - 'other-e10s': {'tests': ['a11yr', 12:20:43 INFO - 'ts_paint', 12:20:43 INFO - 'tpaint', 12:20:43 INFO - 'sessionrestore', 12:20:43 INFO - 'sessionrestore_many_windows', 12:20:43 INFO - 'sessionrestore_no_auto_restore', 12:20:43 INFO - 'tabpaint', 12:20:43 INFO - 'cpstartup']}, 12:20:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:20:43 INFO - 'tests': ['a11yr', 12:20:43 INFO - 'ts_paint', 12:20:43 INFO - 'tpaint', 12:20:43 INFO - 'sessionrestore', 12:20:43 INFO - 'sessionrestore_many_windows', 12:20:43 INFO - 'sessionrestore_no_auto_restore', 12:20:43 INFO - 'tabpaint', 12:20:43 INFO - 'cpstartup']}, 12:20:43 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 12:20:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:20:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:20:43 INFO - 'tests': ['perf_reftest_singletons']}, 12:20:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:20:43 INFO - 'tests': ['perf_reftest']}, 12:20:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:20:43 INFO - 'tsvgr_opacity', 12:20:43 INFO - 'tart', 12:20:43 INFO - 'tscrollx', 12:20:43 INFO - 'tsvg_static']}, 12:20:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:20:43 INFO - 'tests': ['tsvgx', 12:20:43 INFO - 'tsvgr_opacity', 12:20:43 INFO - 'tart', 12:20:43 INFO - 'tscrollx', 12:20:43 INFO - 'tsvg_static']}, 12:20:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:20:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:20:43 INFO - 'talos_options': ['--disable-stylo'], 12:20:43 INFO - 'tests': ['tp5o']}, 12:20:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:20:43 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:20:43 INFO - 'talos_options': ['--mitmproxy', 12:20:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:20:43 INFO - '--firstNonBlankPaint'], 12:20:43 INFO - 'tests': ['tp6_google', 12:20:43 INFO - 'tp6_youtube', 12:20:43 INFO - 'tp6_amazon', 12:20:43 INFO - 'tp6_facebook']}, 12:20:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:20:43 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:20:43 INFO - 'talos_options': ['--disable-stylo', 12:20:43 INFO - '--mitmproxy', 12:20:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:20:43 INFO - '--firstNonBlankPaint'], 12:20:43 INFO - 'tests': ['tp6_google', 12:20:43 INFO - 'tp6_youtube', 12:20:43 INFO - 'tp6_amazon', 12:20:43 INFO - 'tp6_facebook']}, 12:20:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:20:43 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:20:43 INFO - 'talos_options': ['--stylo-threads=1', 12:20:43 INFO - '--mitmproxy', 12:20:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:20:43 INFO - '--firstNonBlankPaint'], 12:20:43 INFO - 'tests': ['tp6_google', 12:20:43 INFO - 'tp6_youtube', 12:20:43 INFO - 'tp6_amazon', 12:20:43 INFO - 'tp6_facebook']}, 12:20:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:20:43 INFO - 'talos_options': ['--xperf_path', 12:20:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:20:43 INFO - 'tests': ['tp5n']}, 12:20:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:20:43 INFO - 'talos_options': ['--disable-stylo', 12:20:43 INFO - '--xperf_path', 12:20:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:20:43 INFO - 'tests': ['tp5n']}}} 12:20:43 INFO - Running post-action listener: _resource_record_post_action 12:20:43 INFO - [mozharness: 2017-10-03 19:20:43.821816Z] Finished populate-webroot step (success) 12:20:43 INFO - [mozharness: 2017-10-03 19:20:43.821904Z] Running create-virtualenv step. 12:20:43 INFO - Running pre-action listener: _resource_record_pre_action 12:20:43 INFO - Running main action method: create_virtualenv 12:20:43 INFO - Creating virtualenv /builds/slave/test/build/venv 12:20:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:20:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:20:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:20:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:20:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:20:44 INFO - Installing distribute.............................................................................................................................................................................................done. 12:20:44 INFO - Installing pip...............done. 12:20:44 INFO - Return code: 0 12:20:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:20:44 INFO - Reading from file tmpfile_stdout 12:20:44 INFO - Output received: 12:20:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:20:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:20: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')]} 12:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20: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')]} 12:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:44 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 0x26ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2892b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34d60>, '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 0x2a35a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a35ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', '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 12:20:44 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 12:20:44 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 12:20:44 INFO - Using env: {'DISPLAY': ':0', 12:20:44 INFO - 'HOME': '/home/cltbld', 12:20:44 INFO - 'LANG': 'en_US.UTF-8', 12:20:44 INFO - 'LANGUAGE': 'en_US:en', 12:20:44 INFO - 'LOGNAME': 'cltbld', 12:20:44 INFO - 'MAIL': '/var/mail/cltbld', 12:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:44 INFO - 'MOZ_NO_REMOTE': '1', 12:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:44 INFO - 'NO_EM_RESTART': '1', 12:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:44 INFO - 'PWD': '/builds/slave/test', 12:20:44 INFO - 'SHELL': '/bin/bash', 12:20:44 INFO - 'SHLVL': '1', 12:20:44 INFO - 'TERM': 'linux', 12:20:44 INFO - 'TMOUT': '86400', 12:20:44 INFO - 'USER': 'cltbld', 12:20:44 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', 12:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:44 INFO - '_': '/tools/buildbot/bin/python'} 12:20:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:20:46 INFO - Downloading/unpacking pip>=1.5 12:20:46 INFO - Running setup.py egg_info for package pip 12:20:46 INFO - warning: no files found matching 'pip/cacert.pem' 12:20:46 INFO - warning: no files found matching '*.html' under directory 'docs' 12:20:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:20:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:20:46 INFO - Installing collected packages: pip 12:20:46 INFO - Found existing installation: pip 1.1 12:20:46 INFO - Uninstalling pip: 12:20:46 INFO - Successfully uninstalled pip 12:20:46 INFO - Running setup.py install for pip 12:20:46 INFO - warning: no files found matching 'pip/cacert.pem' 12:20:46 INFO - warning: no files found matching '*.html' under directory 'docs' 12:20:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:20:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:20:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:20:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:20:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:20:46 INFO - Successfully installed pip 12:20:46 INFO - Cleaning up... 12:20:46 INFO - Return code: 0 12:20:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:20:46 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:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:46 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:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:46 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 0x26ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2892b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34d60>, '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 0x2a35a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a35ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', '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 12:20:46 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 12:20:46 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 12:20:46 INFO - Using env: {'DISPLAY': ':0', 12:20:46 INFO - 'HOME': '/home/cltbld', 12:20:46 INFO - 'LANG': 'en_US.UTF-8', 12:20:46 INFO - 'LANGUAGE': 'en_US:en', 12:20:46 INFO - 'LOGNAME': 'cltbld', 12:20:46 INFO - 'MAIL': '/var/mail/cltbld', 12:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:46 INFO - 'MOZ_NO_REMOTE': '1', 12:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:46 INFO - 'NO_EM_RESTART': '1', 12:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:46 INFO - 'PWD': '/builds/slave/test', 12:20:46 INFO - 'SHELL': '/bin/bash', 12:20:46 INFO - 'SHLVL': '1', 12:20:46 INFO - 'TERM': 'linux', 12:20:46 INFO - 'TMOUT': '86400', 12:20:46 INFO - 'USER': 'cltbld', 12:20:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', 12:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:46 INFO - '_': '/tools/buildbot/bin/python'} 12:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:46 INFO - Downloading/unpacking psutil>=3.1.1 12:20:46 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 12:20:46 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 12:20:46 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 12:20:46 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 12:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:20:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:20:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:20:47 INFO - Installing collected packages: psutil 12:20:47 INFO - Running setup.py install for psutil 12:20:47 INFO - building 'psutil._psutil_linux' extension 12:20:47 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 12:20:47 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 12:20:47 INFO - building 'psutil._psutil_posix' extension 12:20:47 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 12:20:47 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 12:20:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:20:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:20:47 INFO - Successfully installed psutil 12:20:47 INFO - Cleaning up... 12:20:48 INFO - Return code: 0 12:20:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:20:48 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:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:48 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:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:48 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 0x26ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2892b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34d60>, '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 0x2a35a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a35ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', '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 12:20:48 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 12:20:48 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 12:20:48 INFO - Using env: {'DISPLAY': ':0', 12:20:48 INFO - 'HOME': '/home/cltbld', 12:20:48 INFO - 'LANG': 'en_US.UTF-8', 12:20:48 INFO - 'LANGUAGE': 'en_US:en', 12:20:48 INFO - 'LOGNAME': 'cltbld', 12:20:48 INFO - 'MAIL': '/var/mail/cltbld', 12:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:48 INFO - 'MOZ_NO_REMOTE': '1', 12:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:48 INFO - 'NO_EM_RESTART': '1', 12:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:48 INFO - 'PWD': '/builds/slave/test', 12:20:48 INFO - 'SHELL': '/bin/bash', 12:20:48 INFO - 'SHLVL': '1', 12:20:48 INFO - 'TERM': 'linux', 12:20:48 INFO - 'TMOUT': '86400', 12:20:48 INFO - 'USER': 'cltbld', 12:20:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', 12:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:48 INFO - '_': '/tools/buildbot/bin/python'} 12:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:20: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 12:20: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 12:20: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 12:20: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 12:20:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:20:49 INFO - Installing collected packages: mozsystemmonitor 12:20:49 INFO - Running setup.py install for mozsystemmonitor 12:20:49 INFO - Successfully installed mozsystemmonitor 12:20:49 INFO - Cleaning up... 12:20:49 INFO - Return code: 0 12:20:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:20:49 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:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:49 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:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:49 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 0x26ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2892b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34d60>, '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 0x2a35a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a35ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', '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 12:20:49 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 12:20:49 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 12:20:49 INFO - Using env: {'DISPLAY': ':0', 12:20:49 INFO - 'HOME': '/home/cltbld', 12:20:49 INFO - 'LANG': 'en_US.UTF-8', 12:20:49 INFO - 'LANGUAGE': 'en_US:en', 12:20:49 INFO - 'LOGNAME': 'cltbld', 12:20:49 INFO - 'MAIL': '/var/mail/cltbld', 12:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:49 INFO - 'MOZ_NO_REMOTE': '1', 12:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:49 INFO - 'NO_EM_RESTART': '1', 12:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:49 INFO - 'PWD': '/builds/slave/test', 12:20:49 INFO - 'SHELL': '/bin/bash', 12:20:49 INFO - 'SHLVL': '1', 12:20:49 INFO - 'TERM': 'linux', 12:20:49 INFO - 'TMOUT': '86400', 12:20:49 INFO - 'USER': 'cltbld', 12:20:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', 12:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:49 INFO - '_': '/tools/buildbot/bin/python'} 12:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:50 INFO - Downloading/unpacking jsonschema==2.5.1 12:20: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 12:20: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 12:20: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 12:20: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 12:20:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:20:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:20:51 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 12:20:51 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 12:20:51 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 12:20:51 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 12:20:51 INFO - Downloading functools32-3.2.3-2.tar.gz 12:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:20:51 INFO - warning: no files found matching '*.txt' 12:20:51 INFO - no previously-included directories found matching 'build' 12:20:51 INFO - no previously-included directories found matching 'dist' 12:20:51 INFO - no previously-included directories found matching '.git*' 12:20:51 INFO - Installing collected packages: jsonschema, functools32 12:20:51 INFO - Running setup.py install for functools32 12:20:51 INFO - warning: no files found matching '*.txt' 12:20:51 INFO - no previously-included directories found matching 'build' 12:20:51 INFO - no previously-included directories found matching 'dist' 12:20:51 INFO - no previously-included directories found matching '.git*' 12:20:51 INFO - Successfully installed jsonschema functools32 12:20:51 INFO - Cleaning up... 12:20:51 INFO - Return code: 0 12:20:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:20:51 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:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:51 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:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:51 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 0x26ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2892b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34d60>, '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 0x2a35a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a35ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', '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 12:20:51 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 12:20:51 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 12:20:51 INFO - Using env: {'DISPLAY': ':0', 12:20:51 INFO - 'HOME': '/home/cltbld', 12:20:51 INFO - 'LANG': 'en_US.UTF-8', 12:20:51 INFO - 'LANGUAGE': 'en_US:en', 12:20:51 INFO - 'LOGNAME': 'cltbld', 12:20:51 INFO - 'MAIL': '/var/mail/cltbld', 12:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:51 INFO - 'MOZ_NO_REMOTE': '1', 12:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:51 INFO - 'NO_EM_RESTART': '1', 12:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:51 INFO - 'PWD': '/builds/slave/test', 12:20:51 INFO - 'SHELL': '/bin/bash', 12:20:51 INFO - 'SHLVL': '1', 12:20:51 INFO - 'TERM': 'linux', 12:20:51 INFO - 'TMOUT': '86400', 12:20:51 INFO - 'USER': 'cltbld', 12:20:51 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', 12:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:51 INFO - '_': '/tools/buildbot/bin/python'} 12:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:20:51 INFO - Cleaning up... 12:20:51 INFO - Return code: 0 12:20:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:20:51 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:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:51 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:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:51 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 0x26ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2892b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34d60>, '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 0x2a35a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a35ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', '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 12:20:51 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 12:20:51 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 12:20:51 INFO - Using env: {'DISPLAY': ':0', 12:20:51 INFO - 'HOME': '/home/cltbld', 12:20:51 INFO - 'LANG': 'en_US.UTF-8', 12:20:51 INFO - 'LANGUAGE': 'en_US:en', 12:20:51 INFO - 'LOGNAME': 'cltbld', 12:20:51 INFO - 'MAIL': '/var/mail/cltbld', 12:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:51 INFO - 'MOZ_NO_REMOTE': '1', 12:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:51 INFO - 'NO_EM_RESTART': '1', 12:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:51 INFO - 'PWD': '/builds/slave/test', 12:20:51 INFO - 'SHELL': '/bin/bash', 12:20:51 INFO - 'SHLVL': '1', 12:20:51 INFO - 'TERM': 'linux', 12:20:51 INFO - 'TMOUT': '86400', 12:20:51 INFO - 'USER': 'cltbld', 12:20:51 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', 12:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:51 INFO - '_': '/tools/buildbot/bin/python'} 12:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:52 INFO - Downloading/unpacking blobuploader==1.2.4 12:20:52 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 12:20:52 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 12:20:52 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 12:20:52 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 12:20:53 INFO - Downloading blobuploader-1.2.4.tar.gz 12:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:20:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:20:53 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 12:20:53 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 12:20:53 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 12:20:53 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 12:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:20:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:20:53 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 12:20:53 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 12:20:53 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 12:20:53 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 12:20:53 INFO - Downloading docopt-0.6.1.tar.gz 12:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:20:53 INFO - Installing collected packages: blobuploader, requests, docopt 12:20:53 INFO - Running setup.py install for blobuploader 12:20:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:20:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:20:54 INFO - Running setup.py install for requests 12:20:54 INFO - Running setup.py install for docopt 12:20:54 INFO - Successfully installed blobuploader requests docopt 12:20:54 INFO - Cleaning up... 12:20:54 INFO - Return code: 0 12:20:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20:54 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:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:54 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:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:54 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 0x26ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2892b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34d60>, '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 0x2a35a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a35ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', '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 12:20:54 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 12:20:54 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 12:20:54 INFO - Using env: {'DISPLAY': ':0', 12:20:54 INFO - 'HOME': '/home/cltbld', 12:20:54 INFO - 'LANG': 'en_US.UTF-8', 12:20:54 INFO - 'LANGUAGE': 'en_US:en', 12:20:54 INFO - 'LOGNAME': 'cltbld', 12:20:54 INFO - 'MAIL': '/var/mail/cltbld', 12:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:54 INFO - 'MOZ_NO_REMOTE': '1', 12:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:54 INFO - 'NO_EM_RESTART': '1', 12:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:54 INFO - 'PWD': '/builds/slave/test', 12:20:54 INFO - 'SHELL': '/bin/bash', 12:20:54 INFO - 'SHLVL': '1', 12:20:54 INFO - 'TERM': 'linux', 12:20:54 INFO - 'TMOUT': '86400', 12:20:54 INFO - 'USER': 'cltbld', 12:20:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', 12:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:54 INFO - '_': '/tools/buildbot/bin/python'} 12:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:20:54 INFO - Running setup.py (path:/tmp/pip-91sDd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:20:54 INFO - Running setup.py (path:/tmp/pip-G8Ciw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:20:54 INFO - Running setup.py (path:/tmp/pip-sZ790B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:20:54 INFO - Running setup.py (path:/tmp/pip-RB89bS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:20:55 INFO - Running setup.py (path:/tmp/pip-MO8mLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:20:55 INFO - Running setup.py (path:/tmp/pip-N6cujD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:20:55 INFO - Running setup.py (path:/tmp/pip-cO7tkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:20:55 INFO - Running setup.py (path:/tmp/pip-cMM4zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:20:55 INFO - Running setup.py (path:/tmp/pip-LOI7Cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:20:55 INFO - Running setup.py (path:/tmp/pip-NXeY2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:20:55 INFO - Running setup.py (path:/tmp/pip-_HeMRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:20:55 INFO - Running setup.py (path:/tmp/pip-6X4_rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:20:55 INFO - Running setup.py (path:/tmp/pip-2xqfAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:20:55 INFO - Running setup.py (path:/tmp/pip-qUoVJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:55 INFO - Running setup.py (path:/tmp/pip-1CpVC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:20:55 INFO - Running setup.py (path:/tmp/pip-gc6U5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:20:55 INFO - Running setup.py (path:/tmp/pip-kqUl9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:20:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:20:55 INFO - Running setup.py install for manifestparser 12:20:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:20:56 INFO - Running setup.py install for mozcrash 12:20:56 INFO - Running setup.py install for mozdebug 12:20:56 INFO - Running setup.py install for mozdevice 12:20:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:20:56 INFO - Running setup.py install for mozfile 12:20:56 INFO - Running setup.py install for mozhttpd 12:20:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:20:56 INFO - Running setup.py install for mozinfo 12:20:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:20:56 INFO - Running setup.py install for mozInstall 12:20:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:20:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:20:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:20:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:20:56 INFO - Running setup.py install for mozleak 12:20:56 INFO - Running setup.py install for mozlog 12:20:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:20:56 INFO - Running setup.py install for moznetwork 12:20:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:20:57 INFO - Running setup.py install for mozprocess 12:20:57 INFO - Running setup.py install for mozprofile 12:20:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:20:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:20:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:20:57 INFO - Running setup.py install for mozrunner 12:20:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:20:57 INFO - Running setup.py install for mozscreenshot 12:20:57 INFO - Running setup.py install for moztest 12:20:57 INFO - Running setup.py install for mozversion 12:20:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:20:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:20:57 INFO - Cleaning up... 12:20:57 INFO - Return code: 0 12:20:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:57 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 0x26ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2892b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34d60>, '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 0x2a35a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a35ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', '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 12:20:57 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 12:20:57 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 12:20:57 INFO - Using env: {'DISPLAY': ':0', 12:20:57 INFO - 'HOME': '/home/cltbld', 12:20:57 INFO - 'LANG': 'en_US.UTF-8', 12:20:57 INFO - 'LANGUAGE': 'en_US:en', 12:20:57 INFO - 'LOGNAME': 'cltbld', 12:20:57 INFO - 'MAIL': '/var/mail/cltbld', 12:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:57 INFO - 'MOZ_NO_REMOTE': '1', 12:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:57 INFO - 'NO_EM_RESTART': '1', 12:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:57 INFO - 'PWD': '/builds/slave/test', 12:20:57 INFO - 'SHELL': '/bin/bash', 12:20:57 INFO - 'SHLVL': '1', 12:20:57 INFO - 'TERM': 'linux', 12:20:57 INFO - 'TMOUT': '86400', 12:20:57 INFO - 'USER': 'cltbld', 12:20:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', 12:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:57 INFO - '_': '/tools/buildbot/bin/python'} 12:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:20:57 INFO - Running setup.py (path:/tmp/pip-frslqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:20:58 INFO - Running setup.py (path:/tmp/pip-JrH5lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:20:58 INFO - Running setup.py (path:/tmp/pip-wKlc6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:20:58 INFO - Running setup.py (path:/tmp/pip-CtWncI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:20:58 INFO - Running setup.py (path:/tmp/pip-zkNJt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:20:58 INFO - Running setup.py (path:/tmp/pip-p82ann-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:20:58 INFO - Running setup.py (path:/tmp/pip-3iBQcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:20:58 INFO - Running setup.py (path:/tmp/pip-EeJ9jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:20:58 INFO - Running setup.py (path:/tmp/pip-QW3f_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:20:58 INFO - Running setup.py (path:/tmp/pip-g25ZKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:20:58 INFO - Running setup.py (path:/tmp/pip-VFugLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:20:58 INFO - Running setup.py (path:/tmp/pip-iWduZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:20:58 INFO - Running setup.py (path:/tmp/pip-OyPbEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:20:58 INFO - Running setup.py (path:/tmp/pip-nJk8sT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:20:58 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)) 12:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:58 INFO - Running setup.py (path:/tmp/pip-AOjhcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:59 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)) 12:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:20:59 INFO - Running setup.py (path:/tmp/pip-O0pGHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:20:59 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)) 12:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:20:59 INFO - Running setup.py (path:/tmp/pip-RbKkqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:20:59 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)) 12:20:59 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)) 12:20:59 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)) 12:20:59 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)) 12:20:59 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)) 12:20:59 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)) 12:20:59 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)) 12:20:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:00 INFO - Downloading blessings-1.6.tar.gz 12:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:21:00 INFO - Installing collected packages: blessings 12:21:00 INFO - Running setup.py install for blessings 12:21:00 INFO - Successfully installed blessings 12:21:00 INFO - Cleaning up... 12:21:00 INFO - Return code: 0 12:21:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:21:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:00 INFO - Reading from file tmpfile_stdout 12:21:00 INFO - Current package versions: 12:21:00 INFO - argparse == 1.2.1 12:21:00 INFO - blessings == 1.6 12:21:00 INFO - blobuploader == 1.2.4 12:21:00 INFO - docopt == 0.6.1 12:21:00 INFO - functools32 == 3.2.3-2 12:21:00 INFO - jsonschema == 2.5.1 12:21:00 INFO - manifestparser == 1.1 12:21:00 INFO - mozInstall == 1.13 12:21:00 INFO - mozcrash == 1.0 12:21:00 INFO - mozdebug == 0.1 12:21:00 INFO - mozdevice == 0.51 12:21:00 INFO - mozfile == 1.2 12:21:00 INFO - mozhttpd == 0.7 12:21:00 INFO - mozinfo == 0.10 12:21:00 INFO - mozleak == 0.1 12:21:00 INFO - mozlog == 3.5 12:21:00 INFO - moznetwork == 0.27 12:21:00 INFO - mozprocess == 0.25 12:21:00 INFO - mozprofile == 0.28 12:21:00 INFO - mozrunner == 6.13 12:21:00 INFO - mozscreenshot == 0.1 12:21:00 INFO - mozsystemmonitor == 0.3 12:21:00 INFO - moztest == 0.8 12:21:00 INFO - mozversion == 1.4 12:21:00 INFO - psutil == 3.1.1 12:21:00 INFO - requests == 1.2.3 12:21:00 INFO - wsgiref == 0.1.2 12:21:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:00 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 0x26ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2892b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34d60>, '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 0x2a35a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a35ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', '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 12:21:00 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 12:21:00 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 12:21:00 INFO - Using env: {'DISPLAY': ':0', 12:21:00 INFO - 'HOME': '/home/cltbld', 12:21:00 INFO - 'LANG': 'en_US.UTF-8', 12:21:00 INFO - 'LANGUAGE': 'en_US:en', 12:21:00 INFO - 'LOGNAME': 'cltbld', 12:21:00 INFO - 'MAIL': '/var/mail/cltbld', 12:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:00 INFO - 'MOZ_NO_REMOTE': '1', 12:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:00 INFO - 'NO_EM_RESTART': '1', 12:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:00 INFO - 'PWD': '/builds/slave/test', 12:21:00 INFO - 'SHELL': '/bin/bash', 12:21:00 INFO - 'SHLVL': '1', 12:21:00 INFO - 'TERM': 'linux', 12:21:00 INFO - 'TMOUT': '86400', 12:21:00 INFO - 'USER': 'cltbld', 12:21:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', 12:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:00 INFO - '_': '/tools/buildbot/bin/python'} 12:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:01 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)) 12:21:01 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)) 12:21:01 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)) 12:21:01 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)) 12:21:01 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)) 12:21:01 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)) 12:21:01 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)) 12:21:01 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)) 12:21:01 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)) 12:21:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:21:02 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)) 12:21:02 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)) 12:21:02 INFO - Installing collected packages: simplejson 12:21:02 INFO - Running setup.py install for simplejson 12:21:02 INFO - building 'simplejson._speedups' extension 12:21:02 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 12:21:03 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 12:21:03 INFO - Successfully installed simplejson 12:21:03 INFO - Cleaning up... 12:21:03 INFO - Return code: 0 12:21:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:03 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 0x26ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2892b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34d60>, '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 0x2a35a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a35ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', '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 12:21:03 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 12:21:03 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 12:21:03 INFO - Using env: {'DISPLAY': ':0', 12:21:03 INFO - 'HOME': '/home/cltbld', 12:21:03 INFO - 'LANG': 'en_US.UTF-8', 12:21:03 INFO - 'LANGUAGE': 'en_US:en', 12:21:03 INFO - 'LOGNAME': 'cltbld', 12:21:03 INFO - 'MAIL': '/var/mail/cltbld', 12:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:03 INFO - 'MOZ_NO_REMOTE': '1', 12:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:03 INFO - 'NO_EM_RESTART': '1', 12:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:03 INFO - 'PWD': '/builds/slave/test', 12:21:03 INFO - 'SHELL': '/bin/bash', 12:21:03 INFO - 'SHLVL': '1', 12:21:03 INFO - 'TERM': 'linux', 12:21:03 INFO - 'TMOUT': '86400', 12:21:03 INFO - 'USER': 'cltbld', 12:21:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', 12:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:03 INFO - '_': '/tools/buildbot/bin/python'} 12:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:21:03 INFO - Cleaning up... 12:21:03 INFO - Return code: 0 12:21:03 INFO - Running post-action listener: _resource_record_post_action 12:21:03 INFO - Running post-action listener: _start_resource_monitoring 12:21:03 INFO - Starting resource monitoring. 12:21:03 INFO - [mozharness: 2017-10-03 19:21:03.559595Z] Finished create-virtualenv step (success) 12:21:03 INFO - [mozharness: 2017-10-03 19:21:03.560109Z] Running install step. 12:21:03 INFO - Running pre-action listener: _resource_record_pre_action 12:21:03 INFO - Running main action method: install 12:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:03 INFO - Reading from file tmpfile_stdout 12:21:03 INFO - Detecting whether we're running mozinstall >=1.0... 12:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:21:03 INFO - Reading from file tmpfile_stdout 12:21:03 INFO - Output received: 12:21:03 INFO - Usage: mozinstall [options] installer 12:21:03 INFO - Options: 12:21:03 INFO - -h, --help show this help message and exit 12:21:03 INFO - -d DEST, --destination=DEST 12:21:03 INFO - Directory to install application into. [default: 12:21:03 INFO - "/builds/slave/test"] 12:21:03 INFO - --app=APP Application being installed. [default: firefox] 12:21:03 INFO - mkdir: /builds/slave/test/build/application 12:21:03 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'] 12:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:21:21 INFO - Reading from file tmpfile_stdout 12:21:21 INFO - Output received: 12:21:21 INFO - /builds/slave/test/build/application/firefox/firefox 12:21:21 INFO - Running post-action listener: _resource_record_post_action 12:21:21 INFO - [mozharness: 2017-10-03 19:21:21.508621Z] Finished install step (success) 12:21:21 INFO - [mozharness: 2017-10-03 19:21:21.508741Z] Running setup-mitmproxy step. 12:21:21 INFO - Running pre-action listener: _resource_record_pre_action 12:21:21 INFO - Running main action method: setup_mitmproxy 12:21:21 INFO - Skipping: mitmproxy is not required 12:21:21 INFO - Running post-action listener: _resource_record_post_action 12:21:21 INFO - [mozharness: 2017-10-03 19:21:21.509277Z] Finished setup-mitmproxy step (success) 12:21:21 INFO - [mozharness: 2017-10-03 19:21:21.509400Z] Running run-tests step. 12:21:21 INFO - Running pre-action listener: _resource_record_pre_action 12:21:21 INFO - Running pre-action listener: _set_gcov_prefix 12:21:21 INFO - Running main action method: run_tests 12:21:21 WARNING - Try message not found. 12:21:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:21:21 INFO - Python 2.7.3 12:21:21 INFO - Return code: 0 12:21:21 INFO - grabbing minidump binary from tooltool 12:21:21 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:21:21 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 0x2a34d60>, '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 0x2a35a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a35ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:21:21 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:21:21 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:21:21 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:21:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:21:21 INFO - Return code: 0 12:21:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:21:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:21:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:21:21 INFO - ENV: RUST_BACKTRACE is now full 12:21:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:21:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:21:21 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/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:21:21 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/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --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:21:21 INFO - Using env: {'DISPLAY': ':0', 12:21:21 INFO - 'HOME': '/home/cltbld', 12:21:21 INFO - 'LANG': 'en_US.UTF-8', 12:21:21 INFO - 'LANGUAGE': 'en_US:en', 12:21:21 INFO - 'LOGNAME': 'cltbld', 12:21:21 INFO - 'MAIL': '/var/mail/cltbld', 12:21:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:21:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:21 INFO - 'MOZ_NO_REMOTE': '1', 12:21:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:21 INFO - 'NO_EM_RESTART': '1', 12:21:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:21 INFO - 'PWD': '/builds/slave/test', 12:21:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:21:21 INFO - 'RUST_BACKTRACE': 'full', 12:21:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:21:21 INFO - 'SHELL': '/bin/bash', 12:21:21 INFO - 'SHLVL': '1', 12:21:21 INFO - 'TERM': 'linux', 12:21:21 INFO - 'TMOUT': '86400', 12:21:21 INFO - 'USER': 'cltbld', 12:21:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', 12:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:21 INFO - '_': '/tools/buildbot/bin/python'} 12:21:21 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/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:21:21 INFO - mozversion application_buildid: 20171003175736 12:21:21 INFO - mozversion application_changeset: 9be05b2177667ed8221f9da4fdcc200dbdf3de62 12:21:21 INFO - mozversion application_display_name: Nightly 12:21:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:21:21 INFO - mozversion application_name: Firefox 12:21:21 INFO - mozversion application_remotingname: firefox 12:21:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:21:21 INFO - mozversion application_vendor: Mozilla 12:21:21 INFO - mozversion application_version: 58.0a1 12:21:21 INFO - mozversion platform_buildid: 20171003175736 12:21:21 INFO - mozversion platform_changeset: 9be05b2177667ed8221f9da4fdcc200dbdf3de62 12:21:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:21:21 INFO - mozversion platform_version: 58.0a1 12:21:21 INFO - using testdate: 1507058481 12:21:21 INFO - actual date: 1507058481 12:21:21 INFO - starting webserver on 'localhost:60147' 12:21:21 INFO - SUITE-START | Running 2 tests 12:21:21 INFO - TEST-START | dromaeo_css 12:21:21 INFO - Initialising browser for dromaeo_css test... 12:21:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60147/getInfo.html -profile /tmp/tmpYxP073/profile 12:21:21 INFO - TEST-INFO | started process 16342 (/builds/slave/test/build/application/firefox/firefox http://localhost:60147/getInfo.html) 12:21:26 INFO - TEST-INFO | 16342: exit 0 12:21:26 INFO - Browser initialized. 12:21:26 INFO - Running cycle 1/1 for dromaeo_css test... 12:21:26 INFO - Using env: {'DISPLAY': ':0', 12:21:26 INFO - 'HOME': '/home/cltbld', 12:21:26 INFO - 'JSGC_DISABLE_POISONING': '1', 12:21:26 INFO - 'LANG': 'en_US.UTF-8', 12:21:26 INFO - 'LANGUAGE': 'en_US:en', 12:21:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:21:26 INFO - 'LOGNAME': 'cltbld', 12:21:26 INFO - 'MAIL': '/var/mail/cltbld', 12:21:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:21:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:21:26 INFO - 'MOZ_CRASHREPORTER': '1', 12:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:21:26 INFO - 'MOZ_NO_REMOTE': '1', 12:21:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:26 INFO - 'NO_EM_RESTART': '1', 12:21:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:26 INFO - 'PWD': '/builds/slave/test', 12:21:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:21:26 INFO - 'RUST_BACKTRACE': 'full', 12:21:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:21:26 INFO - 'SHELL': '/bin/bash', 12:21:26 INFO - 'SHLVL': '1', 12:21:26 INFO - 'STYLO_FORCE_DISABLED': '1', 12:21:26 INFO - 'TERM': 'linux', 12:21:26 INFO - 'TMOUT': '86400', 12:21:26 INFO - 'USER': 'cltbld', 12:21:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', 12:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:26 INFO - '_': '/tools/buildbot/bin/python'} 12:21:26 INFO - TEST-INFO | started process 16614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYxP073/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:21:27 INFO - PID 16614 | 12:21:27 INFO - PID 16614 | (/builds/slave/test/build/application/firefox/firefox:16662): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:21:27 INFO - PID 16614 | 12:21:37 INFO - PID 16614 | RSS: Main: 148008960 12:21:37 INFO - PID 16614 | 12:24:34 INFO - PID 16614 | Cycle 1(1): loaded http://localhost:60147/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60147/tests/dromaeo/cssquery-ext.html) 12:24:36 INFO - PID 16614 | RSS: Main: 144248832 12:24:36 INFO - PID 16614 | 12:27:38 INFO - PID 16614 | Cycle 1(1): loaded http://localhost:60147/tests/dromaeo/cssquery-ext.html (next: http://localhost:60147/tests/dromaeo/cssquery-jquery.html) 12:27:38 INFO - PID 16614 | RSS: Main: 143900672 12:27:38 INFO - PID 16614 | 12:30:40 INFO - PID 16614 | Cycle 1(1): loaded http://localhost:60147/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60147/tests/dromaeo/cssquery-mootools.html) 12:30:40 INFO - PID 16614 | RSS: Main: 147013632 12:30:40 INFO - PID 16614 | 12:33:42 INFO - PID 16614 | Cycle 1(1): loaded http://localhost:60147/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60147/tests/dromaeo/cssquery-prototype.html) 12:33:42 INFO - PID 16614 | RSS: Main: 146444288 12:33:42 INFO - PID 16614 | 12:36:46 INFO - PID 16614 | Cycle 1(1): loaded http://localhost:60147/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60147/tests/dromaeo/cssquery-yui.html) 12:36:46 INFO - PID 16614 | RSS: Main: 149643264 12:36:46 INFO - PID 16614 | 12:39:47 INFO - PID 16614 | Cycle 1(1): loaded http://localhost:60147/tests/dromaeo/cssquery-yui.html (next: http://localhost:60147/tests/dromaeo/cssquery-dojo.html) 12:39:48 INFO - PID 16614 | RSS: Main: 150605824 12:39:48 INFO - PID 16614 | 12:39:48 INFO - PID 16614 | __start_tp_report 12:39:48 INFO - PID 16614 | _x_x_mozilla_page_load 12:39:48 INFO - PID 16614 | _x_x_mozilla_page_load_details 12:39:48 INFO - PID 16614 | |i|pagename|runs| 12:39:48 INFO - PID 16614 | |0;dojo.html;3844.8846534603963;3854.939891529829;3872.612738726127;3883.281592905311;3888.8444462221532;6264.84337891553;6363.872722545546;6381.649009304487;6412.198475190601;6412.519061070421;6389.616623002611;6400.391962763541;6423.6788160591905;6432.292447830735;6437.710303036363;5689.772409103631;5709;5732.742026608813;5739.167820666001;5749.885002299962;5766.0486019806685;5768.913466298009;5773.134029895507;5788.884222315552;5835.649861008353;5820.534357251409;5883.323417806964;5894.528437724972;5909.231799866011;5920.526357891358;5638.40796716343;5745.339285982123;5828.2131912191735;5856.1941655466935;5939.07944268639;5554.638948468337;5689.800856970028;5698.40166782486;5709.4290570942985;5718.170865224519;6382.585131966407;6394.392532709385;6453.967730161319;6469.191351081115;6481.967590162066;6817.659117044128;6862.656867156672;6871.4502839773195;6904.689288982008;7015.088038555006;6971.965140174267;6978.197507286676;6990.965045174741;6993.125859267591;6998.75504357345;6335.176427064452;6491.415772580443;6501.577397469149;6533.869322613568;6544.9672751635935;7106.751263705849;7117.288271172944;7164.391026762783;7184.676689548983;7260;6820.897686534706;6821.522493425413;6908.516403851782;6913.585184888922;6915.723371065202;6935.098437203233;6942.930570694229;6955.826104347432;7040.577565345993;7049.259827718119;6873.553219040747;6884.793456196322;6902.171739391305;6913.446924246048;6945.79162625112;6963.1644202696;6995.125609298838;6996.790096297119;7006.4745144114395;7006.649667516604;4976.8755781105765;4983.127952608279;4993.625478089158;5070.340855688737;5071.771770270347;4517.435320584927;4533.727976321431;4552.430946131733;4564.2240819060835;4585.358049873021;6426;6467.482601391877;6478.967605161944;6479.1901012373455;6480.092787009822;6889.655517224119;6915.619640919797;6926.307369263033;7013.982972468963;7022.297770222936;6351.96824015877;6383.96808015957;6466.030095485715;6478.319776423502;6495.058216558573;5648.293963254593;5666.829995100154;5674.205611214434;5680.091185410397;5680.602357834912;7222.169450513258;7240.565566065948;7241.927580724126;7335.083114610674;7338.22948590401;6796.35434633709;6888;6955.408790252885;7008.509404341749;7054.435645148478;7170.856582868209;7190.388816950618;7193.244709305657;7197.100362454693;7199.424046076406;6832.555883867532;6838.111045564045;6931.029655848084;6933.341332573397;6953.721851126101;6951.478639101986;6966;7040.929590704028;7041.753538626328;7043.2604576518725;6611.438027767694;6690.665466726547;6698.631575263213;6703.631300278336;6705.6647167642395;6681.565698229794;6699.9665001674675;6706.497012723968;6710.563813352116;6712.966435167793;6517.4134327910715;6587.769428069994;6596.109525214035;6602.570832895846;6611.471082313307;6827.385535301847;6830.7609233676585;6855.348741869514;6860.5197636164985;6860.759873404607;6531.934680653323;6539.738410463528;6555.147830782159;6644.46844252449;6657.367550082734 12:39:48 INFO - PID 16614 | |1;ext.html;986.4278718343362;1008.6116845014667;1014.695591322603;1015.6597539824159;1016.151513486239;41378.58621413785;46008.53991460084;46233.53766462334;46325.30512042322;46328;43065.56934430655;43248.567514324845;43300.566994330045;43356.56643433565;43358.566414335844;7736.729214477495;7882.093559240675;8475.74572762818;8637.740867773977;8674.436161649473;8570.871436928452;8637.52493612851;8690.652373905068;8698.347623928199;8703.173198546128;8590.699325523608;8683.175098365677;8684.30525557957;8694.521801300925;8716.08481109484;8657.69698060568;8694;8697.608382658807;8702.086280940537;8708.17272359125;8539.402241843012;8546.188112129337;8561.657533698644;8562.100979397135;8599.82800343996;40085.198296033916;40479;40513.392299115534;40669;40786;3783.0920579060826;3820.36963900956;3820.6752426043818;3826.9808650956847;3827.8660246891227;33289.500657490156;33323.500147497805;33446.832765836014;33557;33645.32709345799;5353.705546194958;5463.371712253102;5512.448755124496;5529.30883639545;5613.522850557667;218713;219271;219452;219634;220487;54174.45825541773;54361.72819135879;57014;57016.14475782867;57720.134197986226;59855.40144598585;60012;60243.69878150581;60244;60268.397316027156;17357.826421735874;17455.65088698219;17472.82527174712;17667.823321766617;17688.469345919642;14372.928135359256;14467.421303147967;14470.638234044023;14471.348789304506;14478.058926169766;15291.388344466319;15367.923160384351;15428;15456.459023934109;15556.844431555766;5981.910271345933;6057.787977420858;6117.541184411187;6139.84650383744;6142.170806941095;1135.2280449294558;1135.882003899285;1138.2291780671915;1158.808796548577;1159.8086315757805;26585.601215981776;27016.189514314603;27129.050483232993;27140;27450.725492744816;1214.3503225774168;1218.7684339975376;1228.42264135856;1241.1825156893801;1247.2828123828654;14040.929795350958;14156;14275.571732848031;14325.212113333866;14373.496927607484;293625;294109;295328;295755;296332;62012.37987620066;62418;62447;62546.68726656338;62593.68703156546;1518.4305885293015;1533.233383308368;1573.1662219023935;1575.141547856421;1585.738353171737;29284.853575731984;32183.51724724084;32231.677683222868;32702.672973269964;33089;58815.41184588271;59452;59485.40514594799;59551.702241488514;59655.403445966724;232386;233493;234222;234757;234873;38790.80604596959;39108.608913910495;39435.21129577335;39441.60558394494;39605.20789584135;48125.51874481211;49744.25383619176;49812.75093624509;50039;50694.49305507045;31491.212719682193;31527.21181970469;31659.52510712387;31685.841570792;34744.82627586846;35940;36226.63773362338;36443.63556364403;36921.261574767814;36944.07639809026;39494.60505394909;41977.790111049246;42409.78795106005;42597;43384.783076084415;34956.30087398289;35314.64685353216;35319.47020794639;35405.468917965736;35992.64007359893;26701.332466687712;26800.59799102976;26852.388856668662;26985.190444285916;27245.182644520697 12:39:48 INFO - PID 16614 | |2;jquery.html;625.2871726232094;627.9466245369143;634.3561285295423;641.8395401149712;652.5399593286734;23274.883625581868;23470.061197552077;24078.796060196986;24163.879180604094;24718.50562988739;26762.330941726468;27312.590311145348;27329;27344.726552734468;27350;6929.203141638713;6999.12510936133;7051.25961774014;7069.434445244368;7087.468439867031;6806.353396427331;6992.685329160175;7041.049458323112;7054.470914681394;7062.9646851765665;6965.79102626922;7013.684384202723;7022.227554968949;7025.297470252985;7030.367266945974;6566.573172743781;6799.150106236721;6800;6952.826179345506;6973.825654358656;6348.238211414659;6350.809475715736;6357;6359.713812878432;6383.521235907326;31675.524867127013;32207.51688724671;32268.677313227035;32406.351872962645;32417;2262.8642281463167;2283.0297123722517;2285.3829466044076;2291.942701432461;2295.4490922178725;19950.201991920305;21209.151633934624;21432.678509822366;21508.46228844276;21521.89239053795;2589;2611.7127116017223;2626.7110617832022;2638.2349118755537;2677.116551537988;138920;142598.28700856428;152292;159420;159452.20273898673;16587.83412165887;17112.229949652294;17138.314467421413;17182.33673780566;17438.389656361967;27314;27337.45325093527;27369.589456158174;27396.863015684794;27434.45131097367;11195.664130076111;11213.439328033566;11439.828402573969;11479.426028698532;11571.363575003288;10173.94913025445;10175.72803399575;10238;10263.23025773055;10376.118029967538;10000.449975251286;10400.271980961412;10410.739731506621;10532.684019479275;10686.358818470917;3083.9845800770854;3126.3278395145153;3151.527270909336;3159.3619327861034;3226.9677303227136;1026.7895081508273;1042.4579218806177;1061.193492945367;1073.983890241647;1077.5312738958578;21410.25064122748;21624.675629865564;21872.12511499554;22100.2264920727;22391.888040559694;1113.4822307626991;1114.9108071354271;1115.453427820362;1117.1565468071553;1134.8581427321585;11953;12125.333106679218;12161.939190303992;12174.513019479298;12311.938440307742;587054;588680;594553.0544694498;597706;618086;126888;130406;131814;132577.0113448299;133782.33108834393;1223.3455101520822;1229.6864299603544;1264.4562837979572;1266.771981043421;1268.0996492490435;18995.43013709591;19369.225230990603;19655.508612284808;19655.60688786245;19893.403197904085;61362.07956880561;61817;62646.37353626405;62974;63862.999999998145;75429.24570754441;76378.61810691134;76908;77217;78243;15985.44050958211;16121.596960076093;16197.67604647924;16297.26662300223;16357.509274721777;23859.522809543363;23919.52160956806;24244.515109697353;24249.39376515601;24547.140850070162;19690.21239150418;19866.60266794627;20123.195072197534;20153.6976945343;20159.294424695065;16851.578710532336;16985.745213821556;17171.141442928052;17280.654386912443;17306.740398893773;20482.795172048685;20762.688559671315;20769.27307544229;20890.582188356453;20898.1640734375;15815.68368632644;15981.121038343003;16148;16234.918825405797;16249.918750406172;19509.414717558495;19794.307199247956;19817;19959.401217963485;20110.798892011477 12:39:48 INFO - PID 16614 | |3;mootools.html;1399.5591388712555;1462.5685422800273;1469.2213127042671;1479.8742106920909;1481.3852251315705;16786.1606919654;17594.472165835014;17606.38377656782;17614.91192544039;17634.294628214873;17215.13924303783;17268.740968885475;17279.481615551522;17393.565160870985;17417.477475675718;2897.3870980532092;2915.183748550404;2955.2907302247413;2959.3489432324855;2959.4672958867395;2865.641794775653;2903.9709602903913;2927.970720292791;2932.7067293270716;2933.4866398380304;2824.1386377155063;2854.9143525694262;2925.9853700731464;2929.4726949149144;2934.926626834325;2919.7664186865104;2938.76489880809;2954.556816477535;2954.9852250738822;2955.113465960225;2766.432881259337;2861.957070643942;2905.273681579605;2908.4619345421165;2922.956155657667;16714.66570668592;16832.663346732996;16872.83127168737;16919.3232270709;16961.406350777663;8591.398602097855;8925.821483570357;8926.330525210571;8930.151635594608;8933.6873209438;5124.359455068116;5315.069862773999;5367.275417818583;5390.5418039466695;5487.204355368449;2135.3700658305684;2175.8912054397215;2183.366823621164;2187.0923566719794;2237.496563273267;30874.382512349628;30984.690153098407;31050;31110.688893111233;31238.53142202869;7627.237276272328;7721.884171737428;7727.38180945523;7906.5651389174145;7911.920880791118;20470.18119275242;20640.69038964417;20674.793252067586;20763.68854467184;20808;8732.69435569752;8880.289576833839;8941.37410381267;9008.234300084567;9018.774530636787;7792.727254546177;7939;8034.116247212802;8214.301784348398;8225.136360682041;5760.596758226884;5939.70301484924;5992.43071908168;6038.516918646497;6043;1746.4585978346754;1782.6612943540686;1790.7224380221087;1809.2039502618807;1812.664657038452;956.0917128727737;975.4244995452717;988.4711679251566;992.7766252593253;1002.7643503776607;8553.101924297984;8620.439671421338;8644.308455323559;8709.738707838775;8819.338549608805;810.9432339736162;811.9594020298962;813.8697808350754;816.6937398475571;841.886345343383;5145.9485405146215;5470.56235501159;5857.912131318034;6030.547708921848;6161.383861613893;25082.247532574052;25188.748112519006;25663.871680641852;25687.48625027489;25720.614190787153;24883;24959.376015599755;25104;25536.744632553808;25709.485810283688;11322.26405283654;11339.376334301527;11567.305961642329;11604.593839215755;11617.186796924303;8907.688230911886;9035.774105647411;9090.636374545209;9106;9306;20472.59054818925;21435.356939291847;21803.127874884827;21857.89071054698;22239.22162724297;22456.10175592958;22661.88669056644;22670.546589068457;22721.431964201027;22767.975441105522;12803;12877.420516076987;12911;13033.348332583144;13045.673858153623;15232.009919355207;15250.618734531725;15337.923310383376;15396;15448.227588620748;11933.105017123577;12037.398130093285;12110.75778484443;12228.87771122313;12372.566960156351;12346.888780009842;12502.937485312515;12520.749585008067;12703.237805731686;12806.935965320114;10251.179905607385;10441.738956526147;10455.320404173704;10455.529501172618;10460.058594726512;7881.802954926173;7967;8076.919230807852;8077.151899050515;8108.2297181767635;8155.510669359857;8227.42408031432;8229.79425514367;8247.381446391424;8320.209580089882 12:39:48 INFO - PID 16614 | |4;prototype.html;570.4780126184542;581.9679917604532;584.0750158931976;591.3317950715693;598.1984141250723;6286.9685651571735;6364.618122912622;6386.457151142153;6397.121295417058;6464.418202361787;6330.430261276484;6342.524310676695;6345.682715864212;6351.17434733484;6364.427201551859;5200.479952004788;5211.322528071345;5215.295935048758;5222.686638801684;5223.82463945613;5104.64267501275;5177.747679759298;5231.293775340338;5236.214567814839;5264.184051472009;5211.270422140903;5257.973710131444;5274.156135018397;5289.788408463657;5297.284866543006;5158.690478571298;5225.712585807779;5259.579233661317;5284.071313970411;5284.63007589467;4872.366592343008;4872.9512704873205;4886.706797592155;4926.113299606105;4955.628327875388;6144.723487443076;6157;6180.752769889199;6247.812565623039;6310.873782524323;6228.639952033549;6260.217472815898;6282.465990390822;6291.5281353898645;6318.368163183691;6864.485163612749;6877.449804015667;6891.655417229119;6896.724131034753;6907.516473846833;5538.75075621598;5558.86102847428;5561.221428999943;5565.860853478655;5568.016625120495;6761.425278851254;6900.585964842126;6946.79159625207;6994.860102797916;7051.858962820715;5682.886342273131;5707.1724599933605;5728.742206600713;5729.598928074995;5746.96554620164;5788.652680839079;5802.796902108406;5818.359980402152;5831.387704290988;5861.88276234473;6214.285357183981;6225.28409232944;6264.561480696308;6269.185005949289;6274.2784579773;6805.727770889208;6810.931890681129;6821.283765204582;6861.656917154122;6861.931380686229;2006.7190593316948;2018.5256464730776;2033.922021328698;2034.7965203479534;2037.2156719663037;1444.285078885937;1509.539590424909;1532.3564103076735;1532.4483186053012;1546.5539720361498;6163.630182189083;6173.506119510428;6237.688115594293;6248.625082495065;6263.96868015657;6750.189977202669;6809.216940051859;6816.522843401013;6847;6872.41584465326;6045.4281886708895;6128.264608247039;6184.9176394130845;6214.502839772807;6242.625442473466;3557.2351944332095;3582.390993531106;3613.4941108244866;3615.1323682316056;3631.4371272452813;6965.33829286217;6994.125734283215;7040;7053.717851285891;7089.82275443118;6999.0551275577145;7009.894851577231;7010.789676309719;7022.719091236293;7036.169607143105;7084.599392291729;7140.5358651687475;7161.069061022034;7174.174969878531;7178.605176715227;6771.731469957423;6773.627450490073;6812.25065242813;6830.624315662686;6866.588004719732;6686.197656281277;6746.8650626988165;6753.872530152986;6811.727530898708;6827.214870289781;6875.58746475193;6981.359380545467;7006.9649651751415;7011.789646310619;7113.893291600527;5615.522680572034;5630.268065151504;5649.209110724584;5692.516136128475;5692.686902220417;6569.080328754074;6659.500537459613;6733.629650369081;6787.524873258824;6822.181338239443;6541.280459149394;6587.242467116152;6617.139771829631;6619.238787539494;6645.906539440061;6466.676666166579;6494.74021039172;6583.572067815577;6606.054550904225;6687.899681504879;6303.590266632654;6405.3594640535575;6441.935580644134;6575.572587781779;6647.302033286435;6630.436412904957;6650.733970641314;6696.665166741546;6712.966435167793;6736.225334086643;6404.423601875854;6508.186476690414;6518.641474718936;6530.934690653223;6533.803985880431 12:39:48 INFO - PID 16614 | |5;yui.html;956.6030097509533;994.4033579852089;994.8905620381752;1000.4897502273841;1023.3655133817032;19466.51333716658;19671.409857704257;19819.50451238718;19857.20571177155;20014.799852001477;17243.31026758928;17967.460976170703;18043.729344059815;18265.36071237507;18425.07874606271;1032.726327523205;1058.1957712138753;1067.4822710985165;1069.5828626835541;1071.544593547743;1052.884182739898;1059.89930956559;1064.2816099133092;1073.7047311989188;1088.9945550272237;1110.3448965110583;1149.9597514087009;1150.350052220497;1150.9079273658128;1151.3782557418983;1105.4748994227757;1139.1854823800982;1141.4235810915434;1143.2568830260398;1145.2613064573386;809.8785182222714;831.3723139030054;837.0248660310731;837.7738010737128;837.9748607541784;19792.109355079057;19865.304714335074;20007.899960500104;20065.99670016508;20159.0928408222;22707;22867.77132228673;23321.067157313686;23524.294271171893;23550.175743848882;17019.829801701948;17165.656686866318;17307.567310817205;17314.65370692579;17321.133943302786;3887.4751908492276;3906.1797022625283;3907.1013666856497;3908.3160446921675;3909.6872250219913;156991;157469;157781;157990;161025;17656.293748250184;17850.19674114668;17875.642487150184;17905.820941790676;17921.910390447963;34685.826570866986;34760.304793904485;35536.289274214374;35635.643643563235;35650.8217458911;8449.662013519513;8633.525156116348;8651.697190598425;8669.739907802776;8747.16901894319;4158.251514727318;4203.915921681611;4206;4228.577142285747;4249.447571815706;6061.757529698851;6094.542909281821;6207.379262073757;6215.627062376272;6242.687865606792;1082.1396989393293;1095.7205912492263;1114.8717897441736;1117.8770335263114;1117.9385133817718;671.7245929169018;692.9272426395257;701.9438444924393;705.2770909817376;711.494838664554;12636.620901372973;12683.682907927376;13118.344082795822;13697.726045479034;13698.315084245747;641.2241188162376;646.1470858466872;650.3301599352675;664.6776313487954;666.2305037681485;5827.446392592697;5833.504152147115;5834.299884013945;5906.084556893688;5982;149483;151076;151372;151556;152085;134283.32858335646;137063;138524.30737846246;140762.2961885184;142590;110087;111055;111464;113901.01346453;113933;10472.214583906085;10825.188110891871;10837.566497340018;10862.456877156268;10917.12662986975;56182.438175619354;56440;56681.14978275412;57300;57909;73664;74931.62534187295;75301.24698753162;76134;77787;16747.581310467336;16817.075060871768;17037.57406064858;17195.14024298805;17211.741823872904;16684.416045438353;17005.319787208373;17213.31146754116;17361.652766944844;17401.042942638276;17483.950962942265;17741.645167096845;17884.731729024334;18253.54366140804;18259.360922367654;15410.306536206122;15653.295601698179;15912;15964.760528592313;16029.759553606938;15574;15843.603909902346;15894.52316430509;16074.839251607802;16211.594710132342;12928.806067908801;12933.611991640266;12996.935015325242;13269.535566255136;13273.070885038342;12031.578894738643;12064.638060858188;12360.876391236332;12701.174423662802;12754.107212495037 12:39:48 INFO - PID 16614 | __end_tp_report 12:39:48 INFO - PID 16614 | __start_cc_report 12:39:48 INFO - PID 16614 | _x_x_mozilla_cycle_collect,250 12:39:48 INFO - PID 16614 | __end_cc_report 12:39:48 INFO - PID 16614 | __startTimestamp1507059588238__endTimestamp 12:39:48 INFO - PID 16614 | 12:39:48 INFO - PID 16614 | ------- Summary: start ------- 12:39:48 INFO - PID 16614 | Number of tests: 6 12:39:48 INFO - PID 16614 | 12:39:48 INFO - PID 16614 | [#0] dojo.html Cycles:165 Average:6395.63 Median:6611.44 stddev:775.61 (11.7%) stddev-sans-first:751.73 12:39:48 INFO - PID 16614 | Values: 3844.9 3854.9 3872.6 3883.3 3888.8 6264.8 6363.9 6381.6 6412.2 6412.5 6389.6 6400.4 6423.7 6432.3 6437.7 5689.8 5709.0 5732.7 5739.2 5749.9 5766.0 5768.9 5773.1 5788.9 5835.6 5820.5 5883.3 5894.5 5909.2 5920.5 5638.4 5745.3 5828.2 5856.2 5939.1 5554.6 5689.8 5698.4 5709.4 5718.2 6382.6 6394.4 6454.0 6469.2 6482.0 6817.7 6862.7 6871.5 6904.7 7015.1 6972.0 6978.2 6991.0 6993.1 6998.8 6335.2 6491.4 6501.6 6533.9 6545.0 7106.8 7117.3 7164.4 7184.7 7260.0 6820.9 6821.5 6908.5 6913.6 6915.7 6935.1 6942.9 6955.8 7040.6 7049.3 6873.6 6884.8 6902.2 6913.4 6945.8 6963.2 6995.1 6996.8 7006.5 7006.6 4976.9 4983.1 4993.6 5070.3 5071.8 4517.4 4533.7 4552.4 4564.2 4585.4 6426.0 6467.5 6479.0 6479.2 6480.1 6889.7 6915.6 6926.3 7014.0 7022.3 6352.0 6384.0 6466.0 6478.3 6495.1 5648.3 5666.8 5674.2 5680.1 5680.6 7222.2 7240.6 7241.9 7335.1 7338.2 6796.4 6888.0 6955.4 7008.5 7054.4 7170.9 7190.4 7193.2 7197.1 7199.4 6832.6 6838.1 6931.0 6933.3 6953.7 6951.5 6966.0 7040.9 7041.8 7043.3 6611.4 6690.7 6698.6 6703.6 6705.7 6681.6 6700.0 6706.5 6710.6 6713.0 6517.4 6587.8 6596.1 6602.6 6611.5 6827.4 6830.8 6855.3 6860.5 6860.8 6531.9 6539.7 6555.1 6644.5 6657.4 12:39:48 INFO - PID 16614 | 12:39:48 INFO - PID 16614 | [#1] ext.html Cycles:180 Average:44297.62 Median:3820.52 stddev:65474.85 (1713.8%) stddev-sans-first:65577.76 12:39:48 INFO - PID 16614 | Values: 986.4 1008.6 1014.7 1015.7 1016.2 41378.6 46008.5 46233.5 46325.3 46328.0 43065.6 43248.6 43300.6 43356.6 43358.6 7736.7 7882.1 8475.7 8637.7 8674.4 8570.9 8637.5 8690.7 8698.3 8703.2 8590.7 8683.2 8684.3 8694.5 8716.1 8657.7 8694.0 8697.6 8702.1 8708.2 8539.4 8546.2 8561.7 8562.1 8599.8 40085.2 40479.0 40513.4 40669.0 40786.0 3783.1 3820.4 3820.7 3827.0 3827.9 33289.5 33323.5 33446.8 33557.0 33645.3 5353.7 5463.4 5512.4 5529.3 5613.5 218713.0 219271.0 219452.0 219634.0 220487.0 54174.5 54361.7 57014.0 57016.1 57720.1 59855.4 60012.0 60243.7 60244.0 60268.4 17357.8 17455.7 17472.8 17667.8 17688.5 14372.9 14467.4 14470.6 14471.3 14478.1 15291.4 15367.9 15428.0 15456.5 15556.8 5981.9 6057.8 6117.5 6139.8 6142.2 1135.2 1135.9 1138.2 1158.8 1159.8 26585.6 27016.2 27129.1 27140.0 27450.7 1214.4 1218.8 1228.4 1241.2 1247.3 14040.9 14156.0 14275.6 14325.2 14373.5 293625.0 294109.0 295328.0 295755.0 296332.0 62012.4 62418.0 62447.0 62546.7 62593.7 1518.4 1533.2 1573.2 1575.1 1585.7 29284.9 32183.5 32231.7 32702.7 33089.0 58815.4 59452.0 59485.4 59551.7 59655.4 232386.0 233493.0 234222.0 234757.0 234873.0 38790.8 39108.6 39435.2 39441.6 39605.2 48125.5 49744.3 49812.8 50039.0 50694.5 31491.2 31527.2 31659.5 31685.8 34744.8 35940.0 36226.6 36443.6 36921.3 36944.1 39494.6 41977.8 42409.8 42597.0 43384.8 34956.3 35314.6 35319.5 35405.5 35992.6 26701.3 26800.6 26852.4 26985.2 27245.2 12:39:48 INFO - PID 16614 | 12:39:48 INFO - PID 16614 | [#2] jquery.html Cycles:180 Average:39811.61 Median:21573.28 stddev:99936.31 (463.2%) stddev-sans-first:100173.35 12:39:48 INFO - PID 16614 | Values: 625.3 627.9 634.4 641.8 652.5 23274.9 23470.1 24078.8 24163.9 24718.5 26762.3 27312.6 27329.0 27344.7 27350.0 6929.2 6999.1 7051.3 7069.4 7087.5 6806.4 6992.7 7041.0 7054.5 7063.0 6965.8 7013.7 7022.2 7025.3 7030.4 6566.6 6799.2 6800.0 6952.8 6973.8 6348.2 6350.8 6357.0 6359.7 6383.5 31675.5 32207.5 32268.7 32406.4 32417.0 2262.9 2283.0 2285.4 2291.9 2295.4 19950.2 21209.2 21432.7 21508.5 21521.9 2589.0 2611.7 2626.7 2638.2 2677.1 138920.0 142598.3 152292.0 159420.0 159452.2 16587.8 17112.2 17138.3 17182.3 17438.4 27314.0 27337.5 27369.6 27396.9 27434.5 11195.7 11213.4 11439.8 11479.4 11571.4 10173.9 10175.7 10238.0 10263.2 10376.1 10000.4 10400.3 10410.7 10532.7 10686.4 3084.0 3126.3 3151.5 3159.4 3227.0 1026.8 1042.5 1061.2 1074.0 1077.5 21410.3 21624.7 21872.1 22100.2 22391.9 1113.5 1114.9 1115.5 1117.2 1134.9 11953.0 12125.3 12161.9 12174.5 12311.9 587054.0 588680.0 594553.1 597706.0 618086.0 126888.0 130406.0 131814.0 132577.0 133782.3 1223.3 1229.7 1264.5 1266.8 1268.1 18995.4 19369.2 19655.5 19655.6 19893.4 61362.1 61817.0 62646.4 62974.0 63863.0 75429.2 76378.6 76908.0 77217.0 78243.0 15985.4 16121.6 16197.7 16297.3 16357.5 23859.5 23919.5 24244.5 24249.4 24547.1 19690.2 19866.6 20123.2 20153.7 20159.3 16851.6 16985.7 17171.1 17280.7 17306.7 20482.8 20762.7 20769.3 20890.6 20898.2 15815.7 15981.1 16148.0 16234.9 16249.9 19509.4 19794.3 19817.0 19959.4 20110.8 12:39:48 INFO - PID 16614 | 12:39:48 INFO - PID 16614 | [#3] mootools.html Cycles:180 Average:10544.07 Median:2881.51 stddev:7865.66 (273.0%) stddev-sans-first:7857.72 12:39:48 INFO - PID 16614 | Values: 1399.6 1462.6 1469.2 1479.9 1481.4 16786.2 17594.5 17606.4 17614.9 17634.3 17215.1 17268.7 17279.5 17393.6 17417.5 2897.4 2915.2 2955.3 2959.3 2959.5 2865.6 2904.0 2928.0 2932.7 2933.5 2824.1 2854.9 2926.0 2929.5 2934.9 2919.8 2938.8 2954.6 2955.0 2955.1 2766.4 2862.0 2905.3 2908.5 2923.0 16714.7 16832.7 16872.8 16919.3 16961.4 8591.4 8925.8 8926.3 8930.2 8933.7 5124.4 5315.1 5367.3 5390.5 5487.2 2135.4 2175.9 2183.4 2187.1 2237.5 30874.4 30984.7 31050.0 31110.7 31238.5 7627.2 7721.9 7727.4 7906.6 7911.9 20470.2 20640.7 20674.8 20763.7 20808.0 8732.7 8880.3 8941.4 9008.2 9018.8 7792.7 7939.0 8034.1 8214.3 8225.1 5760.6 5939.7 5992.4 6038.5 6043.0 1746.5 1782.7 1790.7 1809.2 1812.7 956.1 975.4 988.5 992.8 1002.8 8553.1 8620.4 8644.3 8709.7 8819.3 810.9 812.0 813.9 816.7 841.9 5145.9 5470.6 5857.9 6030.5 6161.4 25082.2 25188.7 25663.9 25687.5 25720.6 24883.0 24959.4 25104.0 25536.7 25709.5 11322.3 11339.4 11567.3 11604.6 11617.2 8907.7 9035.8 9090.6 9106.0 9306.0 20472.6 21435.4 21803.1 21857.9 22239.2 22456.1 22661.9 22670.5 22721.4 22768.0 12803.0 12877.4 12911.0 13033.3 13045.7 15232.0 15250.6 15337.9 15396.0 15448.2 11933.1 12037.4 12110.8 12228.9 12372.6 12346.9 12502.9 12520.7 12703.2 12806.9 10251.2 10441.7 10455.3 10455.5 10460.1 7881.8 7967.0 8076.9 8077.2 8108.2 8155.5 8227.4 8229.8 8247.4 8320.2 12:39:48 INFO - PID 16614 | 12:39:48 INFO - PID 16614 | [#4] prototype.html Cycles:180 Average:5803.58 Median:6314.62 stddev:1541.06 (24.4%) stddev-sans-first:1494.49 12:39:48 INFO - PID 16614 | Values: 570.5 582.0 584.1 591.3 598.2 6287.0 6364.6 6386.5 6397.1 6464.4 6330.4 6342.5 6345.7 6351.2 6364.4 5200.5 5211.3 5215.3 5222.7 5223.8 5104.6 5177.7 5231.3 5236.2 5264.2 5211.3 5258.0 5274.2 5289.8 5297.3 5158.7 5225.7 5259.6 5284.1 5284.6 4872.4 4873.0 4886.7 4926.1 4955.6 6144.7 6157.0 6180.8 6247.8 6310.9 6228.6 6260.2 6282.5 6291.5 6318.4 6864.5 6877.4 6891.7 6896.7 6907.5 5538.8 5558.9 5561.2 5565.9 5568.0 6761.4 6900.6 6946.8 6994.9 7051.9 5682.9 5707.2 5728.7 5729.6 5747.0 5788.7 5802.8 5818.4 5831.4 5861.9 6214.3 6225.3 6264.6 6269.2 6274.3 6805.7 6810.9 6821.3 6861.7 6861.9 2006.7 2018.5 2033.9 2034.8 2037.2 1444.3 1509.5 1532.4 1532.4 1546.6 6163.6 6173.5 6237.7 6248.6 6264.0 6750.2 6809.2 6816.5 6847.0 6872.4 6045.4 6128.3 6184.9 6214.5 6242.6 3557.2 3582.4 3613.5 3615.1 3631.4 6965.3 6994.1 7040.0 7053.7 7089.8 6999.1 7009.9 7010.8 7022.7 7036.2 7084.6 7140.5 7161.1 7174.2 7178.6 6771.7 6773.6 6812.3 6830.6 6866.6 6686.2 6746.9 6753.9 6811.7 6827.2 6875.6 6981.4 7007.0 7011.8 7113.9 5615.5 5630.3 5649.2 5692.5 5692.7 6569.1 6659.5 6733.6 6787.5 6822.2 6541.3 6587.2 6617.1 6619.2 6645.9 6466.7 6494.7 6583.6 6606.1 6687.9 6303.6 6405.4 6441.9 6575.6 6647.3 6630.4 6650.7 6696.7 6713.0 6736.2 6404.4 6508.2 6518.6 6530.9 6533.8 12:39:48 INFO - PID 16614 | 12:39:48 INFO - PID 16614 | [#5] yui.html Cycles:180 Average:28179.71 Median:17341.39 stddev:42859.11 (247.1%) stddev-sans-first:42930.60 12:39:48 INFO - PID 16614 | Values: 956.6 994.4 994.9 1000.5 1023.4 19466.5 19671.4 19819.5 19857.2 20014.8 17243.3 17967.5 18043.7 18265.4 18425.1 1032.7 1058.2 1067.5 1069.6 1071.5 1052.9 1059.9 1064.3 1073.7 1089.0 1110.3 1150.0 1150.4 1150.9 1151.4 1105.5 1139.2 1141.4 1143.3 1145.3 809.9 831.4 837.0 837.8 838.0 19792.1 19865.3 20007.9 20066.0 20159.1 22707.0 22867.8 23321.1 23524.3 23550.2 17019.8 17165.7 17307.6 17314.7 17321.1 3887.5 3906.2 3907.1 3908.3 3909.7 156991.0 157469.0 157781.0 157990.0 161025.0 17656.3 17850.2 17875.6 17905.8 17921.9 34685.8 34760.3 35536.3 35635.6 35650.8 8449.7 8633.5 8651.7 8669.7 8747.2 4158.3 4203.9 4206.0 4228.6 4249.4 6061.8 6094.5 6207.4 6215.6 6242.7 1082.1 1095.7 1114.9 1117.9 1117.9 671.7 692.9 701.9 705.3 711.5 12636.6 12683.7 13118.3 13697.7 13698.3 641.2 646.1 650.3 664.7 666.2 5827.4 5833.5 5834.3 5906.1 5982.0 149483.0 151076.0 151372.0 151556.0 152085.0 134283.3 137063.0 138524.3 140762.3 142590.0 110087.0 111055.0 111464.0 113901.0 113933.0 10472.2 10825.2 10837.6 10862.5 10917.1 56182.4 56440.0 56681.1 57300.0 57909.0 73664.0 74931.6 75301.2 76134.0 77787.0 16747.6 16817.1 17037.6 17195.1 17211.7 16684.4 17005.3 17213.3 17361.7 17401.0 17484.0 17741.6 17884.7 18253.5 18259.4 15410.3 15653.3 15912.0 15964.8 16029.8 15574.0 15843.6 15894.5 16074.8 16211.6 12928.8 12933.6 12996.9 13269.5 13273.1 12031.6 12064.6 12360.9 12701.2 12754.1 12:39:48 INFO - PID 16614 | -------- Summary: end -------- 12:39:48 INFO - PID 16614 | 12:39:48 INFO - TEST-INFO | 16614: exit 0 12:39:48 INFO - TEST-OK | dromaeo_css | took 1106832ms 12:39:48 INFO - TEST-START | kraken 12:39:48 INFO - Initialising browser for kraken test... 12:39:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60147/getInfo.html -profile /tmp/tmpAXMiGL/profile 12:39:48 INFO - TEST-INFO | started process 17008 (/builds/slave/test/build/application/firefox/firefox http://localhost:60147/getInfo.html) 12:39:52 INFO - TEST-INFO | 17008: exit 0 12:39:52 INFO - Browser initialized. 12:39:52 INFO - Running cycle 1/1 for kraken test... 12:39:52 INFO - Using env: {'DISPLAY': ':0', 12:39:52 INFO - 'HOME': '/home/cltbld', 12:39:52 INFO - 'JSGC_DISABLE_POISONING': '1', 12:39:52 INFO - 'LANG': 'en_US.UTF-8', 12:39:52 INFO - 'LANGUAGE': 'en_US:en', 12:39:52 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:39:52 INFO - 'LOGNAME': 'cltbld', 12:39:52 INFO - 'MAIL': '/var/mail/cltbld', 12:39:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:39:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:39:52 INFO - 'MOZ_CRASHREPORTER': '1', 12:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:52 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:39:52 INFO - 'MOZ_NO_REMOTE': '1', 12:39:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:52 INFO - 'NO_EM_RESTART': '1', 12:39:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:52 INFO - 'PWD': '/builds/slave/test', 12:39:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:39:52 INFO - 'RUST_BACKTRACE': 'full', 12:39:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:39:52 INFO - 'SHELL': '/bin/bash', 12:39:52 INFO - 'SHLVL': '1', 12:39:52 INFO - 'STYLO_FORCE_DISABLED': '1', 12:39:52 INFO - 'TERM': 'linux', 12:39:52 INFO - 'TMOUT': '86400', 12:39:52 INFO - 'USER': 'cltbld', 12:39:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921', 12:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:52 INFO - '_': '/tools/buildbot/bin/python'} 12:39:52 INFO - TEST-INFO | started process 17280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAXMiGL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:39:53 INFO - PID 17280 | 12:39:53 INFO - PID 17280 | (/builds/slave/test/build/application/firefox/firefox:17329): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:39:53 INFO - PID 17280 | 12:40:04 INFO - PID 17280 | RSS: Main: 148144128 12:40:04 INFO - PID 17280 | 12:40:06 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60147/tests/kraken/driver.html?testName=audio-beat-detection) 12:40:07 INFO - PID 17280 | RSS: Main: 153640960 12:40:07 INFO - PID 17280 | 12:40:10 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60147/tests/kraken/driver.html?testName=audio-dft) 12:40:10 INFO - PID 17280 | RSS: Main: 153976832 12:40:10 INFO - PID 17280 | 12:40:13 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60147/tests/kraken/driver.html?testName=audio-fft) 12:40:14 INFO - PID 17280 | RSS: Main: 150839296 12:40:14 INFO - PID 17280 | 12:40:16 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60147/tests/kraken/driver.html?testName=audio-oscillator) 12:40:16 INFO - PID 17280 | RSS: Main: 151175168 12:40:16 INFO - PID 17280 | 12:40:18 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60147/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:40:19 INFO - PID 17280 | RSS: Main: 150798336 12:40:19 INFO - PID 17280 | 12:40:22 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60147/tests/kraken/driver.html?testName=imaging-darkroom) 12:40:23 INFO - PID 17280 | RSS: Main: 151220224 12:40:23 INFO - PID 17280 | 12:40:26 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60147/tests/kraken/driver.html?testName=imaging-desaturate) 12:40:27 INFO - PID 17280 | RSS: Main: 153112576 12:40:27 INFO - PID 17280 | 12:40:30 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60147/tests/kraken/driver.html?testName=json-parse-financial) 12:40:30 INFO - PID 17280 | RSS: Main: 153333760 12:40:30 INFO - PID 17280 | 12:40:32 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60147/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:40:32 INFO - PID 17280 | RSS: Main: 153354240 12:40:32 INFO - PID 17280 | 12:40:34 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:40:35 INFO - PID 17280 | RSS: Main: 153513984 12:40:35 INFO - PID 17280 | 12:40:37 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:40:37 INFO - PID 17280 | RSS: Main: 150302720 12:40:37 INFO - PID 17280 | 12:40:40 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:40:40 INFO - PID 17280 | RSS: Main: 150491136 12:40:40 INFO - PID 17280 | 12:40:43 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:40:44 INFO - PID 17280 | RSS: Main: 151236608 12:40:44 INFO - PID 17280 | 12:40:45 INFO - PID 17280 | Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60147/tests/kraken/driver.html?testName=ai-astar) 12:40:46 INFO - PID 17280 | RSS: Main: 152489984 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | __start_tp_report 12:40:46 INFO - PID 17280 | _x_x_mozilla_page_load 12:40:46 INFO - PID 17280 | _x_x_mozilla_page_load_details 12:40:46 INFO - PID 17280 | |i|pagename|runs| 12:40:46 INFO - PID 17280 | |0;ai-astar;106;105;105;107;105;106;114;106;106;105 12:40:46 INFO - PID 17280 | |1;audio-beat-detection;114;116;113;113;156;113;111;112;111;143 12:40:46 INFO - PID 17280 | |2;audio-dft;163;162;164;166;165;165;162;162;166;168 12:40:46 INFO - PID 17280 | |3;audio-fft;75;73;74;73;73;72;72;72;83;73 12:40:46 INFO - PID 17280 | |4;audio-oscillator;78;78;79;82;79;77;77;78;77;77 12:40:46 INFO - PID 17280 | |5;imaging-gaussian-blur;114;114;114;114;113;114;115;114;112;115 12:40:46 INFO - PID 17280 | |6;imaging-darkroom;149;150;150;149;152;151;152;152;152;150 12:40:46 INFO - PID 17280 | |7;imaging-desaturate;94;94;93;94;95;94;96;94;95;96 12:40:46 INFO - PID 17280 | |8;json-parse-financial;45;44;43;44;45;42;42;45;44;43 12:40:46 INFO - PID 17280 | |9;json-stringify-tinderbox;38;38;37;38;37;38;38;37;38;38 12:40:46 INFO - PID 17280 | |10;stanford-crypto-aes;74;71;68;67;68;70;79;70;69;72 12:40:46 INFO - PID 17280 | |11;stanford-crypto-ccm;112;115;114;108;111;104;104;110;102;106 12:40:46 INFO - PID 17280 | |12;stanford-crypto-pbkdf2;151;148;148;148;152;149;154;149;149;160 12:40:46 INFO - PID 17280 | |13;stanford-crypto-sha256-iterative;60;59;60;62;58;59;57;60;58;62 12:40:46 INFO - PID 17280 | __end_tp_report 12:40:46 INFO - PID 17280 | __start_cc_report 12:40:46 INFO - PID 17280 | _x_x_mozilla_cycle_collect,690 12:40:46 INFO - PID 17280 | __end_cc_report 12:40:46 INFO - PID 17280 | __startTimestamp1507059645998__endTimestamp 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | ------- Summary: start ------- 12:40:46 INFO - PID 17280 | Number of tests: 14 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#0] ai-astar Cycles:10 Average:106.50 Median:106.00 stddev:2.72 (2.6%) stddev-sans-first:2.88 12:40:46 INFO - PID 17280 | Values: 106.0 105.0 105.0 107.0 105.0 106.0 114.0 106.0 106.0 105.0 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#1] audio-beat-detection Cycles:10 Average:120.20 Median:113.50 stddev:15.81 (13.9%) stddev-sans-first:16.61 12:40:46 INFO - PID 17280 | Values: 114.0 116.0 113.0 113.0 156.0 113.0 111.0 112.0 111.0 143.0 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#2] audio-dft Cycles:10 Average:164.30 Median:165.00 stddev:2.06 (1.2%) stddev-sans-first:2.13 12:40:46 INFO - PID 17280 | Values: 163.0 162.0 164.0 166.0 165.0 165.0 162.0 162.0 166.0 168.0 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#3] audio-fft Cycles:10 Average:74.00 Median:73.00 stddev:3.30 (4.5%) stddev-sans-first:3.48 12:40:46 INFO - PID 17280 | Values: 75.0 73.0 74.0 73.0 73.0 72.0 72.0 72.0 83.0 73.0 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:78.00 stddev:1.55 (2.0%) stddev-sans-first:1.64 12:40:46 INFO - PID 17280 | Values: 78.0 78.0 79.0 82.0 79.0 77.0 77.0 78.0 77.0 77.0 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 12:40:46 INFO - PID 17280 | Values: 114.0 114.0 114.0 114.0 113.0 114.0 115.0 114.0 112.0 115.0 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.50 stddev:1.25 (0.8%) stddev-sans-first:1.17 12:40:46 INFO - PID 17280 | Values: 149.0 150.0 150.0 149.0 152.0 151.0 152.0 152.0 152.0 150.0 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.97 (1.0%) stddev-sans-first:1.01 12:40:46 INFO - PID 17280 | Values: 94.0 94.0 93.0 94.0 95.0 94.0 96.0 94.0 95.0 96.0 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#8] json-parse-financial Cycles:10 Average:43.70 Median:44.00 stddev:1.16 (2.6%) stddev-sans-first:1.13 12:40:46 INFO - PID 17280 | Values: 45.0 44.0 43.0 44.0 45.0 42.0 42.0 45.0 44.0 43.0 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 12:40:46 INFO - PID 17280 | Values: 38.0 38.0 37.0 38.0 37.0 38.0 38.0 37.0 38.0 38.0 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#10] stanford-crypto-aes Cycles:10 Average:70.80 Median:70.50 stddev:3.55 (5.0%) stddev-sans-first:3.57 12:40:46 INFO - PID 17280 | Values: 74.0 71.0 68.0 67.0 68.0 70.0 79.0 70.0 69.0 72.0 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#11] stanford-crypto-ccm Cycles:10 Average:108.60 Median:110.50 stddev:4.50 (4.1%) stddev-sans-first:4.60 12:40:46 INFO - PID 17280 | Values: 112.0 115.0 114.0 108.0 111.0 104.0 104.0 110.0 102.0 106.0 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.80 Median:150.00 stddev:3.79 (2.5%) stddev-sans-first:4.02 12:40:46 INFO - PID 17280 | Values: 151.0 148.0 148.0 148.0 152.0 149.0 154.0 149.0 149.0 160.0 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.50 Median:60.00 stddev:1.65 (2.7%) stddev-sans-first:1.74 12:40:46 INFO - PID 17280 | Values: 60.0 59.0 60.0 62.0 58.0 59.0 57.0 60.0 58.0 62.0 12:40:46 INFO - PID 17280 | -------- Summary: end -------- 12:40:46 INFO - PID 17280 | 12:40:46 INFO - PID 17280 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:40:46 INFO - TEST-INFO | 17280: exit 0 12:40:46 INFO - TEST-OK | kraken | took 57932ms 12:40:46 INFO - SUITE-END | took 1164s 12:40:46 INFO - Completed test suite (00:19:24) 12:40:46 INFO - javascript benchmark 12:40:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9234.934879889466, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3844.8846534603963, 3854.939891529829, 3872.612738726127, 3883.281592905311, 3888.8444462221532, 6264.84337891553, 6363.872722545546, 6381.649009304487, 6412.198475190601, 6412.519061070421, 6389.616623002611, 6400.391962763541, 6423.6788160591905, 6432.292447830735, 6437.710303036363, 5689.772409103631, 5709.0, 5732.742026608813, 5739.167820666001, 5749.885002299962, 5766.0486019806685, 5768.913466298009, 5773.134029895507, 5788.884222315552, 5835.649861008353, 5820.534357251409, 5883.323417806964, 5894.528437724972, 5909.231799866011, 5920.526357891358, 5638.40796716343, 5745.339285982123, 5828.2131912191735, 5856.1941655466935, 5939.07944268639, 5554.638948468337, 5689.800856970028, 5698.40166782486, 5709.4290570942985, 5718.170865224519, 6382.585131966407, 6394.392532709385, 6453.967730161319, 6469.191351081115, 6481.967590162066, 6817.659117044128, 6862.656867156672, 6871.4502839773195, 6904.689288982008, 7015.088038555006, 6971.965140174267, 6978.197507286676, 6990.965045174741, 6993.125859267591, 6998.75504357345, 6335.176427064452, 6491.415772580443, 6501.577397469149, 6533.869322613568, 6544.9672751635935, 7106.751263705849, 7117.288271172944, 7164.391026762783, 7184.676689548983, 7260.0, 6820.897686534706, 6821.522493425413, 6908.516403851782, 6913.585184888922, 6915.723371065202, 6935.098437203233, 6942.930570694229, 6955.826104347432, 7040.577565345993, 7049.259827718119, 6873.553219040747, 6884.793456196322, 6902.171739391305, 6913.446924246048, 6945.79162625112, 6963.1644202696, 6995.125609298838, 6996.790096297119, 7006.4745144114395, 7006.649667516604, 4976.8755781105765, 4983.127952608279, 4993.625478089158, 5070.340855688737, 5071.771770270347, 4517.435320584927, 4533.727976321431, 4552.430946131733, 4564.2240819060835, 4585.358049873021, 6426.0, 6467.482601391877, 6478.967605161944, 6479.1901012373455, 6480.092787009822, 6889.655517224119, 6915.619640919797, 6926.307369263033, 7013.982972468963, 7022.297770222936, 6351.96824015877, 6383.96808015957, 6466.030095485715, 6478.319776423502, 6495.058216558573, 5648.293963254593, 5666.829995100154, 5674.205611214434, 5680.091185410397, 5680.602357834912, 7222.169450513258, 7240.565566065948, 7241.927580724126, 7335.083114610674, 7338.22948590401, 6796.35434633709, 6888.0, 6955.408790252885, 7008.509404341749, 7054.435645148478, 7170.856582868209, 7190.388816950618, 7193.244709305657, 7197.100362454693, 7199.424046076406, 6832.555883867532, 6838.111045564045, 6931.029655848084, 6933.341332573397, 6953.721851126101, 6951.478639101986, 6966.0, 7040.929590704028, 7041.753538626328, 7043.2604576518725, 6611.438027767694, 6690.665466726547, 6698.631575263213, 6703.631300278336, 6705.6647167642395, 6681.565698229794, 6699.9665001674675, 6706.497012723968, 6710.563813352116, 6712.966435167793, 6517.4134327910715, 6587.769428069994, 6596.109525214035, 6602.570832895846, 6611.471082313307, 6827.385535301847, 6830.7609233676585, 6855.348741869514, 6860.5197636164985, 6860.759873404607, 6531.934680653323, 6539.738410463528, 6555.147830782159, 6644.46844252449, 6657.367550082734], "value": 6341.175476614972, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [986.4278718343362, 1008.6116845014667, 1014.695591322603, 1015.6597539824159, 1016.151513486239, 41378.58621413785, 46008.53991460084, 46233.53766462334, 46325.30512042322, 46328.0, 43065.56934430655, 43248.567514324845, 43300.566994330045, 43356.56643433565, 43358.566414335844, 7736.729214477495, 7882.093559240675, 8475.74572762818, 8637.740867773977, 8674.436161649473, 8570.871436928452, 8637.52493612851, 8690.652373905068, 8698.347623928199, 8703.173198546128, 8590.699325523608, 8683.175098365677, 8684.30525557957, 8694.521801300925, 8716.08481109484, 8657.69698060568, 8694.0, 8697.608382658807, 8702.086280940537, 8708.17272359125, 8539.402241843012, 8546.188112129337, 8561.657533698644, 8562.100979397135, 8599.82800343996, 40085.198296033916, 40479.0, 40513.392299115534, 40669.0, 40786.0, 3783.0920579060826, 3820.36963900956, 3820.6752426043818, 3826.9808650956847, 3827.8660246891227, 33289.500657490156, 33323.500147497805, 33446.832765836014, 33557.0, 33645.32709345799, 5353.705546194958, 5463.371712253102, 5512.448755124496, 5529.30883639545, 5613.522850557667, 218713.0, 219271.0, 219452.0, 219634.0, 220487.0, 54174.45825541773, 54361.72819135879, 57014.0, 57016.14475782867, 57720.134197986226, 59855.40144598585, 60012.0, 60243.69878150581, 60244.0, 60268.397316027156, 17357.826421735874, 17455.65088698219, 17472.82527174712, 17667.823321766617, 17688.469345919642, 14372.928135359256, 14467.421303147967, 14470.638234044023, 14471.348789304506, 14478.058926169766, 15291.388344466319, 15367.923160384351, 15428.0, 15456.459023934109, 15556.844431555766, 5981.910271345933, 6057.787977420858, 6117.541184411187, 6139.84650383744, 6142.170806941095, 1135.2280449294558, 1135.882003899285, 1138.2291780671915, 1158.808796548577, 1159.8086315757805, 26585.601215981776, 27016.189514314603, 27129.050483232993, 27140.0, 27450.725492744816, 1214.3503225774168, 1218.7684339975376, 1228.42264135856, 1241.1825156893801, 1247.2828123828654, 14040.929795350958, 14156.0, 14275.571732848031, 14325.212113333866, 14373.496927607484, 293625.0, 294109.0, 295328.0, 295755.0, 296332.0, 62012.37987620066, 62418.0, 62447.0, 62546.68726656338, 62593.68703156546, 1518.4305885293015, 1533.233383308368, 1573.1662219023935, 1575.141547856421, 1585.738353171737, 29284.853575731984, 32183.51724724084, 32231.677683222868, 32702.672973269964, 33089.0, 58815.41184588271, 59452.0, 59485.40514594799, 59551.702241488514, 59655.403445966724, 232386.0, 233493.0, 234222.0, 234757.0, 234873.0, 38790.80604596959, 39108.608913910495, 39435.21129577335, 39441.60558394494, 39605.20789584135, 48125.51874481211, 49744.25383619176, 49812.75093624509, 50039.0, 50694.49305507045, 31491.212719682193, 31527.21181970469, 31659.52510712387, 31685.841570792, 34744.82627586846, 35940.0, 36226.63773362338, 36443.63556364403, 36921.261574767814, 36944.07639809026, 39494.60505394909, 41977.790111049246, 42409.78795106005, 42597.0, 43384.783076084415, 34956.30087398289, 35314.64685353216, 35319.47020794639, 35405.468917965736, 35992.64007359893, 26701.332466687712, 26800.59799102976, 26852.388856668662, 26985.190444285916, 27245.182644520697], "value": 19526.63864719952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.2871726232094, 627.9466245369143, 634.3561285295423, 641.8395401149712, 652.5399593286734, 23274.883625581868, 23470.061197552077, 24078.796060196986, 24163.879180604094, 24718.50562988739, 26762.330941726468, 27312.590311145348, 27329.0, 27344.726552734468, 27350.0, 6929.203141638713, 6999.12510936133, 7051.25961774014, 7069.434445244368, 7087.468439867031, 6806.353396427331, 6992.685329160175, 7041.049458323112, 7054.470914681394, 7062.9646851765665, 6965.79102626922, 7013.684384202723, 7022.227554968949, 7025.297470252985, 7030.367266945974, 6566.573172743781, 6799.150106236721, 6800.0, 6952.826179345506, 6973.825654358656, 6348.238211414659, 6350.809475715736, 6357.0, 6359.713812878432, 6383.521235907326, 31675.524867127013, 32207.51688724671, 32268.677313227035, 32406.351872962645, 32417.0, 2262.8642281463167, 2283.0297123722517, 2285.3829466044076, 2291.942701432461, 2295.4490922178725, 19950.201991920305, 21209.151633934624, 21432.678509822366, 21508.46228844276, 21521.89239053795, 2589.0, 2611.7127116017223, 2626.7110617832022, 2638.2349118755537, 2677.116551537988, 138920.0, 142598.28700856428, 152292.0, 159420.0, 159452.20273898673, 16587.83412165887, 17112.229949652294, 17138.314467421413, 17182.33673780566, 17438.389656361967, 27314.0, 27337.45325093527, 27369.589456158174, 27396.863015684794, 27434.45131097367, 11195.664130076111, 11213.439328033566, 11439.828402573969, 11479.426028698532, 11571.363575003288, 10173.94913025445, 10175.72803399575, 10238.0, 10263.23025773055, 10376.118029967538, 10000.449975251286, 10400.271980961412, 10410.739731506621, 10532.684019479275, 10686.358818470917, 3083.9845800770854, 3126.3278395145153, 3151.527270909336, 3159.3619327861034, 3226.9677303227136, 1026.7895081508273, 1042.4579218806177, 1061.193492945367, 1073.983890241647, 1077.5312738958578, 21410.25064122748, 21624.675629865564, 21872.12511499554, 22100.2264920727, 22391.888040559694, 1113.4822307626991, 1114.9108071354271, 1115.453427820362, 1117.1565468071553, 1134.8581427321585, 11953.0, 12125.333106679218, 12161.939190303992, 12174.513019479298, 12311.938440307742, 587054.0, 588680.0, 594553.0544694498, 597706.0, 618086.0, 126888.0, 130406.0, 131814.0, 132577.0113448299, 133782.33108834393, 1223.3455101520822, 1229.6864299603544, 1264.4562837979572, 1266.771981043421, 1268.0996492490435, 18995.43013709591, 19369.225230990603, 19655.508612284808, 19655.60688786245, 19893.403197904085, 61362.07956880561, 61817.0, 62646.37353626405, 62974.0, 63862.999999998145, 75429.24570754441, 76378.61810691134, 76908.0, 77217.0, 78243.0, 15985.44050958211, 16121.596960076093, 16197.67604647924, 16297.26662300223, 16357.509274721777, 23859.522809543363, 23919.52160956806, 24244.515109697353, 24249.39376515601, 24547.140850070162, 19690.21239150418, 19866.60266794627, 20123.195072197534, 20153.6976945343, 20159.294424695065, 16851.578710532336, 16985.745213821556, 17171.141442928052, 17280.654386912443, 17306.740398893773, 20482.795172048685, 20762.688559671315, 20769.27307544229, 20890.582188356453, 20898.1640734375, 15815.68368632644, 15981.121038343003, 16148.0, 16234.918825405797, 16249.918750406172, 19509.414717558495, 19794.307199247956, 19817.0, 19959.401217963485, 20110.798892011477], "value": 13117.780933695267, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.5591388712555, 1462.5685422800273, 1469.2213127042671, 1479.8742106920909, 1481.3852251315705, 16786.1606919654, 17594.472165835014, 17606.38377656782, 17614.91192544039, 17634.294628214873, 17215.13924303783, 17268.740968885475, 17279.481615551522, 17393.565160870985, 17417.477475675718, 2897.3870980532092, 2915.183748550404, 2955.2907302247413, 2959.3489432324855, 2959.4672958867395, 2865.641794775653, 2903.9709602903913, 2927.970720292791, 2932.7067293270716, 2933.4866398380304, 2824.1386377155063, 2854.9143525694262, 2925.9853700731464, 2929.4726949149144, 2934.926626834325, 2919.7664186865104, 2938.76489880809, 2954.556816477535, 2954.9852250738822, 2955.113465960225, 2766.432881259337, 2861.957070643942, 2905.273681579605, 2908.4619345421165, 2922.956155657667, 16714.66570668592, 16832.663346732996, 16872.83127168737, 16919.3232270709, 16961.406350777663, 8591.398602097855, 8925.821483570357, 8926.330525210571, 8930.151635594608, 8933.6873209438, 5124.359455068116, 5315.069862773999, 5367.275417818583, 5390.5418039466695, 5487.204355368449, 2135.3700658305684, 2175.8912054397215, 2183.366823621164, 2187.0923566719794, 2237.496563273267, 30874.382512349628, 30984.690153098407, 31050.0, 31110.688893111233, 31238.53142202869, 7627.237276272328, 7721.884171737428, 7727.38180945523, 7906.5651389174145, 7911.920880791118, 20470.18119275242, 20640.69038964417, 20674.793252067586, 20763.68854467184, 20808.0, 8732.69435569752, 8880.289576833839, 8941.37410381267, 9008.234300084567, 9018.774530636787, 7792.727254546177, 7939.0, 8034.116247212802, 8214.301784348398, 8225.136360682041, 5760.596758226884, 5939.70301484924, 5992.43071908168, 6038.516918646497, 6043.0, 1746.4585978346754, 1782.6612943540686, 1790.7224380221087, 1809.2039502618807, 1812.664657038452, 956.0917128727737, 975.4244995452717, 988.4711679251566, 992.7766252593253, 1002.7643503776607, 8553.101924297984, 8620.439671421338, 8644.308455323559, 8709.738707838775, 8819.338549608805, 810.9432339736162, 811.9594020298962, 813.8697808350754, 816.6937398475571, 841.886345343383, 5145.9485405146215, 5470.56235501159, 5857.912131318034, 6030.547708921848, 6161.383861613893, 25082.247532574052, 25188.748112519006, 25663.871680641852, 25687.48625027489, 25720.614190787153, 24883.0, 24959.376015599755, 25104.0, 25536.744632553808, 25709.485810283688, 11322.26405283654, 11339.376334301527, 11567.305961642329, 11604.593839215755, 11617.186796924303, 8907.688230911886, 9035.774105647411, 9090.636374545209, 9106.0, 9306.0, 20472.59054818925, 21435.356939291847, 21803.127874884827, 21857.89071054698, 22239.22162724297, 22456.10175592958, 22661.88669056644, 22670.546589068457, 22721.431964201027, 22767.975441105522, 12803.0, 12877.420516076987, 12911.0, 13033.348332583144, 13045.673858153623, 15232.009919355207, 15250.618734531725, 15337.923310383376, 15396.0, 15448.227588620748, 11933.105017123577, 12037.398130093285, 12110.75778484443, 12228.87771122313, 12372.566960156351, 12346.888780009842, 12502.937485312515, 12520.749585008067, 12703.237805731686, 12806.935965320114, 10251.179905607385, 10441.738956526147, 10455.320404173704, 10455.529501172618, 10460.058594726512, 7881.802954926173, 7967.0, 8076.919230807852, 8077.151899050515, 8108.2297181767635, 8155.510669359857, 8227.42408031432, 8229.79425514367, 8247.381446391424, 8320.209580089882], "value": 7368.33268483301, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.4780126184542, 581.9679917604532, 584.0750158931976, 591.3317950715693, 598.1984141250723, 6286.9685651571735, 6364.618122912622, 6386.457151142153, 6397.121295417058, 6464.418202361787, 6330.430261276484, 6342.524310676695, 6345.682715864212, 6351.17434733484, 6364.427201551859, 5200.479952004788, 5211.322528071345, 5215.295935048758, 5222.686638801684, 5223.82463945613, 5104.64267501275, 5177.747679759298, 5231.293775340338, 5236.214567814839, 5264.184051472009, 5211.270422140903, 5257.973710131444, 5274.156135018397, 5289.788408463657, 5297.284866543006, 5158.690478571298, 5225.712585807779, 5259.579233661317, 5284.071313970411, 5284.63007589467, 4872.366592343008, 4872.9512704873205, 4886.706797592155, 4926.113299606105, 4955.628327875388, 6144.723487443076, 6157.0, 6180.752769889199, 6247.812565623039, 6310.873782524323, 6228.639952033549, 6260.217472815898, 6282.465990390822, 6291.5281353898645, 6318.368163183691, 6864.485163612749, 6877.449804015667, 6891.655417229119, 6896.724131034753, 6907.516473846833, 5538.75075621598, 5558.86102847428, 5561.221428999943, 5565.860853478655, 5568.016625120495, 6761.425278851254, 6900.585964842126, 6946.79159625207, 6994.860102797916, 7051.858962820715, 5682.886342273131, 5707.1724599933605, 5728.742206600713, 5729.598928074995, 5746.96554620164, 5788.652680839079, 5802.796902108406, 5818.359980402152, 5831.387704290988, 5861.88276234473, 6214.285357183981, 6225.28409232944, 6264.561480696308, 6269.185005949289, 6274.2784579773, 6805.727770889208, 6810.931890681129, 6821.283765204582, 6861.656917154122, 6861.931380686229, 2006.7190593316948, 2018.5256464730776, 2033.922021328698, 2034.7965203479534, 2037.2156719663037, 1444.285078885937, 1509.539590424909, 1532.3564103076735, 1532.4483186053012, 1546.5539720361498, 6163.630182189083, 6173.506119510428, 6237.688115594293, 6248.625082495065, 6263.96868015657, 6750.189977202669, 6809.216940051859, 6816.522843401013, 6847.0, 6872.41584465326, 6045.4281886708895, 6128.264608247039, 6184.9176394130845, 6214.502839772807, 6242.625442473466, 3557.2351944332095, 3582.390993531106, 3613.4941108244866, 3615.1323682316056, 3631.4371272452813, 6965.33829286217, 6994.125734283215, 7040.0, 7053.717851285891, 7089.82275443118, 6999.0551275577145, 7009.894851577231, 7010.789676309719, 7022.719091236293, 7036.169607143105, 7084.599392291729, 7140.5358651687475, 7161.069061022034, 7174.174969878531, 7178.605176715227, 6771.731469957423, 6773.627450490073, 6812.25065242813, 6830.624315662686, 6866.588004719732, 6686.197656281277, 6746.8650626988165, 6753.872530152986, 6811.727530898708, 6827.214870289781, 6875.58746475193, 6981.359380545467, 7006.9649651751415, 7011.789646310619, 7113.893291600527, 5615.522680572034, 5630.268065151504, 5649.209110724584, 5692.516136128475, 5692.686902220417, 6569.080328754074, 6659.500537459613, 6733.629650369081, 6787.524873258824, 6822.181338239443, 6541.280459149394, 6587.242467116152, 6617.139771829631, 6619.238787539494, 6645.906539440061, 6466.676666166579, 6494.74021039172, 6583.572067815577, 6606.054550904225, 6687.899681504879, 6303.590266632654, 6405.3594640535575, 6441.935580644134, 6575.572587781779, 6647.302033286435, 6630.436412904957, 6650.733970641314, 6696.665166741546, 6712.966435167793, 6736.225334086643, 6404.423601875854, 6508.186476690414, 6518.641474718936, 6530.934690653223, 6533.803985880431], "value": 5373.3759583744, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [956.6030097509533, 994.4033579852089, 994.8905620381752, 1000.4897502273841, 1023.3655133817032, 19466.51333716658, 19671.409857704257, 19819.50451238718, 19857.20571177155, 20014.799852001477, 17243.31026758928, 17967.460976170703, 18043.729344059815, 18265.36071237507, 18425.07874606271, 1032.726327523205, 1058.1957712138753, 1067.4822710985165, 1069.5828626835541, 1071.544593547743, 1052.884182739898, 1059.89930956559, 1064.2816099133092, 1073.7047311989188, 1088.9945550272237, 1110.3448965110583, 1149.9597514087009, 1150.350052220497, 1150.9079273658128, 1151.3782557418983, 1105.4748994227757, 1139.1854823800982, 1141.4235810915434, 1143.2568830260398, 1145.2613064573386, 809.8785182222714, 831.3723139030054, 837.0248660310731, 837.7738010737128, 837.9748607541784, 19792.109355079057, 19865.304714335074, 20007.899960500104, 20065.99670016508, 20159.0928408222, 22707.0, 22867.77132228673, 23321.067157313686, 23524.294271171893, 23550.175743848882, 17019.829801701948, 17165.656686866318, 17307.567310817205, 17314.65370692579, 17321.133943302786, 3887.4751908492276, 3906.1797022625283, 3907.1013666856497, 3908.3160446921675, 3909.6872250219913, 156991.0, 157469.0, 157781.0, 157990.0, 161025.0, 17656.293748250184, 17850.19674114668, 17875.642487150184, 17905.820941790676, 17921.910390447963, 34685.826570866986, 34760.304793904485, 35536.289274214374, 35635.643643563235, 35650.8217458911, 8449.662013519513, 8633.525156116348, 8651.697190598425, 8669.739907802776, 8747.16901894319, 4158.251514727318, 4203.915921681611, 4206.0, 4228.577142285747, 4249.447571815706, 6061.757529698851, 6094.542909281821, 6207.379262073757, 6215.627062376272, 6242.687865606792, 1082.1396989393293, 1095.7205912492263, 1114.8717897441736, 1117.8770335263114, 1117.9385133817718, 671.7245929169018, 692.9272426395257, 701.9438444924393, 705.2770909817376, 711.494838664554, 12636.620901372973, 12683.682907927376, 13118.344082795822, 13697.726045479034, 13698.315084245747, 641.2241188162376, 646.1470858466872, 650.3301599352675, 664.6776313487954, 666.2305037681485, 5827.446392592697, 5833.504152147115, 5834.299884013945, 5906.084556893688, 5982.0, 149483.0, 151076.0, 151372.0, 151556.0, 152085.0, 134283.32858335646, 137063.0, 138524.30737846246, 140762.2961885184, 142590.0, 110087.0, 111055.0, 111464.0, 113901.01346453, 113933.0, 10472.214583906085, 10825.188110891871, 10837.566497340018, 10862.456877156268, 10917.12662986975, 56182.438175619354, 56440.0, 56681.14978275412, 57300.0, 57909.0, 73664.0, 74931.62534187295, 75301.24698753162, 76134.0, 77787.0, 16747.581310467336, 16817.075060871768, 17037.57406064858, 17195.14024298805, 17211.741823872904, 16684.416045438353, 17005.319787208373, 17213.31146754116, 17361.652766944844, 17401.042942638276, 17483.950962942265, 17741.645167096845, 17884.731729024334, 18253.54366140804, 18259.360922367654, 15410.306536206122, 15653.295601698179, 15912.0, 15964.760528592313, 16029.759553606938, 15574.0, 15843.603909902346, 15894.52316430509, 16074.839251607802, 16211.594710132342, 12928.806067908801, 12933.611991640266, 12996.935015325242, 13269.535566255136, 13273.070885038342, 12031.578894738643, 12064.638060858188, 12360.876391236332, 12701.174423662802, 12754.107212495037], "value": 9645.005434632714, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1373.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 105.0, 107.0, 105.0, 106.0, 114.0, 106.0, 106.0, 105.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 113.0, 113.0, 156.0, 113.0, 111.0, 112.0, 111.0, 143.0], "value": 120.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 166.0, 165.0, 165.0, 162.0, 162.0, 166.0, 168.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 73.0, 73.0, 72.0, 72.0, 72.0, 83.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 82.0, 79.0, 77.0, 77.0, 78.0, 77.0, 77.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0, 112.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 149.0, 152.0, 151.0, 152.0, 152.0, 152.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 95.0, 94.0, 96.0, 94.0, 95.0, 96.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 43.0, 44.0, 45.0, 42.0, 42.0, 45.0, 44.0, 43.0], "value": 43.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 38.0, 37.0, 38.0, 38.0, 37.0, 38.0, 38.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 68.0, 67.0, 68.0, 70.0, 79.0, 70.0, 69.0, 72.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 114.0, 108.0, 111.0, 104.0, 104.0, 110.0, 102.0, 106.0], "value": 108.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 148.0, 148.0, 152.0, 149.0, 154.0, 149.0, 149.0, 160.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 62.0, 58.0, 59.0, 57.0, 60.0, 58.0, 62.0], "value": 59.5, "unit": "score"}]}]} 12:40:46 INFO - Return code: 0 12:40:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:40:46 INFO - # TBPL SUCCESS # 12:40:46 INFO - Running post-action listener: _package_coverage_data 12:40:46 INFO - Running post-action listener: _resource_record_post_action 12:40:46 INFO - [mozharness: 2017-10-03 19:40:46.791494Z] Finished run-tests step (success) 12:40:46 INFO - Running post-run listener: _resource_record_post_run 12:40:46 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 331317248; Read time: 8; Write time: 234504 12:40:46 INFO - TinderboxPrint: CPU usage
13.1% 12:40:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:40:46 INFO - TinderboxPrint: I/O write bytes / time
331,317,248 / 234,504 12:40:46 INFO - TinderboxPrint: CPU idle
8,197.1 (86.9%) 12:40:46 INFO - TinderboxPrint: CPU user
1,187.7 (12.6%) 12:40:46 INFO - TinderboxPrint: Swap in / out
0 / 0 12:40:46 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12517376; Read time: 0; Write time: 1144 12:40:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:40:46 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318185472; Read time: 8; Write time: 233360 12:40:47 INFO - Running post-run listener: _upload_blobber_files 12:40:47 INFO - Blob upload gear active. 12:40:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:40:47 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:40:47 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:40:47 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:40:47 INFO - (blobuploader) - INFO - Open directory for files ... 12:40:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:40:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:40:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:48 INFO - (blobuploader) - INFO - Done attempting. 12:40:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:40:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:40:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:49 INFO - (blobuploader) - INFO - Done attempting. 12:40:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:40:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:40:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:57 INFO - (blobuploader) - INFO - Done attempting. 12:40:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:40:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:40:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:58 INFO - (blobuploader) - INFO - Done attempting. 12:40:58 INFO - (blobuploader) - INFO - Iteration through files over. 12:40:58 INFO - Return code: 0 12:40:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:40:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:40:58 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bf8902bc4639e0de23b53d75f01f133ee21d6a3d5c14e5429c7e6b81bef4196af9dd39ade412757dc2e0b4710154f4048e4b7bcf3bef7b72f6b64fe6dad0323", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5b78a382e36f9a88e0a906446e2eccba359848f8689a45418ff1a80ab9e946c9735084a1afb0ce61266a3335d85a815c5da84dfde2cd1228dd5df288a129dae", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/604202ad998c9a09aefadbbad83ed908848e752c08462fa138b6e69d1d3aa2dc9ec75cf4a104bc60fe4a61237fc63f82cd6fe25659f2a718acf7735fa66ecd07", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0681d7795a0d42f80735fcb608d0444a807614edd1ad75dc2a909443a2f4702f25d46a0e7d7a53bcf4b5b3357ba495c519ed7a6d36657fc779b6a1f1588c6f71"} 12:40:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:40:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:40:58 INFO - Contents: 12:40:58 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bf8902bc4639e0de23b53d75f01f133ee21d6a3d5c14e5429c7e6b81bef4196af9dd39ade412757dc2e0b4710154f4048e4b7bcf3bef7b72f6b64fe6dad0323", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5b78a382e36f9a88e0a906446e2eccba359848f8689a45418ff1a80ab9e946c9735084a1afb0ce61266a3335d85a815c5da84dfde2cd1228dd5df288a129dae", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/604202ad998c9a09aefadbbad83ed908848e752c08462fa138b6e69d1d3aa2dc9ec75cf4a104bc60fe4a61237fc63f82cd6fe25659f2a718acf7735fa66ecd07", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0681d7795a0d42f80735fcb608d0444a807614edd1ad75dc2a909443a2f4702f25d46a0e7d7a53bcf4b5b3357ba495c519ed7a6d36657fc779b6a1f1588c6f71"} 12:40:58 INFO - Running post-run listener: copy_logs_to_upload_dir 12:40:58 INFO - Copying logs to upload dir... 12:40:58 INFO - mkdir: /builds/slave/test/build/upload/logs 12:40:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.416859 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-10-03 12:40:59.016054) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 12:40:59.021202) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921 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/0bf8902bc4639e0de23b53d75f01f133ee21d6a3d5c14e5429c7e6b81bef4196af9dd39ade412757dc2e0b4710154f4048e4b7bcf3bef7b72f6b64fe6dad0323", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5b78a382e36f9a88e0a906446e2eccba359848f8689a45418ff1a80ab9e946c9735084a1afb0ce61266a3335d85a815c5da84dfde2cd1228dd5df288a129dae", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/604202ad998c9a09aefadbbad83ed908848e752c08462fa138b6e69d1d3aa2dc9ec75cf4a104bc60fe4a61237fc63f82cd6fe25659f2a718acf7735fa66ecd07", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0681d7795a0d42f80735fcb608d0444a807614edd1ad75dc2a909443a2f4702f25d46a0e7d7a53bcf4b5b3357ba495c519ed7a6d36657fc779b6a1f1588c6f71"} build_url:https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/Dq8jydmSRL6tZ237UTvWrg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bf8902bc4639e0de23b53d75f01f133ee21d6a3d5c14e5429c7e6b81bef4196af9dd39ade412757dc2e0b4710154f4048e4b7bcf3bef7b72f6b64fe6dad0323", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5b78a382e36f9a88e0a906446e2eccba359848f8689a45418ff1a80ab9e946c9735084a1afb0ce61266a3335d85a815c5da84dfde2cd1228dd5df288a129dae", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/604202ad998c9a09aefadbbad83ed908848e752c08462fa138b6e69d1d3aa2dc9ec75cf4a104bc60fe4a61237fc63f82cd6fe25659f2a718acf7735fa66ecd07", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0681d7795a0d42f80735fcb608d0444a807614edd1ad75dc2a909443a2f4702f25d46a0e7d7a53bcf4b5b3357ba495c519ed7a6d36657fc779b6a1f1588c6f71"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 12:40:59.049206) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:40:59.049524) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1507058423.797551-1243833921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:40:59.137328) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 12:40:59.137635) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 12:40:59.138099) ========= ========= Total master_lag: 0.21 =========