builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-027 starttime: 1505405452.81 results: success (0) revision: ef0f1085d54eae99d62bbf039952b0deb84f396d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:52.813609) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:52.814074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:52.814710) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:52.865776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:52.866174) ========= 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=1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 09:10:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-09-14 09:10:52 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.180205 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:53.071764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:53.072039) ========= 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=1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020177 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:53.125832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:53.128678) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ef0f1085d54eae99d62bbf039952b0deb84f396d --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 ef0f1085d54eae99d62bbf039952b0deb84f396d --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=1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 09:10:52,811 truncating revision to first 12 chars 2017-09-14 09:10:52,812 Setting DEBUG logging. 2017-09-14 09:10:52,812 attempt 1/10 2017-09-14 09:10:52,812 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ef0f1085d54e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 09:10:53,157 unpacking tar archive at: mozilla-central-ef0f1085d54e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673867 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:53.835436) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:53.835772) ========= script_repo_revision: ef0f1085d54eae99d62bbf039952b0deb84f396d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:53.836192) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:53.836504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 09:10:53.863310) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-14 09:10:53.863721) ========= /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=1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:10:53 INFO - MultiFileLogger online at 20170914 09:10:53 in /builds/slave/test 09:10:53 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 09:10:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:10:53 INFO - {'append_to_log': False, 09:10:53 INFO - 'base_work_dir': '/builds/slave/test', 09:10:53 INFO - 'blob_upload_branch': 'Firefox', 09:10:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:10:53 INFO - 'branch': 'Firefox', 09:10:53 INFO - 'buildbot_json_path': 'buildprops.json', 09:10:53 INFO - 'code_coverage': False, 09:10:53 INFO - 'config_files': ('talos/linux_config.py',), 09:10:53 INFO - 'default_actions': ('clobber', 09:10:53 INFO - 'read-buildbot-config', 09:10:53 INFO - 'download-and-extract', 09:10:53 INFO - 'populate-webroot', 09:10:53 INFO - 'create-virtualenv', 09:10:53 INFO - 'install', 09:10:53 INFO - 'setup-mitmproxy', 09:10:53 INFO - 'run-tests'), 09:10:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:10:53 INFO - 'disable_ccov_upload': False, 09:10:53 INFO - 'disable_stylo': False, 09:10:53 INFO - 'download_minidump_stackwalk': True, 09:10:53 INFO - 'download_symbols': 'ondemand', 09:10:53 INFO - 'enable_stylo': False, 09:10:53 INFO - 'enable_webrender': False, 09:10:53 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 09:10:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:10:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:10:53 INFO - 'gecko_profile': False, 09:10:53 INFO - 'gecko_profile_interval': 0, 09:10:53 INFO - 'installer_path': 'installer.exe', 09:10:53 INFO - 'log_level': 'info', 09:10:53 INFO - 'log_name': 'talos', 09:10:53 INFO - 'log_to_console': True, 09:10:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:10:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:10:53 INFO - 'opt_config_files': (), 09:10:53 INFO - 'pip_index': False, 09:10:53 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 09:10:53 INFO - 'system_bits': '32', 09:10:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:10:53 INFO - 'title': 'talos-linux64-ix-027', 09:10:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:10:53 INFO - 'use_talos_json': True, 09:10:53 INFO - 'verify': 'False', 09:10:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:10:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:10:53 INFO - 'work_dir': 'build'} 09:10:53 INFO - [mozharness: 2017-09-14 16:10:53.772298Z] Running clobber step. 09:10:53 INFO - Running pre-action listener: _resource_record_pre_action 09:10:53 INFO - Running main action method: clobber 09:10:53 INFO - rmtree: /builds/slave/test/build 09:10:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:10:54 INFO - Running post-action listener: _resource_record_post_action 09:10:54 INFO - [mozharness: 2017-09-14 16:10:54.758778Z] Finished clobber step (success) 09:10:54 INFO - [mozharness: 2017-09-14 16:10:54.758875Z] Running read-buildbot-config step. 09:10:54 INFO - Running pre-action listener: _resource_record_pre_action 09:10:54 INFO - Running main action method: read_buildbot_config 09:10:54 INFO - Using buildbot properties: 09:10:54 INFO - { 09:10:54 INFO - "project": "", 09:10:54 INFO - "product": "firefox", 09:10:54 INFO - "who": "ryanvm@gmail.com", 09:10:54 INFO - "installer_path": "public/build/target.tar.bz2", 09:10:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 09:10:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 09:10:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 09:10:54 INFO - "stage_platform": "linux64-pgo", 09:10:54 INFO - "basedir": "/builds/slave/test", 09:10:54 INFO - "buildnumber": 13, 09:10:54 INFO - "platform": "ubuntu64_hw", 09:10:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:10:54 INFO - "slavebuilddir": "test", 09:10:54 INFO - "taskId": "CjCGk_hmRnOPQA971NFZfw", 09:10:54 INFO - "branch": "mozilla-central", 09:10:54 INFO - "script_repo_revision": "production", 09:10:54 INFO - "revision": "ef0f1085d54eae99d62bbf039952b0deb84f396d", 09:10:54 INFO - "slavename": "talos-linux64-ix-027", 09:10:54 INFO - "repo_path": "mozilla-central" 09:10:54 INFO - } 09:10:54 INFO - Finding installer, test and symbols from parent task. 09:10:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CjCGk_hmRnOPQA971NFZfw'}, attempt #1 09:10:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CjCGk_hmRnOPQA971NFZfw'}, attempt #1 09:10:56 INFO - Task dependencies: DlSqvLEzQ-iruS7YzEiCNQ 09:10:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ'}, attempt #1 09:10:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.tar.bz2 09:10:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.test_packages.json 09:10:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.crashreporter-symbols.zip 09:10:56 INFO - Running post-action listener: _resource_record_post_action 09:10:56 INFO - [mozharness: 2017-09-14 16:10:56.813276Z] Finished read-buildbot-config step (success) 09:10:56 INFO - [mozharness: 2017-09-14 16:10:56.813495Z] Running download-and-extract step. 09:10:56 INFO - Running pre-action listener: _resource_record_pre_action 09:10:56 INFO - Running main action method: download_and_extract 09:10:56 INFO - mkdir: /builds/slave/test/build/tests 09:10:56 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')]} 09:10:56 INFO - trying https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.test_packages.json 09:10:56 INFO - Downloading https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:10:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:10:57 INFO - Downloaded 989 bytes. 09:10:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:10:57 INFO - Using the following test package requirements: 09:10:57 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:10:57 INFO - u'common': [u'target.common.tests.zip'], 09:10:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:10:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:10:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:10:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:10:57 INFO - u'mozbase': [u'target.common.tests.zip'], 09:10:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:10:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:10:57 INFO - u'web-platform': [u'target.common.tests.zip', 09:10:57 INFO - u'target.web-platform.tests.tar.gz'], 09:10:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:10:57 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 09:10:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.common.tests.zip 09:10:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:10:57 INFO - Fetch https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.common.tests.zip into memory 09:10:59 INFO - Content-Length response header: 55192496 09:10:59 INFO - Bytes received: 55192496 09:11:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.talos.tests.zip 09:11:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:11:10 INFO - Fetch https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.talos.tests.zip into memory 09:11:11 INFO - Content-Length response header: 14500356 09:11:11 INFO - Bytes received: 14500356 09:11:11 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')]} 09:11:11 INFO - trying https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.tar.bz2 09:11:11 INFO - Downloading https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:11:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:11:16 INFO - Downloaded 62251787 bytes. 09:11:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.tar.bz2 09:11:16 INFO - mkdir: /builds/slave/test/properties 09:11:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:11:16 INFO - Writing to file /builds/slave/test/properties/build_url 09:11:16 INFO - Contents: 09:11:16 INFO - build_url:https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.tar.bz2 09:11:16 INFO - Running post-action listener: _resource_record_post_action 09:11:16 INFO - Running post-action listener: find_tests_for_verification 09:11:16 INFO - Running post-action listener: set_extra_try_arguments 09:11:16 INFO - [mozharness: 2017-09-14 16:11:16.467055Z] Finished download-and-extract step (success) 09:11:16 INFO - [mozharness: 2017-09-14 16:11:16.467300Z] Running populate-webroot step. 09:11:16 INFO - Running pre-action listener: _resource_record_pre_action 09:11:16 INFO - Running main action method: populate_webroot 09:11:16 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:11:16 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:11:16 INFO - 'tests': ['tresize', 09:11:16 INFO - 'tcanvasmark']}, 09:11:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:11:16 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:11:16 INFO - 'tests': ['dromaeo_css', 09:11:16 INFO - 'kraken']}, 09:11:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:11:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:16 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:11:16 INFO - 'talos_options': ['--disable-stylo'], 09:11:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:11:16 INFO - 'tests': ['damp', 'tps']}, 09:11:16 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:11:16 INFO - 'talos_options': ['--disable-stylo'], 09:11:16 INFO - 'tests': ['damp', 'tps']}, 09:11:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:11:16 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:11:16 INFO - 'tests': ['dromaeo_dom']}, 09:11:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:11:16 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:11:16 INFO - 'tests': ['basic_compositor_video', 09:11:16 INFO - 'glvideo']}, 09:11:16 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:11:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:11:16 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:11:16 INFO - 'talos_options': ['--disable-stylo'], 09:11:16 INFO - 'tests': ['ts_paint_webext', 09:11:16 INFO - 'tp5o_webext']}, 09:11:16 INFO - 'other-e10s': {'tests': ['a11yr', 09:11:16 INFO - 'ts_paint', 09:11:16 INFO - 'tpaint', 09:11:16 INFO - 'sessionrestore', 09:11:16 INFO - 'sessionrestore_many_windows', 09:11:16 INFO - 'sessionrestore_no_auto_restore', 09:11:16 INFO - 'tabpaint']}, 09:11:16 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:11:16 INFO - 'tests': ['a11yr', 09:11:16 INFO - 'ts_paint', 09:11:16 INFO - 'tpaint', 09:11:16 INFO - 'sessionrestore', 09:11:16 INFO - 'sessionrestore_many_windows', 09:11:16 INFO - 'sessionrestore_no_auto_restore', 09:11:16 INFO - 'tabpaint']}, 09:11:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:11:16 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 09:11:16 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:11:16 INFO - 'tests': ['bloom_basic_singleton']}, 09:11:16 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:11:16 INFO - 'tests': ['bloom_basic']}, 09:11:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:11:16 INFO - 'tsvgr_opacity', 09:11:16 INFO - 'tart', 09:11:16 INFO - 'tscrollx', 09:11:16 INFO - 'tsvg_static']}, 09:11:16 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:11:16 INFO - 'tests': ['tsvgx', 09:11:16 INFO - 'tsvgr_opacity', 09:11:16 INFO - 'tart', 09:11:16 INFO - 'tscrollx', 09:11:16 INFO - 'tsvg_static']}, 09:11:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:11:16 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:11:16 INFO - 'talos_options': ['--disable-stylo'], 09:11:16 INFO - 'tests': ['tp5o']}, 09:11:16 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:11:16 INFO - 'talos_options': ['--mitmproxy', 09:11:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:11:16 INFO - '--firstNonBlankPaint'], 09:11:16 INFO - 'tests': ['tp6_google', 09:11:16 INFO - 'tp6_youtube', 09:11:16 INFO - 'tp6_amazon', 09:11:16 INFO - 'tp6_facebook']}, 09:11:16 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:11:16 INFO - 'talos_options': ['--disable-stylo', 09:11:16 INFO - '--mitmproxy', 09:11:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:11:16 INFO - '--firstNonBlankPaint'], 09:11:16 INFO - 'tests': ['tp6_google', 09:11:16 INFO - 'tp6_youtube', 09:11:16 INFO - 'tp6_amazon', 09:11:16 INFO - 'tp6_facebook']}, 09:11:16 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:11:16 INFO - 'talos_options': ['--stylo-threads=1', 09:11:16 INFO - '--mitmproxy', 09:11:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:11:16 INFO - '--firstNonBlankPaint'], 09:11:16 INFO - 'tests': ['tp6_google', 09:11:16 INFO - 'tp6_youtube', 09:11:16 INFO - 'tp6_amazon', 09:11:16 INFO - 'tp6_facebook']}, 09:11:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:11:16 INFO - 'talos_options': ['--xperf_path', 09:11:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:16 INFO - 'tests': ['tp5n']}, 09:11:16 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:11:16 INFO - 'talos_options': ['--disable-stylo', 09:11:16 INFO - '--xperf_path', 09:11:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:16 INFO - 'tests': ['tp5n']}}} 09:11:16 INFO - Running post-action listener: _resource_record_post_action 09:11:16 INFO - [mozharness: 2017-09-14 16:11:16.482347Z] Finished populate-webroot step (success) 09:11:16 INFO - [mozharness: 2017-09-14 16:11:16.482437Z] Running create-virtualenv step. 09:11:16 INFO - Running pre-action listener: _resource_record_pre_action 09:11:16 INFO - Running main action method: create_virtualenv 09:11:16 INFO - Creating virtualenv /builds/slave/test/build/venv 09:11:16 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:11:16 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 09:11:16 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:11:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:11:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:11:17 INFO - Installing distribute.............................................................................................................................................................................................done. 09:11:17 INFO - Installing pip...............done. 09:11:17 INFO - Return code: 0 09:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:11:17 INFO - Reading from file tmpfile_stdout 09:11:17 INFO - Output received: 09:11:17 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 09:11:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:17 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 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ada60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b1090>, '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 0x22b1d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22abf90>, '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': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', '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 09:11:17 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 09:11:17 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 09:11:17 INFO - Using env: {'DISPLAY': ':0', 09:11:17 INFO - 'HOME': '/home/cltbld', 09:11:17 INFO - 'LANG': 'en_US.UTF-8', 09:11:17 INFO - 'LANGUAGE': 'en_US:en', 09:11:17 INFO - 'LOGNAME': 'cltbld', 09:11:17 INFO - 'MAIL': '/var/mail/cltbld', 09:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:17 INFO - 'MOZ_NO_REMOTE': '1', 09:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:17 INFO - 'NO_EM_RESTART': '1', 09:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:17 INFO - 'PWD': '/builds/slave/test', 09:11:17 INFO - 'SHELL': '/bin/bash', 09:11:17 INFO - 'SHLVL': '1', 09:11:17 INFO - 'TERM': 'linux', 09:11:17 INFO - 'TMOUT': '86400', 09:11:17 INFO - 'USER': 'cltbld', 09:11:17 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', 09:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:17 INFO - '_': '/tools/buildbot/bin/python'} 09:11:19 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:11:19 INFO - Downloading/unpacking pip>=1.5 09:11:19 INFO - Running setup.py egg_info for package pip 09:11:19 INFO - warning: no files found matching 'pip/cacert.pem' 09:11:19 INFO - warning: no files found matching '*.html' under directory 'docs' 09:11:19 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:11:19 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:11:19 INFO - Installing collected packages: pip 09:11:19 INFO - Found existing installation: pip 1.1 09:11:19 INFO - Uninstalling pip: 09:11:19 INFO - Successfully uninstalled pip 09:11:19 INFO - Running setup.py install for pip 09:11:19 INFO - warning: no files found matching 'pip/cacert.pem' 09:11:19 INFO - warning: no files found matching '*.html' under directory 'docs' 09:11:19 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:11:19 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:11:19 INFO - Installing pip script to /builds/slave/test/build/venv/bin 09:11:19 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 09:11:19 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 09:11:19 INFO - Successfully installed pip 09:11:19 INFO - Cleaning up... 09:11:19 INFO - Return code: 0 09:11:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:11:19 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')]} 09:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:19 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')]} 09:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:19 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 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ada60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b1090>, '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 0x22b1d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22abf90>, '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': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', '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 09:11:19 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 09:11:19 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 09:11:19 INFO - Using env: {'DISPLAY': ':0', 09:11:19 INFO - 'HOME': '/home/cltbld', 09:11:19 INFO - 'LANG': 'en_US.UTF-8', 09:11:19 INFO - 'LANGUAGE': 'en_US:en', 09:11:19 INFO - 'LOGNAME': 'cltbld', 09:11:19 INFO - 'MAIL': '/var/mail/cltbld', 09:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:19 INFO - 'MOZ_NO_REMOTE': '1', 09:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:19 INFO - 'NO_EM_RESTART': '1', 09:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:19 INFO - 'PWD': '/builds/slave/test', 09:11:19 INFO - 'SHELL': '/bin/bash', 09:11:19 INFO - 'SHLVL': '1', 09:11:19 INFO - 'TERM': 'linux', 09:11:19 INFO - 'TMOUT': '86400', 09:11:19 INFO - 'USER': 'cltbld', 09:11:19 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', 09:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:19 INFO - '_': '/tools/buildbot/bin/python'} 09:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:20 INFO - Downloading/unpacking psutil>=3.1.1 09:11:20 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 09:11:20 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 09:11:20 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 09:11:20 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 09:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:11:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:21 INFO - Installing collected packages: psutil 09:11:21 INFO - Running setup.py install for psutil 09:11:21 INFO - building 'psutil._psutil_linux' extension 09:11:21 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 09:11:22 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 09:11:22 INFO - building 'psutil._psutil_posix' extension 09:11:22 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 09:11:22 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 09:11:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:22 INFO - Successfully installed psutil 09:11:22 INFO - Cleaning up... 09:11:22 INFO - Return code: 0 09:11:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ada60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b1090>, '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 0x22b1d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22abf90>, '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': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', '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 09:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:11:22 INFO - Using env: {'DISPLAY': ':0', 09:11:22 INFO - 'HOME': '/home/cltbld', 09:11:22 INFO - 'LANG': 'en_US.UTF-8', 09:11:22 INFO - 'LANGUAGE': 'en_US:en', 09:11:22 INFO - 'LOGNAME': 'cltbld', 09:11:22 INFO - 'MAIL': '/var/mail/cltbld', 09:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:22 INFO - 'MOZ_NO_REMOTE': '1', 09:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:22 INFO - 'NO_EM_RESTART': '1', 09:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:22 INFO - 'PWD': '/builds/slave/test', 09:11:22 INFO - 'SHELL': '/bin/bash', 09:11:22 INFO - 'SHLVL': '1', 09:11:22 INFO - 'TERM': 'linux', 09:11:22 INFO - 'TMOUT': '86400', 09:11:22 INFO - 'USER': 'cltbld', 09:11:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', 09:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:22 INFO - '_': '/tools/buildbot/bin/python'} 09:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:11:24 INFO - Installing collected packages: mozsystemmonitor 09:11:24 INFO - Running setup.py install for mozsystemmonitor 09:11:24 INFO - Successfully installed mozsystemmonitor 09:11:24 INFO - Cleaning up... 09:11:24 INFO - Return code: 0 09:11:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ada60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b1090>, '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 0x22b1d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22abf90>, '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': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', '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 09:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:11:24 INFO - Using env: {'DISPLAY': ':0', 09:11:24 INFO - 'HOME': '/home/cltbld', 09:11:24 INFO - 'LANG': 'en_US.UTF-8', 09:11:24 INFO - 'LANGUAGE': 'en_US:en', 09:11:24 INFO - 'LOGNAME': 'cltbld', 09:11:24 INFO - 'MAIL': '/var/mail/cltbld', 09:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:24 INFO - 'MOZ_NO_REMOTE': '1', 09:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:24 INFO - 'NO_EM_RESTART': '1', 09:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:24 INFO - 'PWD': '/builds/slave/test', 09:11:24 INFO - 'SHELL': '/bin/bash', 09:11:24 INFO - 'SHLVL': '1', 09:11:24 INFO - 'TERM': 'linux', 09:11:24 INFO - 'TMOUT': '86400', 09:11:24 INFO - 'USER': 'cltbld', 09:11:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', 09:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:24 INFO - '_': '/tools/buildbot/bin/python'} 09:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:24 INFO - Downloading/unpacking jsonschema==2.5.1 09:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:11:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:11:26 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 09:11:26 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 09:11:26 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 09:11:26 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 09:11:26 INFO - Downloading functools32-3.2.3-2.tar.gz 09:11:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:11:26 INFO - warning: no files found matching '*.txt' 09:11:26 INFO - no previously-included directories found matching 'build' 09:11:26 INFO - no previously-included directories found matching 'dist' 09:11:26 INFO - no previously-included directories found matching '.git*' 09:11:26 INFO - Installing collected packages: jsonschema, functools32 09:11:26 INFO - Running setup.py install for functools32 09:11:26 INFO - warning: no files found matching '*.txt' 09:11:26 INFO - no previously-included directories found matching 'build' 09:11:26 INFO - no previously-included directories found matching 'dist' 09:11:26 INFO - no previously-included directories found matching '.git*' 09:11:26 INFO - Successfully installed jsonschema functools32 09:11:26 INFO - Cleaning up... 09:11:26 INFO - Return code: 0 09:11:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ada60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b1090>, '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 0x22b1d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22abf90>, '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': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', '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 09:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:11:26 INFO - Using env: {'DISPLAY': ':0', 09:11:26 INFO - 'HOME': '/home/cltbld', 09:11:26 INFO - 'LANG': 'en_US.UTF-8', 09:11:26 INFO - 'LANGUAGE': 'en_US:en', 09:11:26 INFO - 'LOGNAME': 'cltbld', 09:11:26 INFO - 'MAIL': '/var/mail/cltbld', 09:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:26 INFO - 'MOZ_NO_REMOTE': '1', 09:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:26 INFO - 'NO_EM_RESTART': '1', 09:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:26 INFO - 'PWD': '/builds/slave/test', 09:11:26 INFO - 'SHELL': '/bin/bash', 09:11:26 INFO - 'SHLVL': '1', 09:11:26 INFO - 'TERM': 'linux', 09:11:27 INFO - 'TMOUT': '86400', 09:11:27 INFO - 'USER': 'cltbld', 09:11:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', 09:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:27 INFO - '_': '/tools/buildbot/bin/python'} 09:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:11:27 INFO - Cleaning up... 09:11:27 INFO - Return code: 0 09:11:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:11:27 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')]} 09:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:27 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')]} 09:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:27 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 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ada60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b1090>, '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 0x22b1d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22abf90>, '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': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', '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 09:11:27 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 09:11:27 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 09:11:27 INFO - Using env: {'DISPLAY': ':0', 09:11:27 INFO - 'HOME': '/home/cltbld', 09:11:27 INFO - 'LANG': 'en_US.UTF-8', 09:11:27 INFO - 'LANGUAGE': 'en_US:en', 09:11:27 INFO - 'LOGNAME': 'cltbld', 09:11:27 INFO - 'MAIL': '/var/mail/cltbld', 09:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:27 INFO - 'MOZ_NO_REMOTE': '1', 09:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:27 INFO - 'NO_EM_RESTART': '1', 09:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:27 INFO - 'PWD': '/builds/slave/test', 09:11:27 INFO - 'SHELL': '/bin/bash', 09:11:27 INFO - 'SHLVL': '1', 09:11:27 INFO - 'TERM': 'linux', 09:11:27 INFO - 'TMOUT': '86400', 09:11:27 INFO - 'USER': 'cltbld', 09:11:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', 09:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:27 INFO - '_': '/tools/buildbot/bin/python'} 09:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:27 INFO - Downloading/unpacking blobuploader==1.2.4 09:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:28 INFO - Downloading blobuploader-1.2.4.tar.gz 09:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:11:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:11:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:29 INFO - Downloading docopt-0.6.1.tar.gz 09:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:11:29 INFO - Installing collected packages: blobuploader, requests, docopt 09:11:29 INFO - Running setup.py install for blobuploader 09:11:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:11:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:11:29 INFO - Running setup.py install for requests 09:11:29 INFO - Running setup.py install for docopt 09:11:29 INFO - Successfully installed blobuploader requests docopt 09:11:29 INFO - Cleaning up... 09:11:29 INFO - Return code: 0 09:11:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:29 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 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ada60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b1090>, '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 0x22b1d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22abf90>, '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': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', '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 09:11:29 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 09:11:29 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 09:11:29 INFO - Using env: {'DISPLAY': ':0', 09:11:29 INFO - 'HOME': '/home/cltbld', 09:11:29 INFO - 'LANG': 'en_US.UTF-8', 09:11:29 INFO - 'LANGUAGE': 'en_US:en', 09:11:29 INFO - 'LOGNAME': 'cltbld', 09:11:29 INFO - 'MAIL': '/var/mail/cltbld', 09:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:29 INFO - 'MOZ_NO_REMOTE': '1', 09:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:29 INFO - 'NO_EM_RESTART': '1', 09:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:29 INFO - 'PWD': '/builds/slave/test', 09:11:29 INFO - 'SHELL': '/bin/bash', 09:11:29 INFO - 'SHLVL': '1', 09:11:29 INFO - 'TERM': 'linux', 09:11:29 INFO - 'TMOUT': '86400', 09:11:29 INFO - 'USER': 'cltbld', 09:11:29 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', 09:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:29 INFO - '_': '/tools/buildbot/bin/python'} 09:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:29 INFO - Running setup.py (path:/tmp/pip-dzUvtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:29 INFO - Running setup.py (path:/tmp/pip-z9298t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:30 INFO - Running setup.py (path:/tmp/pip-jpih6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:30 INFO - Running setup.py (path:/tmp/pip-LhTToR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:30 INFO - Running setup.py (path:/tmp/pip-WeDdLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:30 INFO - Running setup.py (path:/tmp/pip-7zP7yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:30 INFO - Running setup.py (path:/tmp/pip-0izZv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:30 INFO - Running setup.py (path:/tmp/pip-v_ugc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:30 INFO - Running setup.py (path:/tmp/pip-SZmjcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:30 INFO - Running setup.py (path:/tmp/pip-vqUHiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:30 INFO - Running setup.py (path:/tmp/pip-QgyE_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:30 INFO - Running setup.py (path:/tmp/pip-Po2I75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:30 INFO - Running setup.py (path:/tmp/pip-vN4Yqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:30 INFO - Running setup.py (path:/tmp/pip-O1sre2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:30 INFO - Running setup.py (path:/tmp/pip-iBsnpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:30 INFO - Running setup.py (path:/tmp/pip-qtrstr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:31 INFO - Running setup.py (path:/tmp/pip-oBHXqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:11:31 INFO - Running setup.py install for manifestparser 09:11:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:11:31 INFO - Running setup.py install for mozcrash 09:11:31 INFO - Running setup.py install for mozdebug 09:11:31 INFO - Running setup.py install for mozdevice 09:11:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:11:31 INFO - Running setup.py install for mozfile 09:11:31 INFO - Running setup.py install for mozhttpd 09:11:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:11:31 INFO - Running setup.py install for mozinfo 09:11:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:11:31 INFO - Running setup.py install for mozInstall 09:11:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:11:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:11:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:11:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:11:31 INFO - Running setup.py install for mozleak 09:11:31 INFO - Running setup.py install for mozlog 09:11:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:11:32 INFO - Running setup.py install for moznetwork 09:11:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:11:32 INFO - Running setup.py install for mozprocess 09:11:32 INFO - Running setup.py install for mozprofile 09:11:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:11:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:11:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:11:32 INFO - Running setup.py install for mozrunner 09:11:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:11:32 INFO - Running setup.py install for mozscreenshot 09:11:32 INFO - Running setup.py install for moztest 09:11:32 INFO - Running setup.py install for mozversion 09:11:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:11:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:11:32 INFO - Cleaning up... 09:11:32 INFO - Return code: 0 09:11:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:32 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 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ada60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b1090>, '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 0x22b1d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22abf90>, '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': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', '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 09:11:32 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 09:11:32 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 09:11:32 INFO - Using env: {'DISPLAY': ':0', 09:11:32 INFO - 'HOME': '/home/cltbld', 09:11:32 INFO - 'LANG': 'en_US.UTF-8', 09:11:32 INFO - 'LANGUAGE': 'en_US:en', 09:11:32 INFO - 'LOGNAME': 'cltbld', 09:11:32 INFO - 'MAIL': '/var/mail/cltbld', 09:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:32 INFO - 'MOZ_NO_REMOTE': '1', 09:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:32 INFO - 'NO_EM_RESTART': '1', 09:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:32 INFO - 'PWD': '/builds/slave/test', 09:11:32 INFO - 'SHELL': '/bin/bash', 09:11:32 INFO - 'SHLVL': '1', 09:11:32 INFO - 'TERM': 'linux', 09:11:32 INFO - 'TMOUT': '86400', 09:11:32 INFO - 'USER': 'cltbld', 09:11:32 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', 09:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:32 INFO - '_': '/tools/buildbot/bin/python'} 09:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:33 INFO - Running setup.py (path:/tmp/pip-qGXWYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:33 INFO - Running setup.py (path:/tmp/pip-_IMlZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:33 INFO - Running setup.py (path:/tmp/pip-JWyi4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:33 INFO - Running setup.py (path:/tmp/pip-G4uXLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:33 INFO - Running setup.py (path:/tmp/pip-8JLLrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:33 INFO - Running setup.py (path:/tmp/pip-jmiCQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:33 INFO - Running setup.py (path:/tmp/pip-9ejrrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:33 INFO - Running setup.py (path:/tmp/pip-cDFxG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:33 INFO - Running setup.py (path:/tmp/pip-gQxjo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:33 INFO - Running setup.py (path:/tmp/pip-cYwSEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:33 INFO - Running setup.py (path:/tmp/pip-BbIIhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:33 INFO - Running setup.py (path:/tmp/pip-BAlJah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:33 INFO - Running setup.py (path:/tmp/pip-SnVT8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:34 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)) 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:34 INFO - Running setup.py (path:/tmp/pip-JPBb49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:34 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)) 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:34 INFO - Running setup.py (path:/tmp/pip-LQZDU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:34 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)) 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:34 INFO - Running setup.py (path:/tmp/pip-rmMSGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:34 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)) 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:34 INFO - Running setup.py (path:/tmp/pip-jY2tl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:34 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)) 09:11:34 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)) 09:11:34 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)) 09:11:34 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)) 09:11:34 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)) 09:11:34 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)) 09:11:34 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)) 09:11:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:11:34 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 09:11:34 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 09:11:34 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 09:11:34 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 09:11:35 INFO - Downloading blessings-1.6.tar.gz 09:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:11:35 INFO - Installing collected packages: blessings 09:11:35 INFO - Running setup.py install for blessings 09:11:35 INFO - Successfully installed blessings 09:11:35 INFO - Cleaning up... 09:11:35 INFO - Return code: 0 09:11:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:11:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:35 INFO - Reading from file tmpfile_stdout 09:11:35 INFO - Current package versions: 09:11:35 INFO - argparse == 1.2.1 09:11:35 INFO - blessings == 1.6 09:11:35 INFO - blobuploader == 1.2.4 09:11:35 INFO - docopt == 0.6.1 09:11:35 INFO - functools32 == 3.2.3-2 09:11:35 INFO - jsonschema == 2.5.1 09:11:35 INFO - manifestparser == 1.1 09:11:35 INFO - mozInstall == 1.13 09:11:35 INFO - mozcrash == 1.0 09:11:35 INFO - mozdebug == 0.1 09:11:35 INFO - mozdevice == 0.51 09:11:35 INFO - mozfile == 1.2 09:11:35 INFO - mozhttpd == 0.7 09:11:35 INFO - mozinfo == 0.10 09:11:35 INFO - mozleak == 0.1 09:11:35 INFO - mozlog == 3.5 09:11:35 INFO - moznetwork == 0.27 09:11:35 INFO - mozprocess == 0.25 09:11:35 INFO - mozprofile == 0.28 09:11:35 INFO - mozrunner == 6.13 09:11:35 INFO - mozscreenshot == 0.1 09:11:35 INFO - mozsystemmonitor == 0.3 09:11:35 INFO - moztest == 0.8 09:11:35 INFO - mozversion == 1.4 09:11:35 INFO - psutil == 3.1.1 09:11:35 INFO - requests == 1.2.3 09:11:35 INFO - wsgiref == 0.1.2 09:11:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:35 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')]} 09:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:35 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')]} 09:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:35 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 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ada60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b1090>, '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 0x22b1d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22abf90>, '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': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', '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 09:11:35 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 09:11:35 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 09:11:35 INFO - Using env: {'DISPLAY': ':0', 09:11:35 INFO - 'HOME': '/home/cltbld', 09:11:35 INFO - 'LANG': 'en_US.UTF-8', 09:11:35 INFO - 'LANGUAGE': 'en_US:en', 09:11:35 INFO - 'LOGNAME': 'cltbld', 09:11:35 INFO - 'MAIL': '/var/mail/cltbld', 09:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:35 INFO - 'MOZ_NO_REMOTE': '1', 09:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:35 INFO - 'NO_EM_RESTART': '1', 09:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:35 INFO - 'PWD': '/builds/slave/test', 09:11:35 INFO - 'SHELL': '/bin/bash', 09:11:35 INFO - 'SHLVL': '1', 09:11:35 INFO - 'TERM': 'linux', 09:11:35 INFO - 'TMOUT': '86400', 09:11:35 INFO - 'USER': 'cltbld', 09:11:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', 09:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:35 INFO - '_': '/tools/buildbot/bin/python'} 09:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:36 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)) 09:11:36 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)) 09:11:36 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)) 09:11:36 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)) 09:11:36 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)) 09:11:36 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)) 09:11:36 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)) 09:11:36 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)) 09:11:36 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)) 09:11:36 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:11:37 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)) 09:11:37 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)) 09:11:37 INFO - Installing collected packages: simplejson 09:11:37 INFO - Running setup.py install for simplejson 09:11:37 INFO - building 'simplejson._speedups' extension 09:11:37 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 09:11:38 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 09:11:38 INFO - Successfully installed simplejson 09:11:38 INFO - Cleaning up... 09:11:38 INFO - Return code: 0 09:11:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ada60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b1090>, '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 0x22b1d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22abf90>, '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': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', '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 09:11:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:11:38 INFO - Using env: {'DISPLAY': ':0', 09:11:38 INFO - 'HOME': '/home/cltbld', 09:11:38 INFO - 'LANG': 'en_US.UTF-8', 09:11:38 INFO - 'LANGUAGE': 'en_US:en', 09:11:38 INFO - 'LOGNAME': 'cltbld', 09:11:38 INFO - 'MAIL': '/var/mail/cltbld', 09:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:38 INFO - 'MOZ_NO_REMOTE': '1', 09:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:38 INFO - 'NO_EM_RESTART': '1', 09:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:38 INFO - 'PWD': '/builds/slave/test', 09:11:38 INFO - 'SHELL': '/bin/bash', 09:11:38 INFO - 'SHLVL': '1', 09:11:38 INFO - 'TERM': 'linux', 09:11:38 INFO - 'TMOUT': '86400', 09:11:38 INFO - 'USER': 'cltbld', 09:11:38 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', 09:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:38 INFO - '_': '/tools/buildbot/bin/python'} 09:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:11:38 INFO - Cleaning up... 09:11:38 INFO - Return code: 0 09:11:38 INFO - Running post-action listener: _resource_record_post_action 09:11:38 INFO - Running post-action listener: _start_resource_monitoring 09:11:38 INFO - Starting resource monitoring. 09:11:38 INFO - [mozharness: 2017-09-14 16:11:38.634823Z] Finished create-virtualenv step (success) 09:11:38 INFO - [mozharness: 2017-09-14 16:11:38.635829Z] Running install step. 09:11:38 INFO - Running pre-action listener: _resource_record_pre_action 09:11:38 INFO - Running main action method: install 09:11:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:38 INFO - Reading from file tmpfile_stdout 09:11:38 INFO - Detecting whether we're running mozinstall >=1.0... 09:11:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:11:38 INFO - Reading from file tmpfile_stdout 09:11:38 INFO - Output received: 09:11:38 INFO - Usage: mozinstall [options] installer 09:11:38 INFO - Options: 09:11:38 INFO - -h, --help show this help message and exit 09:11:38 INFO - -d DEST, --destination=DEST 09:11:38 INFO - Directory to install application into. [default: 09:11:38 INFO - "/builds/slave/test"] 09:11:38 INFO - --app=APP Application being installed. [default: firefox] 09:11:38 INFO - mkdir: /builds/slave/test/build/application 09:11:38 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'] 09:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:11:56 INFO - Reading from file tmpfile_stdout 09:11:56 INFO - Output received: 09:11:56 INFO - /builds/slave/test/build/application/firefox/firefox 09:11:56 INFO - Running post-action listener: _resource_record_post_action 09:11:56 INFO - [mozharness: 2017-09-14 16:11:56.561973Z] Finished install step (success) 09:11:56 INFO - [mozharness: 2017-09-14 16:11:56.562311Z] Running setup-mitmproxy step. 09:11:56 INFO - Running pre-action listener: _resource_record_pre_action 09:11:56 INFO - Running main action method: setup_mitmproxy 09:11:56 INFO - Skipping: mitmproxy is not required 09:11:56 INFO - Running post-action listener: _resource_record_post_action 09:11:56 INFO - [mozharness: 2017-09-14 16:11:56.563985Z] Finished setup-mitmproxy step (success) 09:11:56 INFO - [mozharness: 2017-09-14 16:11:56.564298Z] Running run-tests step. 09:11:56 INFO - Running pre-action listener: _resource_record_pre_action 09:11:56 INFO - Running pre-action listener: _set_gcov_prefix 09:11:56 INFO - Running main action method: run_tests 09:11:56 WARNING - Try message not found. 09:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:11:56 INFO - Python 2.7.3 09:11:56 INFO - Return code: 0 09:11:56 INFO - grabbing minidump binary from tooltool 09:11:56 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')]} 09:11:56 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 0x22b1090>, '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 0x22b1d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22abf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:11:56 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 09:11:56 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 09:11:56 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 09:11:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:11:56 INFO - Return code: 0 09:11:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:11:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:11:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:11:56 INFO - ENV: RUST_BACKTRACE is now full 09:11:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:11:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:11:56 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/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 09:11:56 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/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 09:11:56 INFO - Using env: {'DISPLAY': ':0', 09:11:56 INFO - 'HOME': '/home/cltbld', 09:11:56 INFO - 'LANG': 'en_US.UTF-8', 09:11:56 INFO - 'LANGUAGE': 'en_US:en', 09:11:56 INFO - 'LOGNAME': 'cltbld', 09:11:56 INFO - 'MAIL': '/var/mail/cltbld', 09:11:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:11:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:56 INFO - 'MOZ_NO_REMOTE': '1', 09:11:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:56 INFO - 'NO_EM_RESTART': '1', 09:11:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:56 INFO - 'PWD': '/builds/slave/test', 09:11:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:11:56 INFO - 'RUST_BACKTRACE': 'full', 09:11:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:11:56 INFO - 'SHELL': '/bin/bash', 09:11:56 INFO - 'SHLVL': '1', 09:11:56 INFO - 'TERM': 'linux', 09:11:56 INFO - 'TMOUT': '86400', 09:11:56 INFO - 'USER': 'cltbld', 09:11:56 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', 09:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:56 INFO - '_': '/tools/buildbot/bin/python'} 09:11:56 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/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 09:11:56 INFO - mozversion application_buildid: 20170914145054 09:11:56 INFO - mozversion application_changeset: ef0f1085d54eae99d62bbf039952b0deb84f396d 09:11:56 INFO - mozversion application_display_name: Nightly 09:11:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:11:56 INFO - mozversion application_name: Firefox 09:11:56 INFO - mozversion application_remotingname: firefox 09:11:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:11:56 INFO - mozversion application_vendor: Mozilla 09:11:56 INFO - mozversion application_version: 57.0a1 09:11:56 INFO - mozversion platform_buildid: 20170914145054 09:11:56 INFO - mozversion platform_changeset: ef0f1085d54eae99d62bbf039952b0deb84f396d 09:11:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:11:56 INFO - mozversion platform_version: 57.0a1 09:11:56 INFO - using testdate: 1505405516 09:11:56 INFO - actual date: 1505405516 09:11:56 INFO - starting webserver on 'localhost:57126' 09:11:56 INFO - SUITE-START | Running 2 tests 09:11:56 INFO - TEST-START | dromaeo_css 09:11:56 INFO - Initialising browser for dromaeo_css test... 09:11:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57126/getInfo.html -profile /tmp/tmpAc3b9p/profile 09:11:56 INFO - TEST-INFO | started process 3560 (/builds/slave/test/build/application/firefox/firefox http://localhost:57126/getInfo.html) 09:12:04 INFO - TEST-INFO | 3560: exit 0 09:12:04 INFO - Browser initialized. 09:12:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:12:04 INFO - Using env: {'DISPLAY': ':0', 09:12:04 INFO - 'HOME': '/home/cltbld', 09:12:04 INFO - 'JSGC_DISABLE_POISONING': '1', 09:12:04 INFO - 'LANG': 'en_US.UTF-8', 09:12:04 INFO - 'LANGUAGE': 'en_US:en', 09:12:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:12:04 INFO - 'LOGNAME': 'cltbld', 09:12:04 INFO - 'MAIL': '/var/mail/cltbld', 09:12:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:12:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:12:04 INFO - 'MOZ_CRASHREPORTER': '1', 09:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:12:04 INFO - 'MOZ_NO_REMOTE': '1', 09:12:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:04 INFO - 'NO_EM_RESTART': '1', 09:12:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:04 INFO - 'PWD': '/builds/slave/test', 09:12:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:12:04 INFO - 'RUST_BACKTRACE': 'full', 09:12:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:12:04 INFO - 'SHELL': '/bin/bash', 09:12:04 INFO - 'SHLVL': '1', 09:12:04 INFO - 'STYLO_FORCE_DISABLED': '1', 09:12:04 INFO - 'TERM': 'linux', 09:12:04 INFO - 'TMOUT': '86400', 09:12:04 INFO - 'USER': 'cltbld', 09:12:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', 09:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:04 INFO - '_': '/tools/buildbot/bin/python'} 09:12:04 INFO - TEST-INFO | started process 3800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAc3b9p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:05 INFO - PID 3800 | 09:12:05 INFO - PID 3800 | (/builds/slave/test/build/application/firefox/firefox:3849): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:12:05 INFO - PID 3800 | 09:12:16 INFO - PID 3800 | RSS: Main: 164503552 09:12:16 INFO - PID 3800 | 09:15:12 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:57126/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57126/tests/dromaeo/cssquery-ext.html) 09:15:13 INFO - PID 3800 | RSS: Main: 168341504 09:15:13 INFO - PID 3800 | 09:18:15 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:57126/tests/dromaeo/cssquery-ext.html (next: http://localhost:57126/tests/dromaeo/cssquery-jquery.html) 09:18:16 INFO - PID 3800 | RSS: Main: 164986880 09:18:16 INFO - PID 3800 | 09:21:17 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:57126/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57126/tests/dromaeo/cssquery-mootools.html) 09:21:18 INFO - PID 3800 | RSS: Main: 167129088 09:21:18 INFO - PID 3800 | 09:24:19 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:57126/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57126/tests/dromaeo/cssquery-prototype.html) 09:24:20 INFO - PID 3800 | RSS: Main: 165756928 09:24:20 INFO - PID 3800 | 09:27:23 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:57126/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57126/tests/dromaeo/cssquery-yui.html) 09:27:24 INFO - PID 3800 | RSS: Main: 167251968 09:27:24 INFO - PID 3800 | 09:30:25 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:57126/tests/dromaeo/cssquery-yui.html (next: http://localhost:57126/tests/dromaeo/cssquery-dojo.html) 09:30:25 INFO - PID 3800 | RSS: Main: 170004480 09:30:25 INFO - PID 3800 | 09:30:25 INFO - PID 3800 | __start_tp_report 09:30:25 INFO - PID 3800 | _x_x_mozilla_page_load 09:30:25 INFO - PID 3800 | _x_x_mozilla_page_load_details 09:30:25 INFO - PID 3800 | |i|pagename|runs| 09:30:25 INFO - PID 3800 | |0;dojo.html;3810.237952409518;3814;3840.615938406159;3842.884713458597;3858.305505009099;6154.169187159732;6187.133801267821;6188.721507532161;6252.874942501147;6285.528585356105;6155.476784473314;6246.219222597176;6292.779752708645;6333.904991425133;6344.460720838734;5535.778568857261;5642.351129620105;5653.575981801381;5654.773809047633;5673.375928647845;304.3981663519042;5327.840164795043;5563.693996830173;5645;5649.802256921009;5501.119820828668;5580.218769372291;5613.550915926737;5638.041532939369;5648.4633959773755;5541.972290138564;5582.497575218209;5606.299212598426;5627.971860140673;5676.744546495376;5546.694931778791;5558.972205138948;5590.664560126405;5641.717914104278;5642.7178641067785;6148.415900489446;6174.598651087665;6184.350643182491;6278.560500764948;6306.49548036156;6689.899651505231;6757.966210168917;6765;6767.018782276592;6769.627670478122;6785.898211526831;6790.219124800662;6795.626240556768;6798.558093723942;6800.319968003209;6216.036514340284;6303.180586523723;6371.076193951851;6395.97664373698;6400.807975760735;6766.18805743314;6825.1127353443735;6894;6901.068355772007;6919.238883722786;6612.636305003175;6692.79921602343;6697.866042679119;6699.162604674416;6701.765438209639;6728.495362847806;6729.764458243938;6734.090897728842;6824.965875170592;6828.078209441662;6581.14445122131;6718.731250750013;6722.193336799518;6722.630255336004;6753.527253092237;6714.697838597275;6715.4291885190305;6719.731210751613;6723.193216813916;6733.124693789776;4917.311576379309;4956.5786908112495;4971.229459433794;4981.178105612534;5004.799808007639;4489.910201795946;4538.341940418621;4541.091781643684;4548.272276435754;4556.0432309214775;6238.313785483593;6256.405641464054;6335.493160547145;6354.777582784581;6363.427291543783;6661.26726060133;6736.932630673728;6740.090087838177;6744.190697116377;6760.797176084725;6221.191245138103;6227.408396202353;6235.875282494325;6239.563230573907;6320.273168585672;5497.505224529811;5516.834494965157;5519.116941289374;5519.834404967857;5541.2796336476;7064.046353742282;7073.893891591631;7137.785866424016;7159.821004474929;7171.031910692094;6646.335366463315;6782.9321706783285;6784.559003664746;6870.106886104774;6871.415929645936;6923.169219693669;6937.549059311129;6959.373656370951;6972.30276972319;7025.613591252326;6631.0716499689115;6673.099131617169;6768.627725475146;6785.355391237825;6788.558743681645;6715.563488373436;6738.932610674026;6776.051352810709;6869.244383117953;6880.415164711056;6376.808695739135;6465.321141280097;6492;6492.74029038852;6559.672016399257;6532.771353002622;6549.345065493412;6561.507886908596;6574.342565743387;6581.407673309425;6242.438180563771;6358.046293056079;6421.229452465734;6465.482761378984;6476.643784591893;6465.741370345321;6480.222373315232;6484.416402523795;6569.981652843817;6570.737170513126;6228.439440450381;6265.8120256392385;6324.525660575383;6370.617762934239;6410.358964103552 09:30:25 INFO - PID 3800 | |1;ext.html;937.6390089815427;950.70052933326;976.7704589421486;1002.0280328081758;1002.3084071990326;43346.56653433465;43641.12717745643;44264;45160.54839451609;45215.321770173476;44999;45240.3213951791;45256.09487810242;45593;45647.543524564746;8124.796880077986;8195.139510351417;8219.630116644736;8251.216134467217;8277.793055173608;8196.221358970888;8227.465214761021;8244.83510329793;8310.750677479686;8311.418200725951;8270.462419942685;8307.210814972597;8316.293115085226;8324.625391857351;8330.541820199887;8193.46742461738;8258.504489730636;8311.83376332476;8319.708810191645;8324.167583241657;8118.228768267005;8191.262786349198;8192.303654189402;8206.302464290542;8210.30212431944;40440.19119617591;40737;40788.38817417741;40796.59203407987;40882.182356353005;3799.67702745267;3806.5812760596314;3808.409696497047;3828.674562662177;3835.9424608630893;33036.834815826005;33070.17324566881;33159.83420082884;33210.667893321;33244;5268.262443257947;5462.808801691922;5522.641028333145;5526.309211348582;5595.160725891108;205975.99999999852;206234;206378;207782;207930;51311;51430;51436.485635143166;52010.219846702326;52969.470305296454;55095.449045509835;55407.72296138574;55434.445655543735;55463.72268138634;55540;16349.34602615882;16481.587960301087;16486.75269870953;16495.257713402927;16661.166941652868;13277.93361033208;13452.798208026887;13466;13471.12437691547;13499.797503037462;16055.759163612554;16068.517944461684;16228.918855405884;16249.918750406172;16317.673646527002;6348.206474190726;6372.107904893226;6392.328805475358;6418.903716444257;6432.935670643234;1041.099448976645;1062.0653824634273;1067.412922892406;1076.3488089705772;1080.5137688040413;24708;24904.99328336233;25184.874075629505;25264.115755948453;25388.984440622167;1124.8144056230794;1138.1293310617384;1140.1790710688292;1153.6654370232707;1161.297415063891;13151.60545183646;13170.670733231555;13282.53511127106;13292.933535332262;13331;274916;276631;294370;294674;295475;52060.21909671358;52203;52234.47765522372;53678.19482707763;53833;1470.8161479815024;1484.5175318021686;1515.4695856450155;1524.6188452886556;1536.5774412036778;24171.274861754177;24695.753042469347;24765.62851557192;24915.127970520945;25030.123945661813;39444;40148;40214.1957160861;40258;40276.597234027286;224259;229954;230066;230399;230798;38859.417108742826;38870.41694374643;39184.412233817086;39204.21591568096;39440.40839387469;47128.52871471241;47421;47580.7620961893;47605;47755.5224447765;34400.65599344075;34740.305193896485;34907.30185396227;35206.47190292097;35392.29215415729;33918;34188.65811341855;34453.13867153241;34516.82741586276;34868.302633946674;40936.79531602323;41006;41063.38404923988;41195.1760964785;41322.380164296956;33381.99854004384;33402.83298583492;33537.83231083829;33617;34705.95882123541;24801.751982479946;25158;25490.362740931625;25501.872490637426;25699.232665116368 09:30:25 INFO - PID 3800 | |2;jquery.html;595.9868224019168;597.2325561653271;599.007955263459;601.2364297342375;623.3984205241941;22921.656175157364;24099.277021689333;24185.516289674197;24273.150439734614;24273.39316517088;24927.37681557962;26281.474370512577;26408.339791505223;26440.73559264407;26462.470750585024;6606.570572912769;6784.491163162757;6804.047433359334;6806.489513286499;6810.148731408574;6470.417662410382;6493.707783149746;6549.541532092755;6731.326867313254;6859.897101543481;6720.361565651279;6745.4940879434;6798;6835.213950395693;6838.384545390913;6629.204495460527;6799.456043516507;6799.7280108795585;6812.14848143982;6823.317668233187;6348.492120630339;6360.650164240965;6374.553781235315;6381.8085457436355;6423.4861211103;29612;30030.699693003007;30213.69786302131;30240.8487957561;30302.69697303043;2289.4848659051745;2290.0496294037953;2324.1633012115626;2326.3486223857176;2328.4528135888054;18577.16402761879;18736.437906862815;20792.792072079235;20863;20909.163633454642;2588.1588483742858;2592.961105583418;2635.934101647455;2647.6293318935363;2648.8543130127837;138665.306673466;144220;144406;144438.2778086103;150705.24647376692;15115.546533604009;15897.28462219203;16179.595510112105;16449;16941.152942352834;25133.12034078835;25213.11754088598;25233.369165770637;25238.621420678704;25276.241712748648;10512.894871051192;10609.15126789855;10632.681019569425;10667.093297069836;10779.407132607781;9746.75633109178;9860.359076659994;9891.554880030415;9938.204943604638;9996.700098997042;9758.804823903482;9868.457234852152;9874.950625246827;10002.299839011199;10032.749181270381;2921.7516511096796;2956;2984.4180384825186;3021.0634703242067;3027.2431892026993;1038.1642777563982;1053.8735351757684;1058.7723639417409;1071.2822408985999;1072.8927107289364;20961;21501.784982149977;21621.918904054735;21725.891370543362;21747.23884664061;1108.772701596171;1120.1822669451346;1120.865496140452;1122.5341483284346;1128.9322640641424;11641.88358116425;11673.708157295965;11821.172517923835;11891.464884080064;12017.939910300393;551422;560765;564409;566105;588716;125240;125523.3723831375;125811;126644.36677816552;127358.36320818336;1092.251807511857;1241.3420886929941;1241.5964811436138;1263.3746295583744;1271.7075072733323;21871.12515499362;21921.451963701034;21955.451113722283;21959.34121976343;22396;60347.39652603418;60779.69610151921;61157;62933.370666294584;65344;78712.2128778705;79124.20875791168;79255;79589.60205198936;79722.6013869927;15187.848121518644;15516.689666206386;15619.297131628877;15743.606409839846;15806.130662813195;23666.645000324665;24224.636630450204;24259.393515161555;24325.39186520351;24731.752682473663;19954;19980.800191997892;20098.79901200969;20114.69254498453;20149.697754533987;16188.514344569681;16516.83483165153;17595.20821563007;17645.558861028578;18119.094045297945;19619.901900490408;20124.899375503028;20251.79748202499;20550.794492054887;20682.689759653917;15388.076715397112;15413;15538.766918496005;15556.222188890284;15609.375624975328;19560.21759129619;19660;19689.704654430483;19725.210991560176;19727.506812329808 09:30:25 INFO - PID 3800 | |3;mootools.html;1406.8241469816273;1487.3753023730033;1524.3064405695402;1534.1255484373899;1535.2016951185383;16936.23786929588;17599.384021559246;17602.911985440056;17666.293348266056;17674.64650706987;17181.484555463358;17228.741568876478;17243.74134387985;17322;17394.39119630813;2841.7300356466103;2868.9713102868964;2918.751906087985;2922.78079144064;2929.209113539354;2666.693330267015;2713.864306784653;2722.9591556126675;2724.1691284158323;2725.6729192496828;2679.54447743884;2796.8182068165606;2872.698366671501;2879.640044994376;2892.2191008427712;2852.657681078263;2856.8143070700544;2859.127965970378;2887.971120288791;2890.913272601825;2641.220839852248;2712.593111033341;2717.7689896358834;2825.1242114944225;2832.8441935693527;16739.07935063571;16830.915845420695;16847.32610695571;16923.238454269464;16926.23831927566;8521.616527256288;8733.475991440533;8778.166074222938;8813.338999575057;8814.427062240933;5952.553558483131;5978.760849566012;6045.093236014589;6185.8144255672405;6232.065190221458;2148.8074118864024;2153.601583707019;2155.415769409483;2164.188429338998;2202.4451636102044;29973.550396744067;30277.091687249416;30283.242918926982;30295.848520757256;30389;7250.60121693312;7339.486235963538;7347.485676002735;7486.962565187248;7544.660490277951;19421;19432;19435.51411214731;19444.70832937507;19447.416577502696;8365.121662225378;8454.61954212062;8464.619092140869;8466.026406963156;8472.534010629475;7381.630918454056;7720.53676779395;7787.06555213378;7876.330511906552;7876.881846772303;5308.761105750251;5348.090824559834;5391.191321301836;5425.430329815392;5455.8090466834265;1543.3055125193707;1554.518099389193;1568.215892053973;1571.905685658864;1575.6297270141508;911.384815249717;948.9762755931018;950.7528042708807;951.5908159491347;956.9569369378395;8202.917970820336;9295.90704092964;9345.439273643467;9438.150566449052;9579.281553883488;741.5661837824933;783.169839969634;783.5925318834288;795.4471642208609;802.7310850865026;5345.118055520873;5658.547316214693;5852.678102704307;5866.061430171152;6016.669083200466;24203.39491512691;24673.25980220596;24875.62686559703;25131.49737005286;25170;24777.25668229956;24805.875970620033;25092.372690682878;25099.49801004006;25137.120200792884;11577.826332605018;11862.169648124722;11960.58137965167;12061.216020958609;12151.453184606715;9062.546872656472;9221.769455763659;9224.077592240723;9315.16163545257;9339.486328252011;20448.79551204469;20519.897400512902;20566.897165514674;20599.4850128742;20929.790702092785;22003.889980549993;22050.88974555117;22132.22537211254;22160.77839221587;22438.88780556152;12030.518779248732;12314.261144331369;12320.383980800745;12324.876751232732;12328.81506777381;15323.693526129193;15405.306761195998;15724.842751572338;15726.528204153894;15789.842101578837;11549.769004620028;11743.119266055252;11946.462409191434;12052.457639406073;12125.151239413157;12241.816372754594;12249.265044097383;12649.494020239088;12660.746785064062;12787.424565894371;10566.101881340172;10787;10795.082417994245;10804.729881753019;10811.027007569357;7424.298246487576;7526.962365188139;7550.8867366990635;7557.584332861746;7617.390608751176;7865.134835168013;7886.211378862068;7892.960535197517;7960.084590272193;8018.1180070193395 09:30:25 INFO - PID 3800 | |4;prototype.html;535.6732393240122;552.0311852698519;555.1949672974188;567.4621774989778;577.1746402644219;6220.720067596958;6253.1870856788555;6301.9054714179265;6323.241211054674;6360.395762402564;6060.272767267923;6135.386461353863;6254.906176407346;6302.968485157568;6325.620462772225;5051.6716413433005;5058.595312375001;5059.139946209135;5065.746712664352;5065.848024559269;4994.750262486879;4998.125328067592;5034.748262586874;5069.467705890884;5082.567981721558;4820.614350851941;4952.554270115689;4956.7025978441225;4990.625703072266;5016.197408414654;4934.481879402683;4939.653664509347;4955.876103097434;4959.900801983977;4980.975095124501;4455.665825063101;4477.417935668374;4490.640748740093;4499.797509112098;4507.782898617388;5897.351291357947;5975.282966044059;6011.30869949957;6030.914435401626;6091.604045737057;5731.681713205944;5806.65160090396;5851.582055548077;5859.560532960002;5870.178175055453;6577.473802095821;6581.638009909453;6635.767748128841;6668.6332251726135;6709.456824930245;5058.898822023539;5062.4684408137355;5080.491950804927;5084.491550844923;5095.541401273866;6783.660816959133;6809.182898052216;6889;6932.757353492603;6960.234374218882;5187.221916712448;5187.662801917863;5189.818356357509;5191.428942816287;5203.843884683465;5219.686818790885;5257.553107985787;5258.39528454225;5278.340207474066;5281.075811733008;5807.361190269067;5822.689894773642;5826.592138550261;5838;5861.17943487912;6676.86646267072;6678.198616166092;6684.899726504106;6698;6715.4291885190305;1794.8743587948718;1800.7929088154767;1814.7550080738931;1826.5707558723689;1830.5240637434097;1235.4274371546526;1243.8320826688282;1275.1775105057372;1283.3519072868141;1283.8202651628778;6045.969770151209;6077.878442431215;6092.72582733778;6142.938570614237;6149.846253843601;6516.609003459807;6629.337066293332;6644.202695676453;6657.833554161088;6714.381391257413;5927.8221653350465;6126.663033533109;6126.93433500831;6135.386461353829;6223.595466294767;3475.8957231283102;3497.527833742463;3514.7363947704025;3521.207728261172;3535.876244331436;6761.72953081881;6826.829329266808;6905.482088843357;6911.136107986502;6944.722211111499;6637.668116594247;6674.23246326669;6757.526973111835;6809.38715515606;6876.243613202544;6850.45196384298;6858.3827455529245;6896.2069362023;6923.169219693568;7029.718811247493;6610.867782644224;6707.8993815091835;6718.496112791462;6729.697163627747;6737.629430381376;6550;6603.457668797451;6603.9339606605245;6614.570052946543;6626.072349870926;6789.694463749044;6924.853295478418;6932.202796678446;6947.40947019509;7075.292470752884;5073.720945348041;5147.562457191031;5152.201408781495;5171.45699701541;5191.6884986900905;6472.449841763503;6716.361945615354;6716.5634233774645;6729.865402692017;6798.694058767466;6346.301906790157;6518.2504012037325;6547.803565893031;6551.836204094936;6567.31043240472;6505.8698826024165;6528.281888992112;6531.934680653323;6532.804015879531;6546.443552298108;6372.362763723776;6395.968020160056;6438.259600146043;6454.128692626623;6467.047923482181;6269.216347956505;6424;6524.771632992823;6525.771597994048;6638.369354911276;6445.778919075564;6458;6475.222973243241;6494.545381823227;6506.25178104524 09:30:25 INFO - PID 3800 | |5;yui.html;943.2124176312778;960.9567569459375;977.3744803325868;984.8571957066221;999.0309399882112;19516.707249391253;20039;20170.89914550427;20240.69638955415;20314.89842550789;17740.201690923906;17939.64120717585;17951.820481795177;18744;18914.054297285114;1030.567161792049;1064.1433645915035;1065.0893486069415;1065.3288428290166;1065.3341661461586;1049.4647729657854;1083.3175099687226;1085.0288991352734;1088.080571916729;1091.9181061420386;1135.4379582106828;1137.0676045642576;1137.7895089408444;1137.9886201137965;1137.9943100284488;1061.2093989977438;1092.2900114925283;1136.6987748246722;1142.2004596782244;1142.7028972467176;813.5240884082818;813.894193754814;814.2712272516065;815.514768712615;815.9061707903548;20671.58656826855;20985.26551570703;21149.25977590792;21179.576408471898;21198.788012119836;22077.448063798372;23563.17528886498;23710;23735.643965340532;23753.287401377987;17639.118044097744;17980.820191798175;18134.727979080326;18140.818591814044;18175.909120454315;3983.322835118037;4024.3762216856435;4042.090529630839;4042.636162745367;4044.8382064717375;149007.25496372557;150179;150941.2452937739;153104;154147.22926385296;17685;17716.557086072953;17909.10454477271;17942.730859037125;18047.458576242734;31841;32371.35257294841;32392.83803580967;32601.18497037593;32613;8865.778355541162;9018;9038.81922361549;9043.954780226057;9048.276137908952;4735.195016847144;4805.495422980537;4824.372831531879;4828.975855120772;4833.516648335139;6234.064890266496;6241.687915604201;6242.656653883989;6286.968565157145;6296.338884417162;1157.774234024374;1177.1112809828696;1193.3913704011018;1195.1036722458157;1200.609801814414;688.1363888320126;697.5849369625065;709.4714437743913;711.8789805733038;722.3354513847273;12182.451789669487;13095.476180952846;13557.864421355858;14256.928715356356;14259.78610320846;688.198249039863;688.3426327856885;695.9826004349932;698.4656737595743;711.3597762014228;6144.262688477412;6338.8415289617205;6355.5551111421755;6408.359164083555;6432.035194720829;141844.29077854753;145255;145315;146465;147545;122174;122717;123902.9999999982;125252.37373813073;128349.35825321;110626.44686776676;111320;111662;112106;114704;11194.384308863091;11281;11330.886691132982;11636.12729045342;11641.76716465649;54341.641458963844;54779.452205477435;54857.45142548523;55608;55816.16275755786;74229.62885185539;74248;74778.62610686912;75000.62499687467;75461;17015.82984170192;17186.226619801888;17250.309987600354;17394.130293485527;17415.825841741927;19460.1242944065;19666.90166549158;19819.504512387306;19895.900520497304;19977.400677979684;16061.919690401473;16139.515814525583;16197.51407457778;16218.10800405989;16241.431549895697;17141.400050998156;17218;17230.913845430692;17319.307227711255;17398.913005434893;16967.151642417582;17069.48791536256;17168.39910603123;17260.827391726423;17480.47558573245;12162.452689628812;12509.124361294622;12563.93718031404;12566.748665026465;12575;13609.931950340186;13719.188627632493;13773.449062037405;13884.236366999912;13922.095063821225 09:30:25 INFO - PID 3800 | __end_tp_report 09:30:25 INFO - PID 3800 | __start_cc_report 09:30:25 INFO - PID 3800 | _x_x_mozilla_cycle_collect,356 09:30:25 INFO - PID 3800 | __end_cc_report 09:30:25 INFO - PID 3800 | __startTimestamp1505406625697__endTimestamp 09:30:25 INFO - PID 3800 | 09:30:25 INFO - PID 3800 | ------- Summary: start ------- 09:30:25 INFO - PID 3800 | Number of tests: 6 09:30:25 INFO - PID 3800 | 09:30:25 INFO - PID 3800 | [#0] dojo.html Cycles:165 Average:6183.50 Median:6410.36 stddev:862.55 (13.5%) stddev-sans-first:844.86 09:30:25 INFO - PID 3800 | Values: 3810.2 3814.0 3840.6 3842.9 3858.3 6154.2 6187.1 6188.7 6252.9 6285.5 6155.5 6246.2 6292.8 6333.9 6344.5 5535.8 5642.4 5653.6 5654.8 5673.4 304.4 5327.8 5563.7 5645.0 5649.8 5501.1 5580.2 5613.6 5638.0 5648.5 5542.0 5582.5 5606.3 5628.0 5676.7 5546.7 5559.0 5590.7 5641.7 5642.7 6148.4 6174.6 6184.4 6278.6 6306.5 6689.9 6758.0 6765.0 6767.0 6769.6 6785.9 6790.2 6795.6 6798.6 6800.3 6216.0 6303.2 6371.1 6396.0 6400.8 6766.2 6825.1 6894.0 6901.1 6919.2 6612.6 6692.8 6697.9 6699.2 6701.8 6728.5 6729.8 6734.1 6825.0 6828.1 6581.1 6718.7 6722.2 6722.6 6753.5 6714.7 6715.4 6719.7 6723.2 6733.1 4917.3 4956.6 4971.2 4981.2 5004.8 4489.9 4538.3 4541.1 4548.3 4556.0 6238.3 6256.4 6335.5 6354.8 6363.4 6661.3 6736.9 6740.1 6744.2 6760.8 6221.2 6227.4 6235.9 6239.6 6320.3 5497.5 5516.8 5519.1 5519.8 5541.3 7064.0 7073.9 7137.8 7159.8 7171.0 6646.3 6782.9 6784.6 6870.1 6871.4 6923.2 6937.5 6959.4 6972.3 7025.6 6631.1 6673.1 6768.6 6785.4 6788.6 6715.6 6738.9 6776.1 6869.2 6880.4 6376.8 6465.3 6492.0 6492.7 6559.7 6532.8 6549.3 6561.5 6574.3 6581.4 6242.4 6358.0 6421.2 6465.5 6476.6 6465.7 6480.2 6484.4 6570.0 6570.7 6228.4 6265.8 6324.5 6370.6 6410.4 09:30:25 INFO - PID 3800 | 09:30:25 INFO - PID 3800 | [#1] ext.html Cycles:180 Average:42046.68 Median:3832.31 stddev:63281.79 (1651.3%) stddev-sans-first:63384.03 09:30:25 INFO - PID 3800 | Values: 937.6 950.7 976.8 1002.0 1002.3 43346.6 43641.1 44264.0 45160.5 45215.3 44999.0 45240.3 45256.1 45593.0 45647.5 8124.8 8195.1 8219.6 8251.2 8277.8 8196.2 8227.5 8244.8 8310.8 8311.4 8270.5 8307.2 8316.3 8324.6 8330.5 8193.5 8258.5 8311.8 8319.7 8324.2 8118.2 8191.3 8192.3 8206.3 8210.3 40440.2 40737.0 40788.4 40796.6 40882.2 3799.7 3806.6 3808.4 3828.7 3835.9 33036.8 33070.2 33159.8 33210.7 33244.0 5268.3 5462.8 5522.6 5526.3 5595.2 205976.0 206234.0 206378.0 207782.0 207930.0 51311.0 51430.0 51436.5 52010.2 52969.5 55095.4 55407.7 55434.4 55463.7 55540.0 16349.3 16481.6 16486.8 16495.3 16661.2 13277.9 13452.8 13466.0 13471.1 13499.8 16055.8 16068.5 16228.9 16249.9 16317.7 6348.2 6372.1 6392.3 6418.9 6432.9 1041.1 1062.1 1067.4 1076.3 1080.5 24708.0 24905.0 25184.9 25264.1 25389.0 1124.8 1138.1 1140.2 1153.7 1161.3 13151.6 13170.7 13282.5 13292.9 13331.0 274916.0 276631.0 294370.0 294674.0 295475.0 52060.2 52203.0 52234.5 53678.2 53833.0 1470.8 1484.5 1515.5 1524.6 1536.6 24171.3 24695.8 24765.6 24915.1 25030.1 39444.0 40148.0 40214.2 40258.0 40276.6 224259.0 229954.0 230066.0 230399.0 230798.0 38859.4 38870.4 39184.4 39204.2 39440.4 47128.5 47421.0 47580.8 47605.0 47755.5 34400.7 34740.3 34907.3 35206.5 35392.3 33918.0 34188.7 34453.1 34516.8 34868.3 40936.8 41006.0 41063.4 41195.2 41322.4 33382.0 33402.8 33537.8 33617.0 34706.0 24801.8 25158.0 25490.4 25501.9 25699.2 09:30:25 INFO - PID 3800 | 09:30:25 INFO - PID 3800 | [#2] jquery.html Cycles:180 Average:38423.66 Median:2325.26 stddev:94881.62 (4080.5%) stddev-sans-first:95105.28 09:30:25 INFO - PID 3800 | Values: 596.0 597.2 599.0 601.2 623.4 22921.7 24099.3 24185.5 24273.2 24273.4 24927.4 26281.5 26408.3 26440.7 26462.5 6606.6 6784.5 6804.0 6806.5 6810.1 6470.4 6493.7 6549.5 6731.3 6859.9 6720.4 6745.5 6798.0 6835.2 6838.4 6629.2 6799.5 6799.7 6812.1 6823.3 6348.5 6360.7 6374.6 6381.8 6423.5 29612.0 30030.7 30213.7 30240.8 30302.7 2289.5 2290.0 2324.2 2326.3 2328.5 18577.2 18736.4 20792.8 20863.0 20909.2 2588.2 2593.0 2635.9 2647.6 2648.9 138665.3 144220.0 144406.0 144438.3 150705.2 15115.5 15897.3 16179.6 16449.0 16941.2 25133.1 25213.1 25233.4 25238.6 25276.2 10512.9 10609.2 10632.7 10667.1 10779.4 9746.8 9860.4 9891.6 9938.2 9996.7 9758.8 9868.5 9875.0 10002.3 10032.7 2921.8 2956.0 2984.4 3021.1 3027.2 1038.2 1053.9 1058.8 1071.3 1072.9 20961.0 21501.8 21621.9 21725.9 21747.2 1108.8 1120.2 1120.9 1122.5 1128.9 11641.9 11673.7 11821.2 11891.5 12017.9 551422.0 560765.0 564409.0 566105.0 588716.0 125240.0 125523.4 125811.0 126644.4 127358.4 1092.3 1241.3 1241.6 1263.4 1271.7 21871.1 21921.5 21955.5 21959.3 22396.0 60347.4 60779.7 61157.0 62933.4 65344.0 78712.2 79124.2 79255.0 79589.6 79722.6 15187.8 15516.7 15619.3 15743.6 15806.1 23666.6 24224.6 24259.4 24325.4 24731.8 19954.0 19980.8 20098.8 20114.7 20149.7 16188.5 16516.8 17595.2 17645.6 18119.1 19619.9 20124.9 20251.8 20550.8 20682.7 15388.1 15413.0 15538.8 15556.2 15609.4 19560.2 19660.0 19689.7 19725.2 19727.5 09:30:25 INFO - PID 3800 | 09:30:25 INFO - PID 3800 | [#3] mootools.html Cycles:180 Average:10365.96 Median:2720.36 stddev:7692.85 (282.8%) stddev-sans-first:7684.98 09:30:25 INFO - PID 3800 | Values: 1406.8 1487.4 1524.3 1534.1 1535.2 16936.2 17599.4 17602.9 17666.3 17674.6 17181.5 17228.7 17243.7 17322.0 17394.4 2841.7 2869.0 2918.8 2922.8 2929.2 2666.7 2713.9 2723.0 2724.2 2725.7 2679.5 2796.8 2872.7 2879.6 2892.2 2852.7 2856.8 2859.1 2888.0 2890.9 2641.2 2712.6 2717.8 2825.1 2832.8 16739.1 16830.9 16847.3 16923.2 16926.2 8521.6 8733.5 8778.2 8813.3 8814.4 5952.6 5978.8 6045.1 6185.8 6232.1 2148.8 2153.6 2155.4 2164.2 2202.4 29973.6 30277.1 30283.2 30295.8 30389.0 7250.6 7339.5 7347.5 7487.0 7544.7 19421.0 19432.0 19435.5 19444.7 19447.4 8365.1 8454.6 8464.6 8466.0 8472.5 7381.6 7720.5 7787.1 7876.3 7876.9 5308.8 5348.1 5391.2 5425.4 5455.8 1543.3 1554.5 1568.2 1571.9 1575.6 911.4 949.0 950.8 951.6 957.0 8202.9 9295.9 9345.4 9438.2 9579.3 741.6 783.2 783.6 795.4 802.7 5345.1 5658.5 5852.7 5866.1 6016.7 24203.4 24673.3 24875.6 25131.5 25170.0 24777.3 24805.9 25092.4 25099.5 25137.1 11577.8 11862.2 11960.6 12061.2 12151.5 9062.5 9221.8 9224.1 9315.2 9339.5 20448.8 20519.9 20566.9 20599.5 20929.8 22003.9 22050.9 22132.2 22160.8 22438.9 12030.5 12314.3 12320.4 12324.9 12328.8 15323.7 15405.3 15724.8 15726.5 15789.8 11549.8 11743.1 11946.5 12052.5 12125.2 12241.8 12249.3 12649.5 12660.7 12787.4 10566.1 10787.0 10795.1 10804.7 10811.0 7424.3 7527.0 7550.9 7557.6 7617.4 7865.1 7886.2 7893.0 7960.1 8018.1 09:30:25 INFO - PID 3800 | 09:30:25 INFO - PID 3800 | [#4] prototype.html Cycles:180 Average:5593.80 Median:6185.28 stddev:1557.28 (25.2%) stddev-sans-first:1514.66 09:30:25 INFO - PID 3800 | Values: 535.7 552.0 555.2 567.5 577.2 6220.7 6253.2 6301.9 6323.2 6360.4 6060.3 6135.4 6254.9 6303.0 6325.6 5051.7 5058.6 5059.1 5065.7 5065.8 4994.8 4998.1 5034.7 5069.5 5082.6 4820.6 4952.6 4956.7 4990.6 5016.2 4934.5 4939.7 4955.9 4959.9 4981.0 4455.7 4477.4 4490.6 4499.8 4507.8 5897.4 5975.3 6011.3 6030.9 6091.6 5731.7 5806.7 5851.6 5859.6 5870.2 6577.5 6581.6 6635.8 6668.6 6709.5 5058.9 5062.5 5080.5 5084.5 5095.5 6783.7 6809.2 6889.0 6932.8 6960.2 5187.2 5187.7 5189.8 5191.4 5203.8 5219.7 5257.6 5258.4 5278.3 5281.1 5807.4 5822.7 5826.6 5838.0 5861.2 6676.9 6678.2 6684.9 6698.0 6715.4 1794.9 1800.8 1814.8 1826.6 1830.5 1235.4 1243.8 1275.2 1283.4 1283.8 6046.0 6077.9 6092.7 6142.9 6149.8 6516.6 6629.3 6644.2 6657.8 6714.4 5927.8 6126.7 6126.9 6135.4 6223.6 3475.9 3497.5 3514.7 3521.2 3535.9 6761.7 6826.8 6905.5 6911.1 6944.7 6637.7 6674.2 6757.5 6809.4 6876.2 6850.5 6858.4 6896.2 6923.2 7029.7 6610.9 6707.9 6718.5 6729.7 6737.6 6550.0 6603.5 6603.9 6614.6 6626.1 6789.7 6924.9 6932.2 6947.4 7075.3 5073.7 5147.6 5152.2 5171.5 5191.7 6472.4 6716.4 6716.6 6729.9 6798.7 6346.3 6518.3 6547.8 6551.8 6567.3 6505.9 6528.3 6531.9 6532.8 6546.4 6372.4 6396.0 6438.3 6454.1 6467.0 6269.2 6424.0 6524.8 6525.8 6638.4 6445.8 6458.0 6475.2 6494.5 6506.3 09:30:25 INFO - PID 3800 | 09:30:25 INFO - PID 3800 | [#5] yui.html Cycles:180 Average:27557.93 Median:17941.19 stddev:40675.71 (226.7%) stddev-sans-first:40740.73 09:30:25 INFO - PID 3800 | Values: 943.2 961.0 977.4 984.9 999.0 19516.7 20039.0 20170.9 20240.7 20314.9 17740.2 17939.6 17951.8 18744.0 18914.1 1030.6 1064.1 1065.1 1065.3 1065.3 1049.5 1083.3 1085.0 1088.1 1091.9 1135.4 1137.1 1137.8 1138.0 1138.0 1061.2 1092.3 1136.7 1142.2 1142.7 813.5 813.9 814.3 815.5 815.9 20671.6 20985.3 21149.3 21179.6 21198.8 22077.4 23563.2 23710.0 23735.6 23753.3 17639.1 17980.8 18134.7 18140.8 18175.9 3983.3 4024.4 4042.1 4042.6 4044.8 149007.3 150179.0 150941.2 153104.0 154147.2 17685.0 17716.6 17909.1 17942.7 18047.5 31841.0 32371.4 32392.8 32601.2 32613.0 8865.8 9018.0 9038.8 9044.0 9048.3 4735.2 4805.5 4824.4 4829.0 4833.5 6234.1 6241.7 6242.7 6287.0 6296.3 1157.8 1177.1 1193.4 1195.1 1200.6 688.1 697.6 709.5 711.9 722.3 12182.5 13095.5 13557.9 14256.9 14259.8 688.2 688.3 696.0 698.5 711.4 6144.3 6338.8 6355.6 6408.4 6432.0 141844.3 145255.0 145315.0 146465.0 147545.0 122174.0 122717.0 123903.0 125252.4 128349.4 110626.4 111320.0 111662.0 112106.0 114704.0 11194.4 11281.0 11330.9 11636.1 11641.8 54341.6 54779.5 54857.5 55608.0 55816.2 74229.6 74248.0 74778.6 75000.6 75461.0 17015.8 17186.2 17250.3 17394.1 17415.8 19460.1 19666.9 19819.5 19895.9 19977.4 16061.9 16139.5 16197.5 16218.1 16241.4 17141.4 17218.0 17230.9 17319.3 17398.9 16967.2 17069.5 17168.4 17260.8 17480.5 12162.5 12509.1 12563.9 12566.7 12575.0 13609.9 13719.2 13773.4 13884.2 13922.1 09:30:25 INFO - PID 3800 | -------- Summary: end -------- 09:30:25 INFO - PID 3800 | 09:30:26 INFO - TEST-INFO | 3800: exit 0 09:30:26 INFO - TEST-OK | dromaeo_css | took 1109445ms 09:30:26 INFO - TEST-START | kraken 09:30:26 INFO - Initialising browser for kraken test... 09:30:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57126/getInfo.html -profile /tmp/tmpPJcxzL/profile 09:30:26 INFO - TEST-INFO | started process 4165 (/builds/slave/test/build/application/firefox/firefox http://localhost:57126/getInfo.html) 09:30:31 INFO - TEST-INFO | 4165: exit 0 09:30:32 INFO - Browser initialized. 09:30:32 INFO - Running cycle 1/1 for kraken test... 09:30:32 INFO - Using env: {'DISPLAY': ':0', 09:30:32 INFO - 'HOME': '/home/cltbld', 09:30:32 INFO - 'JSGC_DISABLE_POISONING': '1', 09:30:32 INFO - 'LANG': 'en_US.UTF-8', 09:30:32 INFO - 'LANGUAGE': 'en_US:en', 09:30:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:30:32 INFO - 'LOGNAME': 'cltbld', 09:30:32 INFO - 'MAIL': '/var/mail/cltbld', 09:30:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:30:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:30:32 INFO - 'MOZ_CRASHREPORTER': '1', 09:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:30:32 INFO - 'MOZ_NO_REMOTE': '1', 09:30:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:32 INFO - 'NO_EM_RESTART': '1', 09:30:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:32 INFO - 'PWD': '/builds/slave/test', 09:30:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:30:32 INFO - 'RUST_BACKTRACE': 'full', 09:30:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:30:32 INFO - 'SHELL': '/bin/bash', 09:30:32 INFO - 'SHLVL': '1', 09:30:32 INFO - 'STYLO_FORCE_DISABLED': '1', 09:30:32 INFO - 'TERM': 'linux', 09:30:32 INFO - 'TMOUT': '86400', 09:30:32 INFO - 'USER': 'cltbld', 09:30:32 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831', 09:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:32 INFO - '_': '/tools/buildbot/bin/python'} 09:30:32 INFO - TEST-INFO | started process 4404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPJcxzL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:32 INFO - PID 4404 | 09:30:32 INFO - PID 4404 | (/builds/slave/test/build/application/firefox/firefox:4453): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:30:32 INFO - PID 4404 | 09:30:43 INFO - PID 4404 | RSS: Main: 163966976 09:30:43 INFO - PID 4404 | 09:30:45 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57126/tests/kraken/driver.html?testName=audio-beat-detection) 09:30:46 INFO - PID 4404 | RSS: Main: 169820160 09:30:46 INFO - PID 4404 | 09:30:49 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57126/tests/kraken/driver.html?testName=audio-dft) 09:30:49 INFO - PID 4404 | RSS: Main: 170573824 09:30:49 INFO - PID 4404 | 09:30:52 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57126/tests/kraken/driver.html?testName=audio-fft) 09:30:53 INFO - PID 4404 | RSS: Main: 164921344 09:30:53 INFO - PID 4404 | 09:30:55 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57126/tests/kraken/driver.html?testName=audio-oscillator) 09:30:56 INFO - PID 4404 | RSS: Main: 166117376 09:30:56 INFO - PID 4404 | 09:30:58 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57126/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:30:58 INFO - PID 4404 | RSS: Main: 165695488 09:30:58 INFO - PID 4404 | 09:31:01 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57126/tests/kraken/driver.html?testName=imaging-darkroom) 09:31:02 INFO - PID 4404 | RSS: Main: 169435136 09:31:02 INFO - PID 4404 | 09:31:06 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57126/tests/kraken/driver.html?testName=imaging-desaturate) 09:31:06 INFO - PID 4404 | RSS: Main: 169082880 09:31:06 INFO - PID 4404 | 09:31:09 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57126/tests/kraken/driver.html?testName=json-parse-financial) 09:31:10 INFO - PID 4404 | RSS: Main: 168878080 09:31:10 INFO - PID 4404 | 09:31:11 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57126/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:31:12 INFO - PID 4404 | RSS: Main: 168443904 09:31:12 INFO - PID 4404 | 09:31:13 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:31:14 INFO - PID 4404 | RSS: Main: 169930752 09:31:14 INFO - PID 4404 | 09:31:16 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:31:17 INFO - PID 4404 | RSS: Main: 165658624 09:31:17 INFO - PID 4404 | 09:31:19 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:31:20 INFO - PID 4404 | RSS: Main: 166440960 09:31:20 INFO - PID 4404 | 09:31:22 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:31:23 INFO - PID 4404 | RSS: Main: 166854656 09:31:23 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57126/tests/kraken/driver.html?testName=ai-astar) 09:31:25 INFO - PID 4404 | RSS: Main: 168091648 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | __start_tp_report 09:31:25 INFO - PID 4404 | _x_x_mozilla_page_load 09:31:25 INFO - PID 4404 | _x_x_mozilla_page_load_details 09:31:25 INFO - PID 4404 | |i|pagename|runs| 09:31:25 INFO - PID 4404 | |0;ai-astar;105;104;104;105;109;107;100;107;106;109 09:31:25 INFO - PID 4404 | |1;audio-beat-detection;121;114;112;111;122;112;112;142;119;115 09:31:25 INFO - PID 4404 | |2;audio-dft;165;163;161;161;164;161;161;162;169;164 09:31:25 INFO - PID 4404 | |3;audio-fft;74;74;77;74;73;73;73;72;73;73 09:31:25 INFO - PID 4404 | |4;audio-oscillator;80;79;78;77;77;79;78;78;78;77 09:31:25 INFO - PID 4404 | |5;imaging-gaussian-blur;113;113;113;114;111;114;113;114;114;114 09:31:25 INFO - PID 4404 | |6;imaging-darkroom;151;150;152;150;156;149;149;148;152;151 09:31:25 INFO - PID 4404 | |7;imaging-desaturate;102;94;94;94;94;94;95;95;94;95 09:31:25 INFO - PID 4404 | |8;json-parse-financial;47;50;45;48;43;45;44;44;45;45 09:31:25 INFO - PID 4404 | |9;json-stringify-tinderbox;38;39;39;39;38;39;38;39;38;38 09:31:25 INFO - PID 4404 | |10;stanford-crypto-aes;72;73;72;71;71;70;75;72;74;72 09:31:25 INFO - PID 4404 | |11;stanford-crypto-ccm;116;104;103;110;107;112;106;104;104;106 09:31:25 INFO - PID 4404 | |12;stanford-crypto-pbkdf2;155;161;152;158;153;153;154;155;154;160 09:31:25 INFO - PID 4404 | |13;stanford-crypto-sha256-iterative;63;60;61;61;65;60;59;61;62;59 09:31:25 INFO - PID 4404 | __end_tp_report 09:31:25 INFO - PID 4404 | __start_cc_report 09:31:25 INFO - PID 4404 | _x_x_mozilla_cycle_collect,877 09:31:25 INFO - PID 4404 | __end_cc_report 09:31:25 INFO - PID 4404 | __startTimestamp1505406685471__endTimestamp 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | ------- Summary: start ------- 09:31:25 INFO - PID 4404 | Number of tests: 14 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#0] ai-astar Cycles:10 Average:105.60 Median:106.50 stddev:2.67 (2.5%) stddev-sans-first:2.83 09:31:25 INFO - PID 4404 | Values: 105.0 104.0 104.0 105.0 109.0 107.0 100.0 107.0 106.0 109.0 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#1] audio-beat-detection Cycles:10 Average:118.00 Median:117.00 stddev:9.33 (8.0%) stddev-sans-first:9.84 09:31:25 INFO - PID 4404 | Values: 121.0 114.0 112.0 111.0 122.0 112.0 112.0 142.0 119.0 115.0 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:2.56 (1.6%) stddev-sans-first:2.62 09:31:25 INFO - PID 4404 | Values: 165.0 163.0 161.0 161.0 164.0 161.0 161.0 162.0 169.0 164.0 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#3] audio-fft Cycles:10 Average:73.60 Median:73.50 stddev:1.35 (1.8%) stddev-sans-first:1.42 09:31:25 INFO - PID 4404 | Values: 74.0 74.0 77.0 74.0 73.0 73.0 73.0 72.0 73.0 73.0 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.00 stddev:0.99 (1.3%) stddev-sans-first:0.78 09:31:25 INFO - PID 4404 | Values: 80.0 79.0 78.0 77.0 77.0 79.0 78.0 78.0 78.0 77.0 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 09:31:25 INFO - PID 4404 | Values: 113.0 113.0 113.0 114.0 111.0 114.0 113.0 114.0 114.0 114.0 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:2.25 (1.5%) stddev-sans-first:2.39 09:31:25 INFO - PID 4404 | Values: 151.0 150.0 152.0 150.0 156.0 149.0 149.0 148.0 152.0 151.0 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.00 stddev:2.47 (2.6%) stddev-sans-first:0.50 09:31:25 INFO - PID 4404 | Values: 102.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 95.0 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#8] json-parse-financial Cycles:10 Average:45.60 Median:45.00 stddev:2.12 (4.7%) stddev-sans-first:2.19 09:31:25 INFO - PID 4404 | Values: 47.0 50.0 45.0 48.0 43.0 45.0 44.0 44.0 45.0 45.0 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#9] json-stringify-tinderbox Cycles:10 Average:38.50 Median:39.00 stddev:0.53 (1.4%) stddev-sans-first:0.53 09:31:25 INFO - PID 4404 | Values: 38.0 39.0 39.0 39.0 38.0 39.0 38.0 39.0 38.0 38.0 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#10] stanford-crypto-aes Cycles:10 Average:72.20 Median:72.00 stddev:1.48 (2.0%) stddev-sans-first:1.56 09:31:25 INFO - PID 4404 | Values: 72.0 73.0 72.0 71.0 71.0 70.0 75.0 72.0 74.0 72.0 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#11] stanford-crypto-ccm Cycles:10 Average:107.20 Median:106.50 stddev:4.21 (4.0%) stddev-sans-first:3.03 09:31:25 INFO - PID 4404 | Values: 116.0 104.0 103.0 110.0 107.0 112.0 106.0 104.0 104.0 106.0 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:155.00 stddev:3.10 (2.0%) stddev-sans-first:3.28 09:31:25 INFO - PID 4404 | Values: 155.0 161.0 152.0 158.0 153.0 153.0 154.0 155.0 154.0 160.0 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.00 stddev:1.85 (3.0%) stddev-sans-first:1.83 09:31:25 INFO - PID 4404 | Values: 63.0 60.0 61.0 61.0 65.0 60.0 59.0 61.0 62.0 59.0 09:31:25 INFO - PID 4404 | -------- Summary: end -------- 09:31:25 INFO - PID 4404 | 09:31:25 INFO - PID 4404 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:31:26 INFO - TEST-INFO | 4404: exit 0 09:31:26 INFO - TEST-OK | kraken | took 59753ms 09:31:26 INFO - SUITE-END | took 1169s 09:31:26 INFO - Completed test suite (00:19:29) 09:31:26 INFO - javascript benchmark 09:31:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8998.017376632204, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3810.237952409518, 3814.0, 3840.615938406159, 3842.884713458597, 3858.305505009099, 6154.169187159732, 6187.133801267821, 6188.721507532161, 6252.874942501147, 6285.528585356105, 6155.476784473314, 6246.219222597176, 6292.779752708645, 6333.904991425133, 6344.460720838734, 5535.778568857261, 5642.351129620105, 5653.575981801381, 5654.773809047633, 5673.375928647845, 304.3981663519042, 5327.840164795043, 5563.693996830173, 5645.0, 5649.802256921009, 5501.119820828668, 5580.218769372291, 5613.550915926737, 5638.041532939369, 5648.4633959773755, 5541.972290138564, 5582.497575218209, 5606.299212598426, 5627.971860140673, 5676.744546495376, 5546.694931778791, 5558.972205138948, 5590.664560126405, 5641.717914104278, 5642.7178641067785, 6148.415900489446, 6174.598651087665, 6184.350643182491, 6278.560500764948, 6306.49548036156, 6689.899651505231, 6757.966210168917, 6765.0, 6767.018782276592, 6769.627670478122, 6785.898211526831, 6790.219124800662, 6795.626240556768, 6798.558093723942, 6800.319968003209, 6216.036514340284, 6303.180586523723, 6371.076193951851, 6395.97664373698, 6400.807975760735, 6766.18805743314, 6825.1127353443735, 6894.0, 6901.068355772007, 6919.238883722786, 6612.636305003175, 6692.79921602343, 6697.866042679119, 6699.162604674416, 6701.765438209639, 6728.495362847806, 6729.764458243938, 6734.090897728842, 6824.965875170592, 6828.078209441662, 6581.14445122131, 6718.731250750013, 6722.193336799518, 6722.630255336004, 6753.527253092237, 6714.697838597275, 6715.4291885190305, 6719.731210751613, 6723.193216813916, 6733.124693789776, 4917.311576379309, 4956.5786908112495, 4971.229459433794, 4981.178105612534, 5004.799808007639, 4489.910201795946, 4538.341940418621, 4541.091781643684, 4548.272276435754, 4556.0432309214775, 6238.313785483593, 6256.405641464054, 6335.493160547145, 6354.777582784581, 6363.427291543783, 6661.26726060133, 6736.932630673728, 6740.090087838177, 6744.190697116377, 6760.797176084725, 6221.191245138103, 6227.408396202353, 6235.875282494325, 6239.563230573907, 6320.273168585672, 5497.505224529811, 5516.834494965157, 5519.116941289374, 5519.834404967857, 5541.2796336476, 7064.046353742282, 7073.893891591631, 7137.785866424016, 7159.821004474929, 7171.031910692094, 6646.335366463315, 6782.9321706783285, 6784.559003664746, 6870.106886104774, 6871.415929645936, 6923.169219693669, 6937.549059311129, 6959.373656370951, 6972.30276972319, 7025.613591252326, 6631.0716499689115, 6673.099131617169, 6768.627725475146, 6785.355391237825, 6788.558743681645, 6715.563488373436, 6738.932610674026, 6776.051352810709, 6869.244383117953, 6880.415164711056, 6376.808695739135, 6465.321141280097, 6492.0, 6492.74029038852, 6559.672016399257, 6532.771353002622, 6549.345065493412, 6561.507886908596, 6574.342565743387, 6581.407673309425, 6242.438180563771, 6358.046293056079, 6421.229452465734, 6465.482761378984, 6476.643784591893, 6465.741370345321, 6480.222373315232, 6484.416402523795, 6569.981652843817, 6570.737170513126, 6228.439440450381, 6265.8120256392385, 6324.525660575383, 6370.617762934239, 6410.358964103552], "value": 6127.055957112192, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [937.6390089815427, 950.70052933326, 976.7704589421486, 1002.0280328081758, 1002.3084071990326, 43346.56653433465, 43641.12717745643, 44264.0, 45160.54839451609, 45215.321770173476, 44999.0, 45240.3213951791, 45256.09487810242, 45593.0, 45647.543524564746, 8124.796880077986, 8195.139510351417, 8219.630116644736, 8251.216134467217, 8277.793055173608, 8196.221358970888, 8227.465214761021, 8244.83510329793, 8310.750677479686, 8311.418200725951, 8270.462419942685, 8307.210814972597, 8316.293115085226, 8324.625391857351, 8330.541820199887, 8193.46742461738, 8258.504489730636, 8311.83376332476, 8319.708810191645, 8324.167583241657, 8118.228768267005, 8191.262786349198, 8192.303654189402, 8206.302464290542, 8210.30212431944, 40440.19119617591, 40737.0, 40788.38817417741, 40796.59203407987, 40882.182356353005, 3799.67702745267, 3806.5812760596314, 3808.409696497047, 3828.674562662177, 3835.9424608630893, 33036.834815826005, 33070.17324566881, 33159.83420082884, 33210.667893321, 33244.0, 5268.262443257947, 5462.808801691922, 5522.641028333145, 5526.309211348582, 5595.160725891108, 205975.99999999852, 206234.0, 206378.0, 207782.0, 207930.0, 51311.0, 51430.0, 51436.485635143166, 52010.219846702326, 52969.470305296454, 55095.449045509835, 55407.72296138574, 55434.445655543735, 55463.72268138634, 55540.0, 16349.34602615882, 16481.587960301087, 16486.75269870953, 16495.257713402927, 16661.166941652868, 13277.93361033208, 13452.798208026887, 13466.0, 13471.12437691547, 13499.797503037462, 16055.759163612554, 16068.517944461684, 16228.918855405884, 16249.918750406172, 16317.673646527002, 6348.206474190726, 6372.107904893226, 6392.328805475358, 6418.903716444257, 6432.935670643234, 1041.099448976645, 1062.0653824634273, 1067.412922892406, 1076.3488089705772, 1080.5137688040413, 24708.0, 24904.99328336233, 25184.874075629505, 25264.115755948453, 25388.984440622167, 1124.8144056230794, 1138.1293310617384, 1140.1790710688292, 1153.6654370232707, 1161.297415063891, 13151.60545183646, 13170.670733231555, 13282.53511127106, 13292.933535332262, 13331.0, 274916.0, 276631.0, 294370.0, 294674.0, 295475.0, 52060.21909671358, 52203.0, 52234.47765522372, 53678.19482707763, 53833.0, 1470.8161479815024, 1484.5175318021686, 1515.4695856450155, 1524.6188452886556, 1536.5774412036778, 24171.274861754177, 24695.753042469347, 24765.62851557192, 24915.127970520945, 25030.123945661813, 39444.0, 40148.0, 40214.1957160861, 40258.0, 40276.597234027286, 224259.0, 229954.0, 230066.0, 230399.0, 230798.0, 38859.417108742826, 38870.41694374643, 39184.412233817086, 39204.21591568096, 39440.40839387469, 47128.52871471241, 47421.0, 47580.7620961893, 47605.0, 47755.5224447765, 34400.65599344075, 34740.305193896485, 34907.30185396227, 35206.47190292097, 35392.29215415729, 33918.0, 34188.65811341855, 34453.13867153241, 34516.82741586276, 34868.302633946674, 40936.79531602323, 41006.0, 41063.38404923988, 41195.1760964785, 41322.380164296956, 33381.99854004384, 33402.83298583492, 33537.83231083829, 33617.0, 34705.95882123541, 24801.751982479946, 25158.0, 25490.362740931625, 25501.872490637426, 25699.232665116368], "value": 18568.2287802999, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.9868224019168, 597.2325561653271, 599.007955263459, 601.2364297342375, 623.3984205241941, 22921.656175157364, 24099.277021689333, 24185.516289674197, 24273.150439734614, 24273.39316517088, 24927.37681557962, 26281.474370512577, 26408.339791505223, 26440.73559264407, 26462.470750585024, 6606.570572912769, 6784.491163162757, 6804.047433359334, 6806.489513286499, 6810.148731408574, 6470.417662410382, 6493.707783149746, 6549.541532092755, 6731.326867313254, 6859.897101543481, 6720.361565651279, 6745.4940879434, 6798.0, 6835.213950395693, 6838.384545390913, 6629.204495460527, 6799.456043516507, 6799.7280108795585, 6812.14848143982, 6823.317668233187, 6348.492120630339, 6360.650164240965, 6374.553781235315, 6381.8085457436355, 6423.4861211103, 29612.0, 30030.699693003007, 30213.69786302131, 30240.8487957561, 30302.69697303043, 2289.4848659051745, 2290.0496294037953, 2324.1633012115626, 2326.3486223857176, 2328.4528135888054, 18577.16402761879, 18736.437906862815, 20792.792072079235, 20863.0, 20909.163633454642, 2588.1588483742858, 2592.961105583418, 2635.934101647455, 2647.6293318935363, 2648.8543130127837, 138665.306673466, 144220.0, 144406.0, 144438.2778086103, 150705.24647376692, 15115.546533604009, 15897.28462219203, 16179.595510112105, 16449.0, 16941.152942352834, 25133.12034078835, 25213.11754088598, 25233.369165770637, 25238.621420678704, 25276.241712748648, 10512.894871051192, 10609.15126789855, 10632.681019569425, 10667.093297069836, 10779.407132607781, 9746.75633109178, 9860.359076659994, 9891.554880030415, 9938.204943604638, 9996.700098997042, 9758.804823903482, 9868.457234852152, 9874.950625246827, 10002.299839011199, 10032.749181270381, 2921.7516511096796, 2956.0, 2984.4180384825186, 3021.0634703242067, 3027.2431892026993, 1038.1642777563982, 1053.8735351757684, 1058.7723639417409, 1071.2822408985999, 1072.8927107289364, 20961.0, 21501.784982149977, 21621.918904054735, 21725.891370543362, 21747.23884664061, 1108.772701596171, 1120.1822669451346, 1120.865496140452, 1122.5341483284346, 1128.9322640641424, 11641.88358116425, 11673.708157295965, 11821.172517923835, 11891.464884080064, 12017.939910300393, 551422.0, 560765.0, 564409.0, 566105.0, 588716.0, 125240.0, 125523.3723831375, 125811.0, 126644.36677816552, 127358.36320818336, 1092.251807511857, 1241.3420886929941, 1241.5964811436138, 1263.3746295583744, 1271.7075072733323, 21871.12515499362, 21921.451963701034, 21955.451113722283, 21959.34121976343, 22396.0, 60347.39652603418, 60779.69610151921, 61157.0, 62933.370666294584, 65344.0, 78712.2128778705, 79124.20875791168, 79255.0, 79589.60205198936, 79722.6013869927, 15187.848121518644, 15516.689666206386, 15619.297131628877, 15743.606409839846, 15806.130662813195, 23666.645000324665, 24224.636630450204, 24259.393515161555, 24325.39186520351, 24731.752682473663, 19954.0, 19980.800191997892, 20098.79901200969, 20114.69254498453, 20149.697754533987, 16188.514344569681, 16516.83483165153, 17595.20821563007, 17645.558861028578, 18119.094045297945, 19619.901900490408, 20124.899375503028, 20251.79748202499, 20550.794492054887, 20682.689759653917, 15388.076715397112, 15413.0, 15538.766918496005, 15556.222188890284, 15609.375624975328, 19560.21759129619, 19660.0, 19689.704654430483, 19725.210991560176, 19727.506812329808], "value": 12817.09787375543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.8241469816273, 1487.3753023730033, 1524.3064405695402, 1534.1255484373899, 1535.2016951185383, 16936.23786929588, 17599.384021559246, 17602.911985440056, 17666.293348266056, 17674.64650706987, 17181.484555463358, 17228.741568876478, 17243.74134387985, 17322.0, 17394.39119630813, 2841.7300356466103, 2868.9713102868964, 2918.751906087985, 2922.78079144064, 2929.209113539354, 2666.693330267015, 2713.864306784653, 2722.9591556126675, 2724.1691284158323, 2725.6729192496828, 2679.54447743884, 2796.8182068165606, 2872.698366671501, 2879.640044994376, 2892.2191008427712, 2852.657681078263, 2856.8143070700544, 2859.127965970378, 2887.971120288791, 2890.913272601825, 2641.220839852248, 2712.593111033341, 2717.7689896358834, 2825.1242114944225, 2832.8441935693527, 16739.07935063571, 16830.915845420695, 16847.32610695571, 16923.238454269464, 16926.23831927566, 8521.616527256288, 8733.475991440533, 8778.166074222938, 8813.338999575057, 8814.427062240933, 5952.553558483131, 5978.760849566012, 6045.093236014589, 6185.8144255672405, 6232.065190221458, 2148.8074118864024, 2153.601583707019, 2155.415769409483, 2164.188429338998, 2202.4451636102044, 29973.550396744067, 30277.091687249416, 30283.242918926982, 30295.848520757256, 30389.0, 7250.60121693312, 7339.486235963538, 7347.485676002735, 7486.962565187248, 7544.660490277951, 19421.0, 19432.0, 19435.51411214731, 19444.70832937507, 19447.416577502696, 8365.121662225378, 8454.61954212062, 8464.619092140869, 8466.026406963156, 8472.534010629475, 7381.630918454056, 7720.53676779395, 7787.06555213378, 7876.330511906552, 7876.881846772303, 5308.761105750251, 5348.090824559834, 5391.191321301836, 5425.430329815392, 5455.8090466834265, 1543.3055125193707, 1554.518099389193, 1568.215892053973, 1571.905685658864, 1575.6297270141508, 911.384815249717, 948.9762755931018, 950.7528042708807, 951.5908159491347, 956.9569369378395, 8202.917970820336, 9295.90704092964, 9345.439273643467, 9438.150566449052, 9579.281553883488, 741.5661837824933, 783.169839969634, 783.5925318834288, 795.4471642208609, 802.7310850865026, 5345.118055520873, 5658.547316214693, 5852.678102704307, 5866.061430171152, 6016.669083200466, 24203.39491512691, 24673.25980220596, 24875.62686559703, 25131.49737005286, 25170.0, 24777.25668229956, 24805.875970620033, 25092.372690682878, 25099.49801004006, 25137.120200792884, 11577.826332605018, 11862.169648124722, 11960.58137965167, 12061.216020958609, 12151.453184606715, 9062.546872656472, 9221.769455763659, 9224.077592240723, 9315.16163545257, 9339.486328252011, 20448.79551204469, 20519.897400512902, 20566.897165514674, 20599.4850128742, 20929.790702092785, 22003.889980549993, 22050.88974555117, 22132.22537211254, 22160.77839221587, 22438.88780556152, 12030.518779248732, 12314.261144331369, 12320.383980800745, 12324.876751232732, 12328.81506777381, 15323.693526129193, 15405.306761195998, 15724.842751572338, 15726.528204153894, 15789.842101578837, 11549.769004620028, 11743.119266055252, 11946.462409191434, 12052.457639406073, 12125.151239413157, 12241.816372754594, 12249.265044097383, 12649.494020239088, 12660.746785064062, 12787.424565894371, 10566.101881340172, 10787.0, 10795.082417994245, 10804.729881753019, 10811.027007569357, 7424.298246487576, 7526.962365188139, 7550.8867366990635, 7557.584332861746, 7617.390608751176, 7865.134835168013, 7886.211378862068, 7892.960535197517, 7960.084590272193, 8018.1180070193395], "value": 7220.987054765794, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.6732393240122, 552.0311852698519, 555.1949672974188, 567.4621774989778, 577.1746402644219, 6220.720067596958, 6253.1870856788555, 6301.9054714179265, 6323.241211054674, 6360.395762402564, 6060.272767267923, 6135.386461353863, 6254.906176407346, 6302.968485157568, 6325.620462772225, 5051.6716413433005, 5058.595312375001, 5059.139946209135, 5065.746712664352, 5065.848024559269, 4994.750262486879, 4998.125328067592, 5034.748262586874, 5069.467705890884, 5082.567981721558, 4820.614350851941, 4952.554270115689, 4956.7025978441225, 4990.625703072266, 5016.197408414654, 4934.481879402683, 4939.653664509347, 4955.876103097434, 4959.900801983977, 4980.975095124501, 4455.665825063101, 4477.417935668374, 4490.640748740093, 4499.797509112098, 4507.782898617388, 5897.351291357947, 5975.282966044059, 6011.30869949957, 6030.914435401626, 6091.604045737057, 5731.681713205944, 5806.65160090396, 5851.582055548077, 5859.560532960002, 5870.178175055453, 6577.473802095821, 6581.638009909453, 6635.767748128841, 6668.6332251726135, 6709.456824930245, 5058.898822023539, 5062.4684408137355, 5080.491950804927, 5084.491550844923, 5095.541401273866, 6783.660816959133, 6809.182898052216, 6889.0, 6932.757353492603, 6960.234374218882, 5187.221916712448, 5187.662801917863, 5189.818356357509, 5191.428942816287, 5203.843884683465, 5219.686818790885, 5257.553107985787, 5258.39528454225, 5278.340207474066, 5281.075811733008, 5807.361190269067, 5822.689894773642, 5826.592138550261, 5838.0, 5861.17943487912, 6676.86646267072, 6678.198616166092, 6684.899726504106, 6698.0, 6715.4291885190305, 1794.8743587948718, 1800.7929088154767, 1814.7550080738931, 1826.5707558723689, 1830.5240637434097, 1235.4274371546526, 1243.8320826688282, 1275.1775105057372, 1283.3519072868141, 1283.8202651628778, 6045.969770151209, 6077.878442431215, 6092.72582733778, 6142.938570614237, 6149.846253843601, 6516.609003459807, 6629.337066293332, 6644.202695676453, 6657.833554161088, 6714.381391257413, 5927.8221653350465, 6126.663033533109, 6126.93433500831, 6135.386461353829, 6223.595466294767, 3475.8957231283102, 3497.527833742463, 3514.7363947704025, 3521.207728261172, 3535.876244331436, 6761.72953081881, 6826.829329266808, 6905.482088843357, 6911.136107986502, 6944.722211111499, 6637.668116594247, 6674.23246326669, 6757.526973111835, 6809.38715515606, 6876.243613202544, 6850.45196384298, 6858.3827455529245, 6896.2069362023, 6923.169219693568, 7029.718811247493, 6610.867782644224, 6707.8993815091835, 6718.496112791462, 6729.697163627747, 6737.629430381376, 6550.0, 6603.457668797451, 6603.9339606605245, 6614.570052946543, 6626.072349870926, 6789.694463749044, 6924.853295478418, 6932.202796678446, 6947.40947019509, 7075.292470752884, 5073.720945348041, 5147.562457191031, 5152.201408781495, 5171.45699701541, 5191.6884986900905, 6472.449841763503, 6716.361945615354, 6716.5634233774645, 6729.865402692017, 6798.694058767466, 6346.301906790157, 6518.2504012037325, 6547.803565893031, 6551.836204094936, 6567.31043240472, 6505.8698826024165, 6528.281888992112, 6531.934680653323, 6532.804015879531, 6546.443552298108, 6372.362763723776, 6395.968020160056, 6438.259600146043, 6454.128692626623, 6467.047923482181, 6269.216347956505, 6424.0, 6524.771632992823, 6525.771597994048, 6638.369354911276, 6445.778919075564, 6458.0, 6475.222973243241, 6494.545381823227, 6506.25178104524], "value": 5144.7177749339535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [943.2124176312778, 960.9567569459375, 977.3744803325868, 984.8571957066221, 999.0309399882112, 19516.707249391253, 20039.0, 20170.89914550427, 20240.69638955415, 20314.89842550789, 17740.201690923906, 17939.64120717585, 17951.820481795177, 18744.0, 18914.054297285114, 1030.567161792049, 1064.1433645915035, 1065.0893486069415, 1065.3288428290166, 1065.3341661461586, 1049.4647729657854, 1083.3175099687226, 1085.0288991352734, 1088.080571916729, 1091.9181061420386, 1135.4379582106828, 1137.0676045642576, 1137.7895089408444, 1137.9886201137965, 1137.9943100284488, 1061.2093989977438, 1092.2900114925283, 1136.6987748246722, 1142.2004596782244, 1142.7028972467176, 813.5240884082818, 813.894193754814, 814.2712272516065, 815.514768712615, 815.9061707903548, 20671.58656826855, 20985.26551570703, 21149.25977590792, 21179.576408471898, 21198.788012119836, 22077.448063798372, 23563.17528886498, 23710.0, 23735.643965340532, 23753.287401377987, 17639.118044097744, 17980.820191798175, 18134.727979080326, 18140.818591814044, 18175.909120454315, 3983.322835118037, 4024.3762216856435, 4042.090529630839, 4042.636162745367, 4044.8382064717375, 149007.25496372557, 150179.0, 150941.2452937739, 153104.0, 154147.22926385296, 17685.0, 17716.557086072953, 17909.10454477271, 17942.730859037125, 18047.458576242734, 31841.0, 32371.35257294841, 32392.83803580967, 32601.18497037593, 32613.0, 8865.778355541162, 9018.0, 9038.81922361549, 9043.954780226057, 9048.276137908952, 4735.195016847144, 4805.495422980537, 4824.372831531879, 4828.975855120772, 4833.516648335139, 6234.064890266496, 6241.687915604201, 6242.656653883989, 6286.968565157145, 6296.338884417162, 1157.774234024374, 1177.1112809828696, 1193.3913704011018, 1195.1036722458157, 1200.609801814414, 688.1363888320126, 697.5849369625065, 709.4714437743913, 711.8789805733038, 722.3354513847273, 12182.451789669487, 13095.476180952846, 13557.864421355858, 14256.928715356356, 14259.78610320846, 688.198249039863, 688.3426327856885, 695.9826004349932, 698.4656737595743, 711.3597762014228, 6144.262688477412, 6338.8415289617205, 6355.5551111421755, 6408.359164083555, 6432.035194720829, 141844.29077854753, 145255.0, 145315.0, 146465.0, 147545.0, 122174.0, 122717.0, 123902.9999999982, 125252.37373813073, 128349.35825321, 110626.44686776676, 111320.0, 111662.0, 112106.0, 114704.0, 11194.384308863091, 11281.0, 11330.886691132982, 11636.12729045342, 11641.76716465649, 54341.641458963844, 54779.452205477435, 54857.45142548523, 55608.0, 55816.16275755786, 74229.62885185539, 74248.0, 74778.62610686912, 75000.62499687467, 75461.0, 17015.82984170192, 17186.226619801888, 17250.309987600354, 17394.130293485527, 17415.825841741927, 19460.1242944065, 19666.90166549158, 19819.504512387306, 19895.900520497304, 19977.400677979684, 16061.919690401473, 16139.515814525583, 16197.51407457778, 16218.10800405989, 16241.431549895697, 17141.400050998156, 17218.0, 17230.913845430692, 17319.307227711255, 17398.913005434893, 16967.151642417582, 17069.48791536256, 17168.39910603123, 17260.827391726423, 17480.47558573245, 12162.452689628812, 12509.124361294622, 12563.93718031404, 12566.748665026465, 12575.0, 13609.931950340186, 13719.188627632493, 13773.449062037405, 13884.236366999912, 13922.095063821225], "value": 9796.780400486577, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1377.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 104.0, 105.0, 109.0, 107.0, 100.0, 107.0, 106.0, 109.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 114.0, 112.0, 111.0, 122.0, 112.0, 112.0, 142.0, 119.0, 115.0], "value": 118.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 161.0, 161.0, 164.0, 161.0, 161.0, 162.0, 169.0, 164.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 74.0, 73.0, 73.0, 73.0, 72.0, 73.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 77.0, 77.0, 79.0, 78.0, 78.0, 78.0, 77.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 111.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 152.0, 150.0, 156.0, 149.0, 149.0, 148.0, 152.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 50.0, 45.0, 48.0, 43.0, 45.0, 44.0, 44.0, 45.0, 45.0], "value": 45.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 39.0, 39.0, 38.0, 39.0, 38.0, 39.0, 38.0, 38.0], "value": 38.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 71.0, 71.0, 70.0, 75.0, 72.0, 74.0, 72.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 104.0, 103.0, 110.0, 107.0, 112.0, 106.0, 104.0, 104.0, 106.0], "value": 107.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 161.0, 152.0, 158.0, 153.0, 153.0, 154.0, 155.0, 154.0, 160.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 61.0, 61.0, 65.0, 60.0, 59.0, 61.0, 62.0, 59.0], "value": 61.1, "unit": "score"}]}]} 09:31:26 INFO - Return code: 0 09:31:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:31:26 INFO - # TBPL SUCCESS # 09:31:26 INFO - Running post-action listener: _package_coverage_data 09:31:26 INFO - Running post-action listener: _resource_record_post_action 09:31:26 INFO - [mozharness: 2017-09-14 16:31:26.739603Z] Finished run-tests step (success) 09:31:26 INFO - Running post-run listener: _resource_record_post_run 09:31:26 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 10838016; Write bytes: 457756672; Read time: 2944; Write time: 394740 09:31:26 INFO - TinderboxPrint: CPU usage
13.1% 09:31:26 INFO - TinderboxPrint: I/O read bytes / time
10,838,016 / 2,944 09:31:26 INFO - TinderboxPrint: I/O write bytes / time
457,756,672 / 394,740 09:31:26 INFO - TinderboxPrint: CPU idle
8,232.4 (86.9%) 09:31:26 INFO - TinderboxPrint: CPU user
1,186.2 (12.5%) 09:31:26 INFO - TinderboxPrint: Swap in / out
0 / 0 09:31:26 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 98824192; Read time: 80; Write time: 84812 09:31:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:31:26 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 9420800; Write bytes: 358932480; Read time: 2836; Write time: 309928 09:31:27 INFO - Running post-run listener: _upload_blobber_files 09:31:27 INFO - Blob upload gear active. 09:31:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:31:27 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 09:31:27 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'] 09:31:27 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 09:31:27 INFO - (blobuploader) - INFO - Open directory for files ... 09:31:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:31:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:31:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:28 INFO - (blobuploader) - INFO - Done attempting. 09:31:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:31:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:31:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:35 INFO - (blobuploader) - INFO - Done attempting. 09:31:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 09:31:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 09:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:37 INFO - (blobuploader) - INFO - Done attempting. 09:31:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 09:31:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 09:31:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:38 INFO - (blobuploader) - INFO - Done attempting. 09:31:38 INFO - (blobuploader) - INFO - Iteration through files over. 09:31:38 INFO - Return code: 0 09:31:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:31:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:31:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3797cdc65e3a0d842c96f337990fc093d93e8b70eb1a0e786a480f1e99b188282e50ddfaab1d6eb4ff7e086d7d64efb6781bdc114b8c68f3631e2c1414af6e13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c3b15bca9fb49e37df2f1e38ea1822d6324c11b9f8bbb005713a5d862232a8bc474679ae278c1bc72fcbc8ec51b3f2239023dbc79d414338ee038e2b83a9d0f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7db44fa09503a64641b76033d6de68c7b56d60b641836c58be7cec094ab3853011a7dd072148fada6c02f70093afaef9368a2dc5efe56ce46e320242b933e1a1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/780fd8e724b4f39e5958f30503f7eaf99d6d86e5737ba332d415412829d7290051949d029ef4516859ba0d20657df8ce579cebaea930050626c7873d043c2425"} 09:31:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:31:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:31:38 INFO - Contents: 09:31:38 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3797cdc65e3a0d842c96f337990fc093d93e8b70eb1a0e786a480f1e99b188282e50ddfaab1d6eb4ff7e086d7d64efb6781bdc114b8c68f3631e2c1414af6e13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c3b15bca9fb49e37df2f1e38ea1822d6324c11b9f8bbb005713a5d862232a8bc474679ae278c1bc72fcbc8ec51b3f2239023dbc79d414338ee038e2b83a9d0f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7db44fa09503a64641b76033d6de68c7b56d60b641836c58be7cec094ab3853011a7dd072148fada6c02f70093afaef9368a2dc5efe56ce46e320242b933e1a1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/780fd8e724b4f39e5958f30503f7eaf99d6d86e5737ba332d415412829d7290051949d029ef4516859ba0d20657df8ce579cebaea930050626c7873d043c2425"} 09:31:38 INFO - Running post-run listener: copy_logs_to_upload_dir 09:31:38 INFO - Copying logs to upload dir... 09:31:38 INFO - mkdir: /builds/slave/test/build/upload/logs 09:31:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.994000 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-14 09:31:38.915306) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 09:31:38.922815) ========= 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=1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831 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/3797cdc65e3a0d842c96f337990fc093d93e8b70eb1a0e786a480f1e99b188282e50ddfaab1d6eb4ff7e086d7d64efb6781bdc114b8c68f3631e2c1414af6e13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c3b15bca9fb49e37df2f1e38ea1822d6324c11b9f8bbb005713a5d862232a8bc474679ae278c1bc72fcbc8ec51b3f2239023dbc79d414338ee038e2b83a9d0f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7db44fa09503a64641b76033d6de68c7b56d60b641836c58be7cec094ab3853011a7dd072148fada6c02f70093afaef9368a2dc5efe56ce46e320242b933e1a1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/780fd8e724b4f39e5958f30503f7eaf99d6d86e5737ba332d415412829d7290051949d029ef4516859ba0d20657df8ce579cebaea930050626c7873d043c2425"} build_url:https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/DlSqvLEzQ-iruS7YzEiCNQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3797cdc65e3a0d842c96f337990fc093d93e8b70eb1a0e786a480f1e99b188282e50ddfaab1d6eb4ff7e086d7d64efb6781bdc114b8c68f3631e2c1414af6e13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c3b15bca9fb49e37df2f1e38ea1822d6324c11b9f8bbb005713a5d862232a8bc474679ae278c1bc72fcbc8ec51b3f2239023dbc79d414338ee038e2b83a9d0f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7db44fa09503a64641b76033d6de68c7b56d60b641836c58be7cec094ab3853011a7dd072148fada6c02f70093afaef9368a2dc5efe56ce46e320242b933e1a1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/780fd8e724b4f39e5958f30503f7eaf99d6d86e5737ba332d415412829d7290051949d029ef4516859ba0d20657df8ce579cebaea930050626c7873d043c2425"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 09:31:38.950445) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 09:31:38.950750) ========= 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=1f5564757af27664ca02d71f000001b0-1505404847.67538-1823830831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 09:31:39.034192) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 09:31:39.036530) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 09:31:39.036827) ========= ========= Total master_lag: 0.24 =========