builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1505470801.15 results: success (0) revision: f36106f3f52a9bb2769860d20568c589fc2498d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.150420) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.150807) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.151073) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.203766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.204037) ========= 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=7de08804244eb36560b44971000001c3-1505469860.17312-4953465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-15 03:20:01-- 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% 61.7M=0s 2017-09-15 03:20:01 (61.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.166713 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.438193) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.438659) ========= 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=7de08804244eb36560b44971000001c3-1505469860.17312-4953465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019365 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.497120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.497582) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f36106f3f52a9bb2769860d20568c589fc2498d0 --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 f36106f3f52a9bb2769860d20568c589fc2498d0 --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=7de08804244eb36560b44971000001c3-1505469860.17312-4953465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-15 03:20:01,549 truncating revision to first 12 chars 2017-09-15 03:20:01,549 Setting DEBUG logging. 2017-09-15 03:20:01,549 attempt 1/10 2017-09-15 03:20:01,549 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f36106f3f52a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-15 03:20:01,945 unpacking tar archive at: mozilla-central-f36106f3f52a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.693747 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:02.209078) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:02.209398) ========= script_repo_revision: f36106f3f52a9bb2769860d20568c589fc2498d0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:02.209849) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:02.210118) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:02.222570) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-15 03:20:02.222892) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1505469860.17312-4953465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:20:02 INFO - MultiFileLogger online at 20170915 03:20:02 in /builds/slave/test 03:20:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:20:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:02 INFO - {'append_to_log': False, 03:20:02 INFO - 'base_work_dir': '/builds/slave/test', 03:20:02 INFO - 'blob_upload_branch': 'Firefox', 03:20:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:02 INFO - 'branch': 'Firefox', 03:20:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:02 INFO - 'code_coverage': False, 03:20:02 INFO - 'config_files': ('talos/linux_config.py',), 03:20:02 INFO - 'default_actions': ('clobber', 03:20:02 INFO - 'read-buildbot-config', 03:20:02 INFO - 'download-and-extract', 03:20:02 INFO - 'populate-webroot', 03:20:02 INFO - 'create-virtualenv', 03:20:02 INFO - 'install', 03:20:02 INFO - 'setup-mitmproxy', 03:20:02 INFO - 'run-tests'), 03:20:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:02 INFO - 'disable_ccov_upload': False, 03:20:02 INFO - 'disable_stylo': False, 03:20:02 INFO - 'download_minidump_stackwalk': True, 03:20:02 INFO - 'download_symbols': 'ondemand', 03:20:02 INFO - 'enable_stylo': False, 03:20:02 INFO - 'enable_webrender': False, 03:20:02 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:20:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:02 INFO - 'gecko_profile': False, 03:20:02 INFO - 'gecko_profile_interval': 0, 03:20:02 INFO - 'installer_path': 'installer.exe', 03:20:02 INFO - 'log_level': 'info', 03:20:02 INFO - 'log_name': 'talos', 03:20:02 INFO - 'log_to_console': True, 03:20:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:20:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:20:02 INFO - 'opt_config_files': (), 03:20:02 INFO - 'pip_index': False, 03:20:02 INFO - 'suite': 'dromaeojs-e10s', 03:20:02 INFO - 'system_bits': '32', 03:20:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:02 INFO - 'title': 'talos-linux64-ix-003', 03:20:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:02 INFO - 'use_talos_json': True, 03:20:02 INFO - 'verify': 'False', 03:20:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:02 INFO - 'work_dir': 'build'} 03:20:02 INFO - [mozharness: 2017-09-15 10:20:02.505585Z] Running clobber step. 03:20:02 INFO - Running pre-action listener: _resource_record_pre_action 03:20:02 INFO - Running main action method: clobber 03:20:02 INFO - rmtree: /builds/slave/test/build 03:20:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:03 INFO - Running post-action listener: _resource_record_post_action 03:20:03 INFO - [mozharness: 2017-09-15 10:20:03.453123Z] Finished clobber step (success) 03:20:03 INFO - [mozharness: 2017-09-15 10:20:03.453220Z] Running read-buildbot-config step. 03:20:03 INFO - Running pre-action listener: _resource_record_pre_action 03:20:03 INFO - Running main action method: read_buildbot_config 03:20:03 INFO - Using buildbot properties: 03:20:03 INFO - { 03:20:03 INFO - "project": "", 03:20:03 INFO - "product": "firefox", 03:20:03 INFO - "who": "archaeopteryx@coole-files.de", 03:20:03 INFO - "installer_path": "public/build/target.tar.bz2", 03:20:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:20:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:20:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:20:03 INFO - "stage_platform": "linux64-pgo", 03:20:03 INFO - "basedir": "/builds/slave/test", 03:20:03 INFO - "buildnumber": 186, 03:20:03 INFO - "platform": "ubuntu64_hw", 03:20:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:20:03 INFO - "slavebuilddir": "test", 03:20:03 INFO - "taskId": "KgSRvbugRX2HPGFuAFpF6g", 03:20:03 INFO - "branch": "mozilla-central", 03:20:03 INFO - "script_repo_revision": "production", 03:20:03 INFO - "revision": "f36106f3f52a9bb2769860d20568c589fc2498d0", 03:20:03 INFO - "slavename": "talos-linux64-ix-003", 03:20:03 INFO - "repo_path": "mozilla-central" 03:20:03 INFO - } 03:20:03 INFO - Finding installer, test and symbols from parent task. 03:20:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KgSRvbugRX2HPGFuAFpF6g'}, attempt #1 03:20:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KgSRvbugRX2HPGFuAFpF6g'}, attempt #1 03:20:04 INFO - Task dependencies: GEzbUQjLSKKZw0Ok6RZgng 03:20:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng'}, attempt #1 03:20:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2 03:20:04 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.test_packages.json 03:20:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.crashreporter-symbols.zip 03:20:04 INFO - Running post-action listener: _resource_record_post_action 03:20:04 INFO - [mozharness: 2017-09-15 10:20:04.885009Z] Finished read-buildbot-config step (success) 03:20:04 INFO - [mozharness: 2017-09-15 10:20:04.885227Z] Running download-and-extract step. 03:20:04 INFO - Running pre-action listener: _resource_record_pre_action 03:20:04 INFO - Running main action method: download_and_extract 03:20:04 INFO - mkdir: /builds/slave/test/build/tests 03:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:04 INFO - trying https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.test_packages.json 03:20:04 INFO - Downloading https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:20:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:20:05 INFO - Downloaded 989 bytes. 03:20:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:20:05 INFO - Using the following test package requirements: 03:20:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:20:05 INFO - u'common': [u'target.common.tests.zip'], 03:20:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:20:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:20:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:20:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:20:05 INFO - u'mozbase': [u'target.common.tests.zip'], 03:20:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:20:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:20:05 INFO - u'web-platform': [u'target.common.tests.zip', 03:20:05 INFO - u'target.web-platform.tests.tar.gz'], 03:20:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:20:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:20:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.common.tests.zip 03:20:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:20:05 INFO - Fetch https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.common.tests.zip into memory 03:20:07 INFO - Content-Length response header: 55327223 03:20:07 INFO - Bytes received: 55327223 03:20:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.talos.tests.zip 03:20:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:20:18 INFO - Fetch https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.talos.tests.zip into memory 03:20:19 INFO - Content-Length response header: 14500356 03:20:19 INFO - Bytes received: 14500356 03:20: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')]} 03:20:19 INFO - trying https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2 03:20:19 INFO - Downloading https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:20:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:20:22 INFO - Downloaded 62199272 bytes. 03:20:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2 03:20:22 INFO - mkdir: /builds/slave/test/properties 03:20:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:20:22 INFO - Writing to file /builds/slave/test/properties/build_url 03:20:22 INFO - Contents: 03:20:22 INFO - build_url:https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2 03:20:22 INFO - Running post-action listener: _resource_record_post_action 03:20:22 INFO - Running post-action listener: find_tests_for_verification 03:20:22 INFO - Running post-action listener: set_extra_try_arguments 03:20:22 INFO - [mozharness: 2017-09-15 10:20:22.382461Z] Finished download-and-extract step (success) 03:20:22 INFO - [mozharness: 2017-09-15 10:20:22.382604Z] Running populate-webroot step. 03:20:22 INFO - Running pre-action listener: _resource_record_pre_action 03:20:22 INFO - Running main action method: populate_webroot 03:20:22 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:20:22 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['tresize', 03:20:22 INFO - 'tcanvasmark']}, 03:20:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:20:22 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['dromaeo_css', 03:20:22 INFO - 'kraken']}, 03:20:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:22 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'tests': ['damp', 'tps']}, 03:20:22 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['damp', 'tps']}, 03:20:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:20:22 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['dromaeo_dom']}, 03:20:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:20:22 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['basic_compositor_video', 03:20:22 INFO - 'glvideo']}, 03:20:22 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:20:22 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['ts_paint_webext', 03:20:22 INFO - 'tp5o_webext']}, 03:20:22 INFO - 'other-e10s': {'tests': ['a11yr', 03:20:22 INFO - 'ts_paint', 03:20:22 INFO - 'tpaint', 03:20:22 INFO - 'sessionrestore', 03:20:22 INFO - 'sessionrestore_many_windows', 03:20:22 INFO - 'sessionrestore_no_auto_restore', 03:20:22 INFO - 'tabpaint']}, 03:20:22 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['a11yr', 03:20:22 INFO - 'ts_paint', 03:20:22 INFO - 'tpaint', 03:20:22 INFO - 'sessionrestore', 03:20:22 INFO - 'sessionrestore_many_windows', 03:20:22 INFO - 'sessionrestore_no_auto_restore', 03:20:22 INFO - 'tabpaint']}, 03:20:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:20:22 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:20:22 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['bloom_basic_singleton']}, 03:20:22 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['bloom_basic']}, 03:20:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:20:22 INFO - 'tsvgr_opacity', 03:20:22 INFO - 'tart', 03:20:22 INFO - 'tscrollx', 03:20:22 INFO - 'tsvg_static']}, 03:20:22 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['tsvgx', 03:20:22 INFO - 'tsvgr_opacity', 03:20:22 INFO - 'tart', 03:20:22 INFO - 'tscrollx', 03:20:22 INFO - 'tsvg_static']}, 03:20:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:20:22 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['tp5o']}, 03:20:22 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:22 INFO - 'talos_options': ['--mitmproxy', 03:20:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:22 INFO - '--firstNonBlankPaint'], 03:20:22 INFO - 'tests': ['tp6_google', 03:20:22 INFO - 'tp6_youtube', 03:20:22 INFO - 'tp6_amazon', 03:20:22 INFO - 'tp6_facebook']}, 03:20:22 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:22 INFO - 'talos_options': ['--disable-stylo', 03:20:22 INFO - '--mitmproxy', 03:20:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:22 INFO - '--firstNonBlankPaint'], 03:20:22 INFO - 'tests': ['tp6_google', 03:20:22 INFO - 'tp6_youtube', 03:20:22 INFO - 'tp6_amazon', 03:20:22 INFO - 'tp6_facebook']}, 03:20:22 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:22 INFO - 'talos_options': ['--stylo-threads=1', 03:20:22 INFO - '--mitmproxy', 03:20:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:22 INFO - '--firstNonBlankPaint'], 03:20:22 INFO - 'tests': ['tp6_google', 03:20:22 INFO - 'tp6_youtube', 03:20:22 INFO - 'tp6_amazon', 03:20:22 INFO - 'tp6_facebook']}, 03:20:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'talos_options': ['--xperf_path', 03:20:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:22 INFO - 'tests': ['tp5n']}, 03:20:22 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'talos_options': ['--disable-stylo', 03:20:22 INFO - '--xperf_path', 03:20:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:22 INFO - 'tests': ['tp5n']}}} 03:20:22 INFO - Running post-action listener: _resource_record_post_action 03:20:22 INFO - [mozharness: 2017-09-15 10:20:22.397824Z] Finished populate-webroot step (success) 03:20:22 INFO - [mozharness: 2017-09-15 10:20:22.397913Z] Running create-virtualenv step. 03:20:22 INFO - Running pre-action listener: _resource_record_pre_action 03:20:22 INFO - Running main action method: create_virtualenv 03:20:22 INFO - Creating virtualenv /builds/slave/test/build/venv 03:20:22 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:20:22 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:20:22 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:20:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:20:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:20:24 INFO - Installing distribute.............................................................................................................................................................................................done. 03:20:25 INFO - Installing pip...............done. 03:20:25 INFO - Return code: 0 03:20:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:20:25 INFO - Reading from file tmpfile_stdout 03:20:25 INFO - Output received: 03:20:25 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:20:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:20:25 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')]} 03:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:25 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')]} 03:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:25 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 0xb3f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf090>, '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 0xeafd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea9f90>, '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': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', '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 03:20:25 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 03:20:25 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 03:20:25 INFO - Using env: {'DISPLAY': ':0', 03:20:25 INFO - 'HOME': '/home/cltbld', 03:20:25 INFO - 'LANG': 'en_US.UTF-8', 03:20:25 INFO - 'LANGUAGE': 'en_US:en', 03:20:25 INFO - 'LOGNAME': 'cltbld', 03:20:25 INFO - 'MAIL': '/var/mail/cltbld', 03:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:25 INFO - 'MOZ_NO_REMOTE': '1', 03:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:25 INFO - 'NO_EM_RESTART': '1', 03:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:25 INFO - 'PWD': '/builds/slave/test', 03:20:25 INFO - 'SHELL': '/bin/bash', 03:20:25 INFO - 'SHLVL': '1', 03:20:25 INFO - 'TERM': 'linux', 03:20:25 INFO - 'TMOUT': '86400', 03:20:25 INFO - 'USER': 'cltbld', 03:20:25 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', 03:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:25 INFO - '_': '/tools/buildbot/bin/python'} 03:20:26 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:20:26 INFO - Downloading/unpacking pip>=1.5 03:20:26 INFO - Running setup.py egg_info for package pip 03:20:26 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:26 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:26 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:26 INFO - Installing collected packages: pip 03:20:26 INFO - Found existing installation: pip 1.1 03:20:26 INFO - Uninstalling pip: 03:20:26 INFO - Successfully uninstalled pip 03:20:26 INFO - Running setup.py install for pip 03:20:26 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:26 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:26 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:26 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:20:26 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:20:26 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:20:26 INFO - Successfully installed pip 03:20:26 INFO - Cleaning up... 03:20:26 INFO - Return code: 0 03:20:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:20: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')]} 03:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20: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')]} 03:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20: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', '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 0xb3f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf090>, '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 0xeafd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea9f90>, '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': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', '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 03:20: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:20: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 psutil>=3.1.1 03:20:26 INFO - Using env: {'DISPLAY': ':0', 03:20:26 INFO - 'HOME': '/home/cltbld', 03:20:26 INFO - 'LANG': 'en_US.UTF-8', 03:20:26 INFO - 'LANGUAGE': 'en_US:en', 03:20:26 INFO - 'LOGNAME': 'cltbld', 03:20:26 INFO - 'MAIL': '/var/mail/cltbld', 03:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:26 INFO - 'MOZ_NO_REMOTE': '1', 03:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:26 INFO - 'NO_EM_RESTART': '1', 03:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:26 INFO - 'PWD': '/builds/slave/test', 03:20:26 INFO - 'SHELL': '/bin/bash', 03:20:26 INFO - 'SHLVL': '1', 03:20:26 INFO - 'TERM': 'linux', 03:20:26 INFO - 'TMOUT': '86400', 03:20:26 INFO - 'USER': 'cltbld', 03:20:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', 03:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:26 INFO - '_': '/tools/buildbot/bin/python'} 03:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:27 INFO - Downloading/unpacking psutil>=3.1.1 03:20: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 03:20: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 03:20: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 03:20: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 03:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:20:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:28 INFO - Installing collected packages: psutil 03:20:28 INFO - Running setup.py install for psutil 03:20:28 INFO - building 'psutil._psutil_linux' extension 03:20:28 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 03:20:29 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 03:20:29 INFO - building 'psutil._psutil_posix' extension 03:20:29 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 03:20:30 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 03:20:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:30 INFO - Successfully installed psutil 03:20:30 INFO - Cleaning up... 03:20:30 INFO - Return code: 0 03:20:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:20:30 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')]} 03:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:30 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')]} 03:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:30 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 0xb3f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf090>, '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 0xeafd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea9f90>, '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': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', '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 03:20:30 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 03:20:30 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 03:20:30 INFO - Using env: {'DISPLAY': ':0', 03:20:30 INFO - 'HOME': '/home/cltbld', 03:20:30 INFO - 'LANG': 'en_US.UTF-8', 03:20:30 INFO - 'LANGUAGE': 'en_US:en', 03:20:30 INFO - 'LOGNAME': 'cltbld', 03:20:30 INFO - 'MAIL': '/var/mail/cltbld', 03:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:30 INFO - 'MOZ_NO_REMOTE': '1', 03:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:30 INFO - 'NO_EM_RESTART': '1', 03:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:30 INFO - 'PWD': '/builds/slave/test', 03:20:30 INFO - 'SHELL': '/bin/bash', 03:20:30 INFO - 'SHLVL': '1', 03:20:30 INFO - 'TERM': 'linux', 03:20:30 INFO - 'TMOUT': '86400', 03:20:30 INFO - 'USER': 'cltbld', 03:20:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', 03:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:30 INFO - '_': '/tools/buildbot/bin/python'} 03:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:20:31 INFO - Installing collected packages: mozsystemmonitor 03:20:31 INFO - Running setup.py install for mozsystemmonitor 03:20:31 INFO - Successfully installed mozsystemmonitor 03:20:31 INFO - Cleaning up... 03:20:31 INFO - Return code: 0 03:20:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb3f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf090>, '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 0xeafd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea9f90>, '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': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', '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 03:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:20:31 INFO - Using env: {'DISPLAY': ':0', 03:20:31 INFO - 'HOME': '/home/cltbld', 03:20:31 INFO - 'LANG': 'en_US.UTF-8', 03:20:31 INFO - 'LANGUAGE': 'en_US:en', 03:20:31 INFO - 'LOGNAME': 'cltbld', 03:20:31 INFO - 'MAIL': '/var/mail/cltbld', 03:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:31 INFO - 'MOZ_NO_REMOTE': '1', 03:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:31 INFO - 'NO_EM_RESTART': '1', 03:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:31 INFO - 'PWD': '/builds/slave/test', 03:20:31 INFO - 'SHELL': '/bin/bash', 03:20:31 INFO - 'SHLVL': '1', 03:20:31 INFO - 'TERM': 'linux', 03:20:31 INFO - 'TMOUT': '86400', 03:20:31 INFO - 'USER': 'cltbld', 03:20:31 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', 03:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:31 INFO - '_': '/tools/buildbot/bin/python'} 03:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:31 INFO - Downloading/unpacking jsonschema==2.5.1 03:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:20:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:33 INFO - Downloading functools32-3.2.3-2.tar.gz 03:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:20:33 INFO - warning: no files found matching '*.txt' 03:20:33 INFO - no previously-included directories found matching 'build' 03:20:33 INFO - no previously-included directories found matching 'dist' 03:20:33 INFO - no previously-included directories found matching '.git*' 03:20:33 INFO - Installing collected packages: jsonschema, functools32 03:20:33 INFO - Running setup.py install for functools32 03:20:33 INFO - warning: no files found matching '*.txt' 03:20:33 INFO - no previously-included directories found matching 'build' 03:20:33 INFO - no previously-included directories found matching 'dist' 03:20:33 INFO - no previously-included directories found matching '.git*' 03:20:33 INFO - Successfully installed jsonschema functools32 03:20:33 INFO - Cleaning up... 03:20:33 INFO - Return code: 0 03:20:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:33 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 0xb3f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf090>, '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 0xeafd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea9f90>, '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': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', '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 03:20:33 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 03:20:33 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 03:20:33 INFO - Using env: {'DISPLAY': ':0', 03:20:33 INFO - 'HOME': '/home/cltbld', 03:20:33 INFO - 'LANG': 'en_US.UTF-8', 03:20:33 INFO - 'LANGUAGE': 'en_US:en', 03:20:33 INFO - 'LOGNAME': 'cltbld', 03:20:33 INFO - 'MAIL': '/var/mail/cltbld', 03:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:33 INFO - 'MOZ_NO_REMOTE': '1', 03:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:33 INFO - 'NO_EM_RESTART': '1', 03:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:33 INFO - 'PWD': '/builds/slave/test', 03:20:33 INFO - 'SHELL': '/bin/bash', 03:20:33 INFO - 'SHLVL': '1', 03:20:33 INFO - 'TERM': 'linux', 03:20:33 INFO - 'TMOUT': '86400', 03:20:33 INFO - 'USER': 'cltbld', 03:20:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', 03:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:33 INFO - '_': '/tools/buildbot/bin/python'} 03:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:20:33 INFO - Cleaning up... 03:20:33 INFO - Return code: 0 03:20:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:33 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 0xb3f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf090>, '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 0xeafd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea9f90>, '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': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', '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 03:20:33 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 03:20:33 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 03:20:33 INFO - Using env: {'DISPLAY': ':0', 03:20:33 INFO - 'HOME': '/home/cltbld', 03:20:33 INFO - 'LANG': 'en_US.UTF-8', 03:20:33 INFO - 'LANGUAGE': 'en_US:en', 03:20:33 INFO - 'LOGNAME': 'cltbld', 03:20:33 INFO - 'MAIL': '/var/mail/cltbld', 03:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:33 INFO - 'MOZ_NO_REMOTE': '1', 03:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:33 INFO - 'NO_EM_RESTART': '1', 03:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:33 INFO - 'PWD': '/builds/slave/test', 03:20:33 INFO - 'SHELL': '/bin/bash', 03:20:33 INFO - 'SHLVL': '1', 03:20:33 INFO - 'TERM': 'linux', 03:20:33 INFO - 'TMOUT': '86400', 03:20:33 INFO - 'USER': 'cltbld', 03:20:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', 03:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:33 INFO - '_': '/tools/buildbot/bin/python'} 03:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:33 INFO - Downloading/unpacking blobuploader==1.2.4 03:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:35 INFO - Downloading blobuploader-1.2.4.tar.gz 03:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:20:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:20:35 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 03:20:35 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 03:20:35 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 03:20:35 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 03:20:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:20:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:20: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 03:20: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 03:20: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 03:20: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 03:20:36 INFO - Downloading docopt-0.6.1.tar.gz 03:20:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:20:36 INFO - Installing collected packages: blobuploader, requests, docopt 03:20:36 INFO - Running setup.py install for blobuploader 03:20:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:20:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:20:36 INFO - Running setup.py install for requests 03:20:36 INFO - Running setup.py install for docopt 03:20:37 INFO - Successfully installed blobuploader requests docopt 03:20:37 INFO - Cleaning up... 03:20:37 INFO - Return code: 0 03:20:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:37 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 0xb3f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf090>, '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 0xeafd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea9f90>, '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': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', '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 03:20:37 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 03:20:37 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 03:20:37 INFO - Using env: {'DISPLAY': ':0', 03:20:37 INFO - 'HOME': '/home/cltbld', 03:20:37 INFO - 'LANG': 'en_US.UTF-8', 03:20:37 INFO - 'LANGUAGE': 'en_US:en', 03:20:37 INFO - 'LOGNAME': 'cltbld', 03:20:37 INFO - 'MAIL': '/var/mail/cltbld', 03:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:37 INFO - 'MOZ_NO_REMOTE': '1', 03:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:37 INFO - 'NO_EM_RESTART': '1', 03:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:37 INFO - 'PWD': '/builds/slave/test', 03:20:37 INFO - 'SHELL': '/bin/bash', 03:20:37 INFO - 'SHLVL': '1', 03:20:37 INFO - 'TERM': 'linux', 03:20:37 INFO - 'TMOUT': '86400', 03:20:37 INFO - 'USER': 'cltbld', 03:20:37 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', 03:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:37 INFO - '_': '/tools/buildbot/bin/python'} 03:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:37 INFO - Running setup.py (path:/tmp/pip-iYphIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:37 INFO - Running setup.py (path:/tmp/pip-F5cANp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:37 INFO - Running setup.py (path:/tmp/pip-PPDWuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:37 INFO - Running setup.py (path:/tmp/pip-a8OIzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:37 INFO - Running setup.py (path:/tmp/pip-GxnlO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:37 INFO - Running setup.py (path:/tmp/pip-PNwnxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:37 INFO - Running setup.py (path:/tmp/pip-ww2DYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:37 INFO - Running setup.py (path:/tmp/pip-vxRuAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:37 INFO - Running setup.py (path:/tmp/pip-rG3KiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:37 INFO - Running setup.py (path:/tmp/pip-1lSAqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:37 INFO - Running setup.py (path:/tmp/pip-v8tGqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:38 INFO - Running setup.py (path:/tmp/pip-nbDXnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:38 INFO - Running setup.py (path:/tmp/pip-zuv0fW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:38 INFO - Running setup.py (path:/tmp/pip-Ye__fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:38 INFO - Running setup.py (path:/tmp/pip-DrYeGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:38 INFO - Running setup.py (path:/tmp/pip-jo3Vyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:38 INFO - Running setup.py (path:/tmp/pip-neKSLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:20:38 INFO - Running setup.py install for manifestparser 03:20:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:20:38 INFO - Running setup.py install for mozcrash 03:20:38 INFO - Running setup.py install for mozdebug 03:20:38 INFO - Running setup.py install for mozdevice 03:20:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:20:38 INFO - Running setup.py install for mozfile 03:20:38 INFO - Running setup.py install for mozhttpd 03:20:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Running setup.py install for mozinfo 03:20:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Running setup.py install for mozInstall 03:20:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Running setup.py install for mozleak 03:20:39 INFO - Running setup.py install for mozlog 03:20:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Running setup.py install for moznetwork 03:20:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Running setup.py install for mozprocess 03:20:39 INFO - Running setup.py install for mozprofile 03:20:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Running setup.py install for mozrunner 03:20:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Running setup.py install for mozscreenshot 03:20:39 INFO - Running setup.py install for moztest 03:20:40 INFO - Running setup.py install for mozversion 03:20:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:20:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:20:40 INFO - Cleaning up... 03:20:40 INFO - Return code: 0 03:20:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:40 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 0xb3f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf090>, '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 0xeafd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea9f90>, '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': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', '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 03:20:40 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 03:20:40 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 03:20:40 INFO - Using env: {'DISPLAY': ':0', 03:20:40 INFO - 'HOME': '/home/cltbld', 03:20:40 INFO - 'LANG': 'en_US.UTF-8', 03:20:40 INFO - 'LANGUAGE': 'en_US:en', 03:20:40 INFO - 'LOGNAME': 'cltbld', 03:20:40 INFO - 'MAIL': '/var/mail/cltbld', 03:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:40 INFO - 'MOZ_NO_REMOTE': '1', 03:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:40 INFO - 'NO_EM_RESTART': '1', 03:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:40 INFO - 'PWD': '/builds/slave/test', 03:20:40 INFO - 'SHELL': '/bin/bash', 03:20:40 INFO - 'SHLVL': '1', 03:20:40 INFO - 'TERM': 'linux', 03:20:40 INFO - 'TMOUT': '86400', 03:20:40 INFO - 'USER': 'cltbld', 03:20:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', 03:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:40 INFO - '_': '/tools/buildbot/bin/python'} 03:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:40 INFO - Running setup.py (path:/tmp/pip-eZt9an-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:40 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)) 03:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:40 INFO - Running setup.py (path:/tmp/pip-fTkHXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:40 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)) 03:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:40 INFO - Running setup.py (path:/tmp/pip-wXV6Pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:40 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)) 03:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:40 INFO - Running setup.py (path:/tmp/pip-30xIZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:40 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)) 03:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:40 INFO - Running setup.py (path:/tmp/pip-rVfVGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:40 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)) 03:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:40 INFO - Running setup.py (path:/tmp/pip-2lyNpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:40 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)) 03:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:40 INFO - Running setup.py (path:/tmp/pip-wW3HDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:40 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)) 03:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:40 INFO - Running setup.py (path:/tmp/pip-O6YgWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:40 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)) 03:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:40 INFO - Running setup.py (path:/tmp/pip-n7Hh1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:41 INFO - Running setup.py (path:/tmp/pip-Xi9Bv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:41 INFO - Running setup.py (path:/tmp/pip-ZMC_UK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:41 INFO - Running setup.py (path:/tmp/pip-4cW0O9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:41 INFO - Running setup.py (path:/tmp/pip-kYIeOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:41 INFO - Running setup.py (path:/tmp/pip-RW0dH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:41 INFO - Running setup.py (path:/tmp/pip-AlzwzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:41 INFO - Running setup.py (path:/tmp/pip-Y8f1xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:41 INFO - Running setup.py (path:/tmp/pip-CJSaWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:41 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)) 03:20:41 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)) 03:20:41 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)) 03:20:41 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)) 03:20:41 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)) 03:20:41 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)) 03:20:41 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)) 03:20:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:42 INFO - Downloading blessings-1.6.tar.gz 03:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:20:42 INFO - Installing collected packages: blessings 03:20:42 INFO - Running setup.py install for blessings 03:20:42 INFO - Successfully installed blessings 03:20:42 INFO - Cleaning up... 03:20:43 INFO - Return code: 0 03:20:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:20:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:43 INFO - Reading from file tmpfile_stdout 03:20:43 INFO - Current package versions: 03:20:43 INFO - argparse == 1.2.1 03:20:43 INFO - blessings == 1.6 03:20:43 INFO - blobuploader == 1.2.4 03:20:43 INFO - docopt == 0.6.1 03:20:43 INFO - functools32 == 3.2.3-2 03:20:43 INFO - jsonschema == 2.5.1 03:20:43 INFO - manifestparser == 1.1 03:20:43 INFO - mozInstall == 1.13 03:20:43 INFO - mozcrash == 1.0 03:20:43 INFO - mozdebug == 0.1 03:20:43 INFO - mozdevice == 0.51 03:20:43 INFO - mozfile == 1.2 03:20:43 INFO - mozhttpd == 0.7 03:20:43 INFO - mozinfo == 0.10 03:20:43 INFO - mozleak == 0.1 03:20:43 INFO - mozlog == 3.5 03:20:43 INFO - moznetwork == 0.27 03:20:43 INFO - mozprocess == 0.25 03:20:43 INFO - mozprofile == 0.28 03:20:43 INFO - mozrunner == 6.13 03:20:43 INFO - mozscreenshot == 0.1 03:20:43 INFO - mozsystemmonitor == 0.3 03:20:43 INFO - moztest == 0.8 03:20:43 INFO - mozversion == 1.4 03:20:43 INFO - psutil == 3.1.1 03:20:43 INFO - requests == 1.2.3 03:20:43 INFO - wsgiref == 0.1.2 03:20:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:43 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')]} 03:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:43 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')]} 03:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:43 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 0xb3f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf090>, '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 0xeafd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea9f90>, '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': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', '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 03:20:43 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 03:20:43 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 03:20:43 INFO - Using env: {'DISPLAY': ':0', 03:20:43 INFO - 'HOME': '/home/cltbld', 03:20:43 INFO - 'LANG': 'en_US.UTF-8', 03:20:43 INFO - 'LANGUAGE': 'en_US:en', 03:20:43 INFO - 'LOGNAME': 'cltbld', 03:20:43 INFO - 'MAIL': '/var/mail/cltbld', 03:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:43 INFO - 'MOZ_NO_REMOTE': '1', 03:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:43 INFO - 'NO_EM_RESTART': '1', 03:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:43 INFO - 'PWD': '/builds/slave/test', 03:20:43 INFO - 'SHELL': '/bin/bash', 03:20:43 INFO - 'SHLVL': '1', 03:20:43 INFO - 'TERM': 'linux', 03:20:43 INFO - 'TMOUT': '86400', 03:20:43 INFO - 'USER': 'cltbld', 03:20:43 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', 03:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:43 INFO - '_': '/tools/buildbot/bin/python'} 03:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:43 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)) 03:20:43 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)) 03:20:43 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)) 03:20:43 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)) 03:20:43 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)) 03:20:43 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)) 03:20:43 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)) 03:20:43 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)) 03:20:43 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)) 03:20:43 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:20:44 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)) 03:20:44 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)) 03:20:44 INFO - Installing collected packages: simplejson 03:20:44 INFO - Running setup.py install for simplejson 03:20:44 INFO - building 'simplejson._speedups' extension 03:20:44 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 03:20:45 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 03:20:45 INFO - Successfully installed simplejson 03:20:45 INFO - Cleaning up... 03:20:45 INFO - Return code: 0 03:20:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb3f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf090>, '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 0xeafd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea9f90>, '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': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', '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 03:20:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:20:45 INFO - Using env: {'DISPLAY': ':0', 03:20:45 INFO - 'HOME': '/home/cltbld', 03:20:45 INFO - 'LANG': 'en_US.UTF-8', 03:20:45 INFO - 'LANGUAGE': 'en_US:en', 03:20:45 INFO - 'LOGNAME': 'cltbld', 03:20:45 INFO - 'MAIL': '/var/mail/cltbld', 03:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:45 INFO - 'MOZ_NO_REMOTE': '1', 03:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:45 INFO - 'NO_EM_RESTART': '1', 03:20:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:45 INFO - 'PWD': '/builds/slave/test', 03:20:45 INFO - 'SHELL': '/bin/bash', 03:20:45 INFO - 'SHLVL': '1', 03:20:45 INFO - 'TERM': 'linux', 03:20:45 INFO - 'TMOUT': '86400', 03:20:45 INFO - 'USER': 'cltbld', 03:20:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', 03:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:45 INFO - '_': '/tools/buildbot/bin/python'} 03:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:20:45 INFO - Cleaning up... 03:20:45 INFO - Return code: 0 03:20:45 INFO - Running post-action listener: _resource_record_post_action 03:20:45 INFO - Running post-action listener: _start_resource_monitoring 03:20:45 INFO - Starting resource monitoring. 03:20:45 INFO - [mozharness: 2017-09-15 10:20:45.929575Z] Finished create-virtualenv step (success) 03:20:45 INFO - [mozharness: 2017-09-15 10:20:45.930578Z] Running install step. 03:20:45 INFO - Running pre-action listener: _resource_record_pre_action 03:20:45 INFO - Running main action method: install 03:20:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:46 INFO - Reading from file tmpfile_stdout 03:20:46 INFO - Detecting whether we're running mozinstall >=1.0... 03:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:20:46 INFO - Reading from file tmpfile_stdout 03:20:46 INFO - Output received: 03:20:46 INFO - Usage: mozinstall [options] installer 03:20:46 INFO - Options: 03:20:46 INFO - -h, --help show this help message and exit 03:20:46 INFO - -d DEST, --destination=DEST 03:20:46 INFO - Directory to install application into. [default: 03:20:46 INFO - "/builds/slave/test"] 03:20:46 INFO - --app=APP Application being installed. [default: firefox] 03:20:46 INFO - mkdir: /builds/slave/test/build/application 03:20:46 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'] 03:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:21:03 INFO - Reading from file tmpfile_stdout 03:21:03 INFO - Output received: 03:21:03 INFO - /builds/slave/test/build/application/firefox/firefox 03:21:03 INFO - Running post-action listener: _resource_record_post_action 03:21:03 INFO - [mozharness: 2017-09-15 10:21:03.852523Z] Finished install step (success) 03:21:03 INFO - [mozharness: 2017-09-15 10:21:03.852774Z] Running setup-mitmproxy step. 03:21:03 INFO - Running pre-action listener: _resource_record_pre_action 03:21:03 INFO - Running main action method: setup_mitmproxy 03:21:03 INFO - Skipping: mitmproxy is not required 03:21:03 INFO - Running post-action listener: _resource_record_post_action 03:21:03 INFO - [mozharness: 2017-09-15 10:21:03.853901Z] Finished setup-mitmproxy step (success) 03:21:03 INFO - [mozharness: 2017-09-15 10:21:03.854121Z] Running run-tests step. 03:21:03 INFO - Running pre-action listener: _resource_record_pre_action 03:21:03 INFO - Running pre-action listener: _set_gcov_prefix 03:21:03 INFO - Running main action method: run_tests 03:21:03 WARNING - Try message not found. 03:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:21:03 INFO - Python 2.7.3 03:21:03 INFO - Return code: 0 03:21:03 INFO - grabbing minidump binary from tooltool 03:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:03 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 0xeaf090>, '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 0xeafd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea9f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:21:03 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 03:21:03 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 03:21:03 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 03:21:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:21:03 INFO - Return code: 0 03:21:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:21:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:21:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:21:03 INFO - ENV: RUST_BACKTRACE is now full 03:21:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:21:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:21:03 INFO - Using env: {'DISPLAY': ':0', 03:21:03 INFO - 'HOME': '/home/cltbld', 03:21:03 INFO - 'LANG': 'en_US.UTF-8', 03:21:03 INFO - 'LANGUAGE': 'en_US:en', 03:21:03 INFO - 'LOGNAME': 'cltbld', 03:21:03 INFO - 'MAIL': '/var/mail/cltbld', 03:21:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:03 INFO - 'MOZ_NO_REMOTE': '1', 03:21:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:03 INFO - 'NO_EM_RESTART': '1', 03:21:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:03 INFO - 'PWD': '/builds/slave/test', 03:21:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:03 INFO - 'RUST_BACKTRACE': 'full', 03:21:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:03 INFO - 'SHELL': '/bin/bash', 03:21:03 INFO - 'SHLVL': '1', 03:21:03 INFO - 'TERM': 'linux', 03:21:03 INFO - 'TMOUT': '86400', 03:21:03 INFO - 'USER': 'cltbld', 03:21:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', 03:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:03 INFO - '_': '/tools/buildbot/bin/python'} 03:21:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:21:04 INFO - mozversion application_buildid: 20170915090318 03:21:04 INFO - mozversion application_changeset: f36106f3f52a9bb2769860d20568c589fc2498d0 03:21:04 INFO - mozversion application_display_name: Nightly 03:21:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:21:04 INFO - mozversion application_name: Firefox 03:21:04 INFO - mozversion application_remotingname: firefox 03:21:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:21:04 INFO - mozversion application_vendor: Mozilla 03:21:04 INFO - mozversion application_version: 57.0a1 03:21:04 INFO - mozversion platform_buildid: 20170915090318 03:21:04 INFO - mozversion platform_changeset: f36106f3f52a9bb2769860d20568c589fc2498d0 03:21:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:21:04 INFO - mozversion platform_version: 57.0a1 03:21:04 INFO - using testdate: 1505470864 03:21:04 INFO - actual date: 1505470864 03:21:04 INFO - starting webserver on 'localhost:40742' 03:21:04 INFO - SUITE-START | Running 2 tests 03:21:04 INFO - TEST-START | dromaeo_css 03:21:04 INFO - Initialising browser for dromaeo_css test... 03:21:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40742/getInfo.html -profile /tmp/tmpgYEStW/profile 03:21:04 INFO - TEST-INFO | started process 3583 (/builds/slave/test/build/application/firefox/firefox http://localhost:40742/getInfo.html) 03:21:13 INFO - TEST-INFO | 3583: exit 0 03:21:13 INFO - Browser initialized. 03:21:13 INFO - Running cycle 1/1 for dromaeo_css test... 03:21:13 INFO - Using env: {'DISPLAY': ':0', 03:21:13 INFO - 'HOME': '/home/cltbld', 03:21:13 INFO - 'JSGC_DISABLE_POISONING': '1', 03:21:13 INFO - 'LANG': 'en_US.UTF-8', 03:21:13 INFO - 'LANGUAGE': 'en_US:en', 03:21:13 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:21:13 INFO - 'LOGNAME': 'cltbld', 03:21:13 INFO - 'MAIL': '/var/mail/cltbld', 03:21:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:13 INFO - 'MOZ_CRASHREPORTER': '1', 03:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:13 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:21:13 INFO - 'MOZ_NO_REMOTE': '1', 03:21:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:13 INFO - 'NO_EM_RESTART': '1', 03:21:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:13 INFO - 'PWD': '/builds/slave/test', 03:21:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:13 INFO - 'RUST_BACKTRACE': 'full', 03:21:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:13 INFO - 'SHELL': '/bin/bash', 03:21:13 INFO - 'SHLVL': '1', 03:21:13 INFO - 'TERM': 'linux', 03:21:13 INFO - 'TMOUT': '86400', 03:21:13 INFO - 'USER': 'cltbld', 03:21:13 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', 03:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:13 INFO - '_': '/tools/buildbot/bin/python'} 03:21:13 INFO - TEST-INFO | started process 3825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgYEStW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:14 INFO - PID 3825 | 03:21:14 INFO - PID 3825 | (/builds/slave/test/build/application/firefox/firefox:3875): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:21:14 INFO - PID 3825 | 03:21:25 INFO - PID 3825 | RSS: Main: 161263616 03:21:25 INFO - PID 3825 | 03:24:22 INFO - PID 3825 | Cycle 1(1): loaded http://localhost:40742/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40742/tests/dromaeo/cssquery-ext.html) 03:24:23 INFO - PID 3825 | RSS: Main: 169025536 03:24:23 INFO - PID 3825 | 03:27:25 INFO - PID 3825 | Cycle 1(1): loaded http://localhost:40742/tests/dromaeo/cssquery-ext.html (next: http://localhost:40742/tests/dromaeo/cssquery-jquery.html) 03:27:25 INFO - PID 3825 | RSS: Main: 164835328 03:27:25 INFO - PID 3825 | 03:30:27 INFO - PID 3825 | Cycle 1(1): loaded http://localhost:40742/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40742/tests/dromaeo/cssquery-mootools.html) 03:30:27 INFO - PID 3825 | RSS: Main: 165613568 03:30:27 INFO - PID 3825 | 03:33:29 INFO - PID 3825 | Cycle 1(1): loaded http://localhost:40742/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40742/tests/dromaeo/cssquery-prototype.html) 03:33:30 INFO - PID 3825 | RSS: Main: 165699584 03:33:30 INFO - PID 3825 | 03:36:33 INFO - PID 3825 | Cycle 1(1): loaded http://localhost:40742/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40742/tests/dromaeo/cssquery-yui.html) 03:36:33 INFO - PID 3825 | RSS: Main: 167129088 03:36:33 INFO - PID 3825 | 03:39:35 INFO - PID 3825 | Cycle 1(1): loaded http://localhost:40742/tests/dromaeo/cssquery-yui.html (next: http://localhost:40742/tests/dromaeo/cssquery-dojo.html) 03:39:35 INFO - PID 3825 | RSS: Main: 170098688 03:39:35 INFO - PID 3825 | 03:39:35 INFO - PID 3825 | __start_tp_report 03:39:35 INFO - PID 3825 | _x_x_mozilla_page_load 03:39:35 INFO - PID 3825 | _x_x_mozilla_page_load_details 03:39:35 INFO - PID 3825 | |i|pagename|runs| 03:39:35 INFO - PID 3825 | |0;dojo.html;3785;3822.3502004659213;3825.9617403825955;3892.630200130988;3896.805159742012;6111.755529778803;6219.067139929008;6245.0632405139195;6249.4687951524065;6270.184875966123;6211.844703882416;6241.750329986795;6256.906146407796;6354.01512765521;6362.650054247015;5573.804916827912;5587.078132108218;5626.268585083933;5673.744681489343;5680.971595142039;257.983800037045;5549.056660367727;5587.972060139694;5638.238837756912;5698.173764804101;5535.308086489189;5544.63959842609;5578.665280083208;5590.301212348457;5631.0708733059;5526.917096243559;5573.080441727151;5604.243427137366;5649;5654.547636189095;5551.77792888284;5561.221428999943;5616.494515493584;5630.761232528837;5635.408282130358;6146.539009574255;6201.286852011986;6254.155688981975;6261.092141639482;6286.874262514724;6666.200055993263;6702.899456508157;6713.597184168965;6721.462283017347;6742.460603151736;6812.727490900358;6821.317868213188;6838.589684618939;6847.041414201966;6849.212340580847;6189;6260.686965651745;6341.778037768702;6342.048692696087;6386.808395748135;6872.862542749217;6879.58722476653;6882.105326307648;6900.827479313058;6907.689153988083;6614.86770264592;6641.468682505388;6641.501887358468;6642.767503137367;6644.202695676453;6662.533622646368;6728.058071869942;6732.4950628703045;6740.0226967090475;6741.696623651947;6677.866442671119;6681.665916704145;6681.9331806682285;6694.497912656473;6706.027625994301;6679.56582822115;6680.665966701646;6691;6712.060311556386;6713.832154196184;4921.311016457699;4924.039812236651;4969.676970996874;4980.252962055648;4985.326980857538;4405.449318835145;4491.640668746492;4497.775111244425;4539.886502837456;4542.636589072932;6176.969115154396;6235.719392627343;6302.621842689362;6304.243490781136;6312.5581209314905;6797;6809.659517024228;6816.420604248694;6838.658067096625;6843.144606924135;6241.21984751906;6252.656103914328;6256.311805701369;6328.398802113792;6350.396712312323;5381.354237491526;5391.353037635509;5420.945790542044;5526.364468086222;5529.529989950819;6947.617881016491;6949.061876646689;6953.860922781516;6962.477814163958;6965.5124141309625;6443.162388889415;6656.5340426169705;6688.933110668929;6699.5310328276555;6708.698108585223;7031.191412987368;7052.929470705228;7058.858822823412;7070.116235470567;7077.610731409822;6654.800355989328;6678.3989440950545;6740.359665831738;6772.0857684212;6776.627285499345;6654.101696270942;6735;6739.258681545124;6826.249112597709;6867.141607299088;6429.646369449538;6467.288598254282;6517.967410162919;6521.347865213441;6538.803835884931;6525.314841941527;6534.509911756542;6548.279689234085;6560.967195163994;6562.409383155539;6407.935920640734;6409.327020662763;6409.9679501602195;6503.317151699192;6504.642244676588;6399.7440102395385;6491.902621460777;6518.315576864361;6631.104800851823;6632.137822083098;6246.843828904313;6334.9366506334345;6345.238571371465;6347.5239357047485;6348 03:39:35 INFO - PID 3825 | |1;ext.html;935.6865450074225;946.2335508238323;978.3445091788501;995.5868314649423;997.3616885193472;43664;44496;44646.55353446465;44665.106697866024;44771.55228447715;40513.392299115534;40591.59408405922;40644;40815.59184408155;40872.79563602178;7527.13437954634;7655.425843061765;7656.196099409565;7659.885101723478;7680.500767450098;7282.19895811463;7339.743108991186;7342.4860259781835;7342.853142937138;7344.816379590527;8034.9598252008955;8223.506589604613;8223.876641850376;8226.42415030948;8228.876566851503;8033.758987230392;8080.313173380269;8136.877946830773;8146.022477302702;8153.592320384017;7897.091834439056;8027.397945154137;8077.192280771876;8091.433599648027;8095.635696393676;41879.790601047105;41987.160256794996;41987.58012419867;42089.78955105205;42108.3683744741;3790.1851102012924;3800.847966081353;3847.61523847613;3852.672522835562;3855.8072096395067;33615.15962100943;33805.830970845236;33935.321293574234;34060.82969585136;34092;5499.615026948115;5539.639923404966;5567.164925261202;5575.749091290902;5684.516816070639;216970;217762;218036;218285;219431;53945.460545394046;54253.45746542484;54502.72748636232;54849;54876.72561637166;56966.71516642473;57029.42970570324;57207.14189287164;57238.42761572331;57277.427225728046;17258.223379947933;17563.73654395185;17575.121243937752;17585.824141758418;17611.647767044586;14148.787768183485;14281.85718142826;14285.714285714228;14328.068675536057;14328.14031158134;15422.537323880302;15676.137812420198;15704.764428533581;15724.29240684172;15795.763063554055;6178.320384757673;6200.875982480416;6202.34875338092;6246.344133865879;6279.7802076928;1125.2235957189514;1127.3912087472672;1129.8192289233684;1135.2450620337547;1142.9657110286705;25434.491310174064;26073.217803465926;26332.21003369902;26358.20925372242;26399.472010559683;1232.7596118756755;1239.3431481314917;1249.9687507812378;1260.1431026901794;1264.8482182138202;13719.862801372059;13734.793978090336;14015.50945716895;14131.57605271823;14269.64325891861;272317;289738;291065;291721;291827;51258.23112653313;51705;51820.740896295276;57844.843103137704;59239.40760592425;1514.9166795826336;1555.3312075807512;1566.0368873142936;1570.6073481629592;1578.8579027887315;30985.69014309828;31386.529202062444;31587.684123159393;31606.367872642877;31832.52251216187;41814.79092604518;41900.37149442822;41914.79042604767;41991.370129447474;42010.57989420189;232759;233509;233529;234005;235123;36331.09172270714;36398;36620;36698.8165059173;36823.44764828583;45083;46459.303110452696;46901;46921.76539117283;47084.29373559331;33924.32151357008;34246.315073697886;34665.480017800255;34995;35246;34406.65593344034;34520.82739586286;34668;34698.306033878674;35031.47452788159;40558.1888362237;40638.796806016966;40789.796051019555;40825;40841.38737918874;34063.82968085243;34147;34350.656493435745;34355.65644343525;35063.82468087643;25333.366665832764;25747.742522574536;26240.73759262459;26507.337316566467;26645.200643980712 03:39:35 INFO - PID 3825 | |2;jquery.html;597.9790707325244;603.3393434189561;609.7987664070857;615.9045347971063;621.5214285000549;23457.530849383023;23977.880110599446;24053.398665033383;24072;24115.276541703755;20180.39458816238;23959.28122156334;24029.158979435724;24058.879705601492;24104.397390065256;6790.898136527943;6869.862602747967;6914;6916.4812639052025;6918.238993710688;6586.93413065868;6777.423918966893;6868.690908909086;6877.931220687779;6881.4838887083415;6809.795706128824;6813.829654258634;6814.1482314710665;6819.318068193191;6822.829429264283;6791.728330866759;6800.489963252776;6805.965970170167;6818.181818181801;6827.965860170717;6334.936650633481;6345.9365406345805;6353.30113687494;6356.45970092538;6359.20509936258;29615;29876.103716888527;30022;30127.246818829484;30602.234944126576;2216.1689366487567;2269.6028195065796;2271.5797577448225;2272.3410211038777;2277.6355783074628;19481.31815386469;19884.20463181471;20004.199832006703;20087.096080676405;20110.49723756903;2299.0458959531775;2324.59319619066;2333.6849525314205;2367.7513861044513;2371.1108334374608;139581.3020934889;143374;151917;156591.21704391518;157259.2137039319;15326.463573774865;15398.230088495531;15860.286287117107;15949.20253987296;16208.189590520427;25094.24717258485;25173;25176.622350664755;25211;25255.62116568253;10333.328333658288;10612.25714200014;10641.574337026586;10693.411862347646;10710.73223169427;9408.482533460725;9498.430094194371;9502.667406640734;9537.904620953701;9667.081627245401;9521.571529281198;9523.19052880513;9668.323217374857;9947.701568952943;10013.849792253122;2757.655293088364;2807.087696498646;2867.8996235132086;2938.3682508260827;2967.7922545422043;1053.594366169015;1055.6041484443333;1066.6000249906285;1068.1881769854965;1071.7481391872905;20978.580428391346;21008.894955525124;21070.15719371208;21407.46481337979;21515.78484215169;1093.907017903487;1111.6831702964616;1118.983215251772;1128.227164392394;1142.9885701143048;11484;11668.591599293984;11779.411029448493;11784.764304713857;11862.228955118062;558028;560779;571131;584026;586245;126960.36519817526;128981;129847.35076324746;131171;131721;1187.7469269920146;1212.963611091651;1250.7248405350808;1252.0234217310513;1255.416231452379;18192.363267285582;18464.538386540444;18696.15867285948;18772.24911003599;18968.620627587094;60803.695981519806;62911.685441572496;63257;63456.365436346896;64258;74101.25898740944;74499.2550074514;74726.62636686781;75834.62082689772;76413.61793190999;15142.621434464227;15250.161241131844;15284;15298.847011530188;15385.76921346203;23583.52832943366;23589.882050590324;23664.645030324904;23878.88060559686;23950.161744338864;16892.746608800633;18547.907260463613;18767.906160469658;19325.8067419324;19623.215071396986;16869.578260543585;16981.235844386785;17091.316347345968;17278.395256165975;17511.38710145139;19608.60782784308;19896.70154947706;19922;19943;19958.600827983068;14208.431662733376;14922.701545969237;15010.699786004438;15024.399024038916;15041.097534147986;19609.313674021912;19778.109985050418;19787;19800.801991980472;19803.10886010162 03:39:35 INFO - PID 3825 | |3;mootools.html;1424.1526291856344;1462.5246794791694;1468.625500497373;1478.4825311141096;1485.9777103343451;16946.576335591602;17350.392736254234;17427.564310892234;17505.474835754932;17509.29962801488;17124.14379281034;17368;17398.304067837304;17436.65126697465;17439.73840392395;2809.9438011239763;2848.686644469107;2848.9287767805868;2854.100958198171;2858.614087098236;2656.070375368625;2759.530879750447;2790.8604569771533;2793.6647602287753;2794.888204471829;2765.363966287755;2864.8997285095024;2871.7702583793352;2873.856307184643;2883.09182607478;2881.135659302222;2882.4811533923885;2886.9133925982255;2918.2266699324696;2922.6346706661666;2807.1297897651793;2819.5065863474015;2831.108200916705;2831.150654803551;2831.263871393432;15045.247737613185;15295;15313.31090100937;15320.387184512607;15325.46360877364;8678.913210867937;8892;8900.243479304267;8950.910490895072;8964.50695211763;5946.126970004435;5962.612430192024;6004.519638428916;6055.2430946131735;6139.907901381483;1950.0834607734341;1971.6746736788414;1978.574606459618;2006.6588679924448;2036.2058797069155;30277.69722302771;30455.695443045508;30515.38969220603;30545.23636909095;30635.387292254254;7260.745873894494;7325.706971721178;7416.184219735825;7473;7579.54522728638;19618.803811961698;19622;19622.509437263896;19623.21507139727;19623.803761962197;8285.4200205985;8290.792730181794;8298.336133109458;8301;8301.916980830236;7270.854582908312;7511.661975211128;7530.811729706801;7823.530588164728;7945.880811787828;5552.250446189793;5767.942320576741;5780.566457515703;5891;5892.970535147382;1592.1243316176058;1625.2929975460713;1626.8698504119643;1681.4619321817145;1747.467022558132;958.9568469418892;961.4327546747453;964.1066375415833;986.4180133721139;988.4020167798523;8456.238938495564;8479.95760021196;8503.787405314917;8602.483850968836;8612.741617751477;1039.4387031003325;1048.051513380392;1050.9684709458575;1056.1550759392455;1056.915446764257;5126.384833819965;5153.458886816905;5196.8960620787375;5259.789608415697;5311.681299121988;24629;25379.61930571043;25494.23517294447;25673.10144144946;25705;23167.53664926726;24931.626025609632;24975.375615609755;25520.617190742152;25528.872355638476;12139;12427.875721242672;12463.252204867737;12502.437195350582;12519.499220031279;9832.213422926292;10319.94840025795;10369.792604147724;10409.843852342372;10448.477576121011;21072.578548429254;21329.040193191035;21656.242031528822;21713.89143054338;21984.340469785933;21834.454138646663;22032.559348813254;22045.448863777892;22107.889460552593;22617.773822262225;13513.054086213871;13520.256385898476;13657.385417656427;13697.657558561115;13726.245056521988;15561.84438155604;15611;15644.608884777972;15732.842671573138;15737.44918927832;12922.353882305659;13002.284874332003;13086.280254586089;13103;13131.409086590935;11769.882301176878;11779.293242405483;11825.645230643095;11853.407329633312;12002.699932501757;11125.88741125881;11142.665720028412;11192.104631629612;11206;11209.607663732057;8488.320934325116;8510.425571269336;8617;8647;8699.347548933982;8622.568871556272;8636.740897773077;8684.782880427787;8767.780805479913;8772.210501054935 03:39:35 INFO - PID 3825 | |4;prototype.html;542.9791991056812;577.8708294584824;581.8632621333986;585.4409039367405;592.2005292854647;6243.406876346746;6264.123022776815;6278.811635650932;6280.780172693957;6314;6120.785772497963;6138.570300078996;6142.600730952496;6181.536384771138;6207.255129384469;5072.0870243356185;5078.669886457368;5082.517160869711;5082.517160869711;5084.542391184802;4818.9036219275595;5076.974615126919;5095.6178286628465;5102.540771330579;5137.332146820908;4847.345608342882;4867.853964381075;4872.02559488102;4885.487023862496;4903.534164254408;4927.2855435961765;4930.876728081808;4938.753062346868;4952.108620448318;4954.777035033396;4443;4453.465584129925;4464.325877795826;4469.664775141878;4482.282834746425;6008.3390827009;6055.545834062419;6087.939120608781;6092.299385570672;6105.419985101408;5783.467381144;5797.304323481167;5806.535477161817;5831.446012628793;5838.649681019152;6491.974975515211;6492.480601551864;6540.149780528548;6545.738170473223;6592.747677747826;4960.578350840183;4964.056829202476;4976.800927962877;4987.925181122286;5017.548420642123;6579.506537009695;6739.865202695919;6740.460763138937;6894.620795856226;6899.896501552531;5105.795768169306;5116.513931176532;5146.562542183956;5165.560927321145;5167.276581278624;5122.743862806845;5135.974320128375;5158.432572417031;5185.637005409661;5216.139337009351;5665.716714164275;5682.40334764852;5735.627184233095;5746.942530574641;5768.451997060357;6509.641969691713;6511.446527045159;6598.73605055802;6602.801915942529;6633;1780.5933312682835;1801.8108098649716;1803.7655104836288;1806.9367572134913;1816.7910690270787;1204.8599881251862;1259.1689484939895;1281.1736430002595;1287.5557932513454;1299.551000634305;6049.5462840287155;6081.756729730761;6119.449249567471;6128.448439640454;6191.9690401548605;6626.602403855784;6647.567908085959;6660.100886380374;6669.766558170538;6670;5893.616914900518;5920.378360272195;5938.940610593839;6077.17958075663;6136.520340151715;3442.1430212923215;3462.082548124749;3486.8082255476193;3496.4056110461283;3498.2828520153816;6694.9665251674405;6735.4274886635185;6790.456763458911;6795.150606174228;6901.413379862667;6664.333566643297;6673.796577642759;6719.932800672029;6741.359570840762;6752.501574417399;6673.632950187786;6694.732210711614;6751.594904305757;6756.256811750605;6803.387695107563;6491.4806815455595;6521.576097553644;6578.407943285128;6590.439812615981;6600.669966501751;6465.353464653497;6537.607743535403;6540.672966351568;6592.571482853599;6607.57050791697;6797.966010169917;6824.146981627297;6826.897596535957;6887.6556172192195;6915.273896241023;5049.444561098203;5067.366579177603;5105.923411148761;5109.846704598868;5116.437191908962;6424.261209960914;6474.417302442803;6516.380943810331;6680.5991640501725;6697.698603562754;6389.9041514376395;6403.327650596807;6417.101605775102;6418.807435776934;6491.48068154537;6309.968450157719;6325.810225693236;6355.5551111421755;6365.586236894587;6381.521385895983;6248.343923888108;6306.810795676137;6335.054199797117;6370.522210834113;6398.488120950406;6478.352164783484;6514.967425163033;6517.4460170886005;6570.277269500256;6587.538872278895;6280.717367718372;6295.213098362705;6306.779262725782;6332.240131184288;6342.904856427065 03:39:35 INFO - PID 3825 | |5;yui.html;879.5909901895625;910.9635614575417;911.9817603647928;982.9164521015714;1020.8668378100307;17755.37856175034;18251.178696958636;18410.079496025177;18421.078946052676;18476.445706628823;17223.397181098662;17266.482005539823;17387;18592.628147437044;20060.598788024232;1053.4258828938227;1055.5566662001977;1068.086785798139;1068.3963560588243;1068.7167900506372;1040.750219947211;1078.7572796120849;1080.713610893114;1080.864891888514;1081.5187241677456;1139.658102569226;1145.5532342386475;1147.3574798113084;1148.070063248767;1161.9883801161964;1081.9783604327947;1102.4763237462182;1109.6948339206742;1121.4673030310619;1121.9943900280487;825.5376988886183;828.9917100828975;829.0134739659785;829.1625458287174;829.5188790501555;18709.53226169343;18790.53023674419;18799.342023029127;18830.05849707509;18862.528436789053;19027.048647567568;19234.03829808518;19345.806541934682;19382.12780424884;19526.31657891981;18714.438566843015;18909;19003.90498047515;19038.238470461303;19308.903455482774;3983.203359328146;4012.8394864205397;4015.738976966517;4015.819288132041;4017.2568074906235;166561;167717;167766;167857;170194;17630.559236019202;17680.204390802446;17737.73393399074;17750.20124094419;18153.63692726138;34706.479402808975;34709.13227169341;34916.82541587276;34952.300953980775;35032.29935401278;9015.684451044182;9077.727668169966;9125.954370228106;9137.223336016514;9148.817023659489;4487.125010622963;4495.483019452805;4496.100779844044;4557.794899229542;4592;6059.606125601822;6159.6612186330185;6162.106494558264;6194.5973511721595;6226.315105338409;1150.6663067710438;1155.2548606148987;1173.4602083041725;1183.177691504396;1189.3339729751367;658.9538732288789;662.5792621685265;675.4123912196322;680.880845851974;687.5702685821361;12317.876821231674;12446.25322480654;12475.189112707645;13270.336483175995;13584.660383490294;669.7655820462799;675.878341898463;683.5044592670274;684.8801459744525;686.6806934775353;6202;6206.906896396557;6252.843678907972;6254.843628909313;6264.812055638338;148062;149605;156240;156588;158295;101968;125442;126171.36914315553;129733;132333;109444.63601245524;109815.45092274647;110278.44860775645;112284.43857780822;112439;12821.679458013625;12828.166169198972;12836.807447888103;12847.293398863152;12870.485180593047;50888.236676449145;51502.22746658728;51540.74229628828;52201.7389913048;52617.210741838135;65353;65462.67268663626;65571;66452;67421.32578674347;19120;19398.127084280957;19400.320988765325;19448;19628.60742785108;20071.899640502288;20217;20229.393118206477;20354.796452035884;20368.79631203669;19429.51426214356;19805.108770105093;19837.107330170467;19863.404097877086;19986.500337491678;17018.914905425394;17151.22819473102;17356.91321543384;17379.565510861823;17595.736063958793;19276.518087047934;19602.705959410905;19629.411117666492;19649.80350196537;19849;14577.271136443347;14644.267786610413;14644.487442939446;14681.41274349014;14891.776623350876;14123.788143178066;14411;14430.783538247144;14519;14522.273886305853 03:39:35 INFO - PID 3825 | __end_tp_report 03:39:35 INFO - PID 3825 | __start_cc_report 03:39:35 INFO - PID 3825 | _x_x_mozilla_cycle_collect,352 03:39:35 INFO - PID 3825 | __end_cc_report 03:39:35 INFO - PID 3825 | __startTimestamp1505471975541__endTimestamp 03:39:35 INFO - PID 3825 | 03:39:35 INFO - PID 3825 | ------- Summary: start ------- 03:39:35 INFO - PID 3825 | Number of tests: 6 03:39:35 INFO - PID 3825 | 03:39:35 INFO - PID 3825 | [#0] dojo.html Cycles:165 Average:6174.91 Median:6409.33 stddev:861.97 (13.4%) stddev-sans-first:843.97 03:39:35 INFO - PID 3825 | Values: 3785.0 3822.4 3826.0 3892.6 3896.8 6111.8 6219.1 6245.1 6249.5 6270.2 6211.8 6241.8 6256.9 6354.0 6362.7 5573.8 5587.1 5626.3 5673.7 5681.0 258.0 5549.1 5588.0 5638.2 5698.2 5535.3 5544.6 5578.7 5590.3 5631.1 5526.9 5573.1 5604.2 5649.0 5654.5 5551.8 5561.2 5616.5 5630.8 5635.4 6146.5 6201.3 6254.2 6261.1 6286.9 6666.2 6702.9 6713.6 6721.5 6742.5 6812.7 6821.3 6838.6 6847.0 6849.2 6189.0 6260.7 6341.8 6342.0 6386.8 6872.9 6879.6 6882.1 6900.8 6907.7 6614.9 6641.5 6641.5 6642.8 6644.2 6662.5 6728.1 6732.5 6740.0 6741.7 6677.9 6681.7 6681.9 6694.5 6706.0 6679.6 6680.7 6691.0 6712.1 6713.8 4921.3 4924.0 4969.7 4980.3 4985.3 4405.4 4491.6 4497.8 4539.9 4542.6 6177.0 6235.7 6302.6 6304.2 6312.6 6797.0 6809.7 6816.4 6838.7 6843.1 6241.2 6252.7 6256.3 6328.4 6350.4 5381.4 5391.4 5420.9 5526.4 5529.5 6947.6 6949.1 6953.9 6962.5 6965.5 6443.2 6656.5 6688.9 6699.5 6708.7 7031.2 7052.9 7058.9 7070.1 7077.6 6654.8 6678.4 6740.4 6772.1 6776.6 6654.1 6735.0 6739.3 6826.2 6867.1 6429.6 6467.3 6518.0 6521.3 6538.8 6525.3 6534.5 6548.3 6561.0 6562.4 6407.9 6409.3 6410.0 6503.3 6504.6 6399.7 6491.9 6518.3 6631.1 6632.1 6246.8 6334.9 6345.2 6347.5 6348.0 03:39:35 INFO - PID 3825 | 03:39:35 INFO - PID 3825 | [#1] ext.html Cycles:180 Average:42795.18 Median:3795.52 stddev:64484.00 (1699.0%) stddev-sans-first:64588.29 03:39:35 INFO - PID 3825 | Values: 935.7 946.2 978.3 995.6 997.4 43664.0 44496.0 44646.6 44665.1 44771.6 40513.4 40591.6 40644.0 40815.6 40872.8 7527.1 7655.4 7656.2 7659.9 7680.5 7282.2 7339.7 7342.5 7342.9 7344.8 8035.0 8223.5 8223.9 8226.4 8228.9 8033.8 8080.3 8136.9 8146.0 8153.6 7897.1 8027.4 8077.2 8091.4 8095.6 41879.8 41987.2 41987.6 42089.8 42108.4 3790.2 3800.8 3847.6 3852.7 3855.8 33615.2 33805.8 33935.3 34060.8 34092.0 5499.6 5539.6 5567.2 5575.7 5684.5 216970.0 217762.0 218036.0 218285.0 219431.0 53945.5 54253.5 54502.7 54849.0 54876.7 56966.7 57029.4 57207.1 57238.4 57277.4 17258.2 17563.7 17575.1 17585.8 17611.6 14148.8 14281.9 14285.7 14328.1 14328.1 15422.5 15676.1 15704.8 15724.3 15795.8 6178.3 6200.9 6202.3 6246.3 6279.8 1125.2 1127.4 1129.8 1135.2 1143.0 25434.5 26073.2 26332.2 26358.2 26399.5 1232.8 1239.3 1250.0 1260.1 1264.8 13719.9 13734.8 14015.5 14131.6 14269.6 272317.0 289738.0 291065.0 291721.0 291827.0 51258.2 51705.0 51820.7 57844.8 59239.4 1514.9 1555.3 1566.0 1570.6 1578.9 30985.7 31386.5 31587.7 31606.4 31832.5 41814.8 41900.4 41914.8 41991.4 42010.6 232759.0 233509.0 233529.0 234005.0 235123.0 36331.1 36398.0 36620.0 36698.8 36823.4 45083.0 46459.3 46901.0 46921.8 47084.3 33924.3 34246.3 34665.5 34995.0 35246.0 34406.7 34520.8 34668.0 34698.3 35031.5 40558.2 40638.8 40789.8 40825.0 40841.4 34063.8 34147.0 34350.7 34355.7 35063.8 25333.4 25747.7 26240.7 26507.3 26645.2 03:39:35 INFO - PID 3825 | 03:39:35 INFO - PID 3825 | [#2] jquery.html Cycles:180 Average:38429.17 Median:2274.99 stddev:96058.93 (4222.4%) stddev-sans-first:96286.41 03:39:35 INFO - PID 3825 | Values: 598.0 603.3 609.8 615.9 621.5 23457.5 23977.9 24053.4 24072.0 24115.3 20180.4 23959.3 24029.2 24058.9 24104.4 6790.9 6869.9 6914.0 6916.5 6918.2 6586.9 6777.4 6868.7 6877.9 6881.5 6809.8 6813.8 6814.1 6819.3 6822.8 6791.7 6800.5 6806.0 6818.2 6828.0 6334.9 6345.9 6353.3 6356.5 6359.2 29615.0 29876.1 30022.0 30127.2 30602.2 2216.2 2269.6 2271.6 2272.3 2277.6 19481.3 19884.2 20004.2 20087.1 20110.5 2299.0 2324.6 2333.7 2367.8 2371.1 139581.3 143374.0 151917.0 156591.2 157259.2 15326.5 15398.2 15860.3 15949.2 16208.2 25094.2 25173.0 25176.6 25211.0 25255.6 10333.3 10612.3 10641.6 10693.4 10710.7 9408.5 9498.4 9502.7 9537.9 9667.1 9521.6 9523.2 9668.3 9947.7 10013.8 2757.7 2807.1 2867.9 2938.4 2967.8 1053.6 1055.6 1066.6 1068.2 1071.7 20978.6 21008.9 21070.2 21407.5 21515.8 1093.9 1111.7 1119.0 1128.2 1143.0 11484.0 11668.6 11779.4 11784.8 11862.2 558028.0 560779.0 571131.0 584026.0 586245.0 126960.4 128981.0 129847.4 131171.0 131721.0 1187.7 1213.0 1250.7 1252.0 1255.4 18192.4 18464.5 18696.2 18772.2 18968.6 60803.7 62911.7 63257.0 63456.4 64258.0 74101.3 74499.3 74726.6 75834.6 76413.6 15142.6 15250.2 15284.0 15298.8 15385.8 23583.5 23589.9 23664.6 23878.9 23950.2 16892.7 18547.9 18767.9 19325.8 19623.2 16869.6 16981.2 17091.3 17278.4 17511.4 19608.6 19896.7 19922.0 19943.0 19958.6 14208.4 14922.7 15010.7 15024.4 15041.1 19609.3 19778.1 19787.0 19800.8 19803.1 03:39:35 INFO - PID 3825 | 03:39:35 INFO - PID 3825 | [#3] mootools.html Cycles:180 Average:10508.94 Median:25524.74 stddev:7742.04 (30.3%) stddev-sans-first:7733.67 03:39:35 INFO - PID 3825 | Values: 1424.2 1462.5 1468.6 1478.5 1486.0 16946.6 17350.4 17427.6 17505.5 17509.3 17124.1 17368.0 17398.3 17436.7 17439.7 2809.9 2848.7 2848.9 2854.1 2858.6 2656.1 2759.5 2790.9 2793.7 2794.9 2765.4 2864.9 2871.8 2873.9 2883.1 2881.1 2882.5 2886.9 2918.2 2922.6 2807.1 2819.5 2831.1 2831.2 2831.3 15045.2 15295.0 15313.3 15320.4 15325.5 8678.9 8892.0 8900.2 8950.9 8964.5 5946.1 5962.6 6004.5 6055.2 6139.9 1950.1 1971.7 1978.6 2006.7 2036.2 30277.7 30455.7 30515.4 30545.2 30635.4 7260.7 7325.7 7416.2 7473.0 7579.5 19618.8 19622.0 19622.5 19623.2 19623.8 8285.4 8290.8 8298.3 8301.0 8301.9 7270.9 7511.7 7530.8 7823.5 7945.9 5552.3 5767.9 5780.6 5891.0 5893.0 1592.1 1625.3 1626.9 1681.5 1747.5 959.0 961.4 964.1 986.4 988.4 8456.2 8480.0 8503.8 8602.5 8612.7 1039.4 1048.1 1051.0 1056.2 1056.9 5126.4 5153.5 5196.9 5259.8 5311.7 24629.0 25379.6 25494.2 25673.1 25705.0 23167.5 24931.6 24975.4 25520.6 25528.9 12139.0 12427.9 12463.3 12502.4 12519.5 9832.2 10319.9 10369.8 10409.8 10448.5 21072.6 21329.0 21656.2 21713.9 21984.3 21834.5 22032.6 22045.4 22107.9 22617.8 13513.1 13520.3 13657.4 13697.7 13726.2 15561.8 15611.0 15644.6 15732.8 15737.4 12922.4 13002.3 13086.3 13103.0 13131.4 11769.9 11779.3 11825.6 11853.4 12002.7 11125.9 11142.7 11192.1 11206.0 11209.6 8488.3 8510.4 8617.0 8647.0 8699.3 8622.6 8636.7 8684.8 8767.8 8772.2 03:39:35 INFO - PID 3825 | 03:39:35 INFO - PID 3825 | [#4] prototype.html Cycles:180 Average:5535.21 Median:6140.59 stddev:1530.87 (24.9%) stddev-sans-first:1488.60 03:39:35 INFO - PID 3825 | Values: 543.0 577.9 581.9 585.4 592.2 6243.4 6264.1 6278.8 6280.8 6314.0 6120.8 6138.6 6142.6 6181.5 6207.3 5072.1 5078.7 5082.5 5082.5 5084.5 4818.9 5077.0 5095.6 5102.5 5137.3 4847.3 4867.9 4872.0 4885.5 4903.5 4927.3 4930.9 4938.8 4952.1 4954.8 4443.0 4453.5 4464.3 4469.7 4482.3 6008.3 6055.5 6087.9 6092.3 6105.4 5783.5 5797.3 5806.5 5831.4 5838.6 6492.0 6492.5 6540.1 6545.7 6592.7 4960.6 4964.1 4976.8 4987.9 5017.5 6579.5 6739.9 6740.5 6894.6 6899.9 5105.8 5116.5 5146.6 5165.6 5167.3 5122.7 5136.0 5158.4 5185.6 5216.1 5665.7 5682.4 5735.6 5746.9 5768.5 6509.6 6511.4 6598.7 6602.8 6633.0 1780.6 1801.8 1803.8 1806.9 1816.8 1204.9 1259.2 1281.2 1287.6 1299.6 6049.5 6081.8 6119.4 6128.4 6192.0 6626.6 6647.6 6660.1 6669.8 6670.0 5893.6 5920.4 5938.9 6077.2 6136.5 3442.1 3462.1 3486.8 3496.4 3498.3 6695.0 6735.4 6790.5 6795.2 6901.4 6664.3 6673.8 6719.9 6741.4 6752.5 6673.6 6694.7 6751.6 6756.3 6803.4 6491.5 6521.6 6578.4 6590.4 6600.7 6465.4 6537.6 6540.7 6592.6 6607.6 6798.0 6824.1 6826.9 6887.7 6915.3 5049.4 5067.4 5105.9 5109.8 5116.4 6424.3 6474.4 6516.4 6680.6 6697.7 6389.9 6403.3 6417.1 6418.8 6491.5 6310.0 6325.8 6355.6 6365.6 6381.5 6248.3 6306.8 6335.1 6370.5 6398.5 6478.4 6515.0 6517.4 6570.3 6587.5 6280.7 6295.2 6306.8 6332.2 6342.9 03:39:35 INFO - PID 3825 | 03:39:35 INFO - PID 3825 | [#5] yui.html Cycles:180 Average:28041.11 Median:18885.76 stddev:42378.49 (224.4%) stddev-sans-first:42448.30 03:39:35 INFO - PID 3825 | Values: 879.6 911.0 912.0 982.9 1020.9 17755.4 18251.2 18410.1 18421.1 18476.4 17223.4 17266.5 17387.0 18592.6 20060.6 1053.4 1055.6 1068.1 1068.4 1068.7 1040.8 1078.8 1080.7 1080.9 1081.5 1139.7 1145.6 1147.4 1148.1 1162.0 1082.0 1102.5 1109.7 1121.5 1122.0 825.5 829.0 829.0 829.2 829.5 18709.5 18790.5 18799.3 18830.1 18862.5 19027.0 19234.0 19345.8 19382.1 19526.3 18714.4 18909.0 19003.9 19038.2 19308.9 3983.2 4012.8 4015.7 4015.8 4017.3 166561.0 167717.0 167766.0 167857.0 170194.0 17630.6 17680.2 17737.7 17750.2 18153.6 34706.5 34709.1 34916.8 34952.3 35032.3 9015.7 9077.7 9126.0 9137.2 9148.8 4487.1 4495.5 4496.1 4557.8 4592.0 6059.6 6159.7 6162.1 6194.6 6226.3 1150.7 1155.3 1173.5 1183.2 1189.3 659.0 662.6 675.4 680.9 687.6 12317.9 12446.3 12475.2 13270.3 13584.7 669.8 675.9 683.5 684.9 686.7 6202.0 6206.9 6252.8 6254.8 6264.8 148062.0 149605.0 156240.0 156588.0 158295.0 101968.0 125442.0 126171.4 129733.0 132333.0 109444.6 109815.5 110278.4 112284.4 112439.0 12821.7 12828.2 12836.8 12847.3 12870.5 50888.2 51502.2 51540.7 52201.7 52617.2 65353.0 65462.7 65571.0 66452.0 67421.3 19120.0 19398.1 19400.3 19448.0 19628.6 20071.9 20217.0 20229.4 20354.8 20368.8 19429.5 19805.1 19837.1 19863.4 19986.5 17018.9 17151.2 17356.9 17379.6 17595.7 19276.5 19602.7 19629.4 19649.8 19849.0 14577.3 14644.3 14644.5 14681.4 14891.8 14123.8 14411.0 14430.8 14519.0 14522.3 03:39:35 INFO - PID 3825 | -------- Summary: end -------- 03:39:35 INFO - PID 3825 | 03:39:36 INFO - TEST-INFO | 3825: exit 0 03:39:36 INFO - TEST-OK | dromaeo_css | took 1111922ms 03:39:36 INFO - TEST-START | kraken 03:39:36 INFO - Initialising browser for kraken test... 03:39:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40742/getInfo.html -profile /tmp/tmpZuAKnX/profile 03:39:36 INFO - TEST-INFO | started process 4198 (/builds/slave/test/build/application/firefox/firefox http://localhost:40742/getInfo.html) 03:39:41 INFO - TEST-INFO | 4198: exit 0 03:39:41 INFO - Browser initialized. 03:39:41 INFO - Running cycle 1/1 for kraken test... 03:39:41 INFO - Using env: {'DISPLAY': ':0', 03:39:41 INFO - 'HOME': '/home/cltbld', 03:39:41 INFO - 'JSGC_DISABLE_POISONING': '1', 03:39:41 INFO - 'LANG': 'en_US.UTF-8', 03:39:41 INFO - 'LANGUAGE': 'en_US:en', 03:39:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:39:41 INFO - 'LOGNAME': 'cltbld', 03:39:41 INFO - 'MAIL': '/var/mail/cltbld', 03:39:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:39:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:39:41 INFO - 'MOZ_CRASHREPORTER': '1', 03:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:39:41 INFO - 'MOZ_NO_REMOTE': '1', 03:39:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:41 INFO - 'NO_EM_RESTART': '1', 03:39:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:41 INFO - 'PWD': '/builds/slave/test', 03:39:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:39:41 INFO - 'RUST_BACKTRACE': 'full', 03:39:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:39:41 INFO - 'SHELL': '/bin/bash', 03:39:41 INFO - 'SHLVL': '1', 03:39:41 INFO - 'TERM': 'linux', 03:39:41 INFO - 'TMOUT': '86400', 03:39:41 INFO - 'USER': 'cltbld', 03:39:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1505469860.17312-4953465', 03:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:41 INFO - '_': '/tools/buildbot/bin/python'} 03:39:41 INFO - TEST-INFO | started process 4435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZuAKnX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:42 INFO - PID 4435 | 03:39:42 INFO - PID 4435 | (/builds/slave/test/build/application/firefox/firefox:4484): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:39:42 INFO - PID 4435 | 03:39:53 INFO - PID 4435 | RSS: Main: 165138432 03:39:53 INFO - PID 4435 | 03:39:55 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40742/tests/kraken/driver.html?testName=audio-beat-detection) 03:39:56 INFO - PID 4435 | RSS: Main: 171413504 03:39:56 INFO - PID 4435 | 03:39:59 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40742/tests/kraken/driver.html?testName=audio-dft) 03:39:59 INFO - PID 4435 | RSS: Main: 171507712 03:39:59 INFO - PID 4435 | 03:40:02 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40742/tests/kraken/driver.html?testName=audio-fft) 03:40:03 INFO - PID 4435 | RSS: Main: 165433344 03:40:03 INFO - PID 4435 | 03:40:05 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40742/tests/kraken/driver.html?testName=audio-oscillator) 03:40:06 INFO - PID 4435 | RSS: Main: 166936576 03:40:06 INFO - PID 4435 | 03:40:08 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40742/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:40:08 INFO - PID 4435 | RSS: Main: 166699008 03:40:08 INFO - PID 4435 | 03:40:11 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40742/tests/kraken/driver.html?testName=imaging-darkroom) 03:40:12 INFO - PID 4435 | RSS: Main: 170119168 03:40:12 INFO - PID 4435 | 03:40:16 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40742/tests/kraken/driver.html?testName=imaging-desaturate) 03:40:16 INFO - PID 4435 | RSS: Main: 169967616 03:40:16 INFO - PID 4435 | 03:40:19 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40742/tests/kraken/driver.html?testName=json-parse-financial) 03:40:20 INFO - PID 4435 | RSS: Main: 169758720 03:40:20 INFO - PID 4435 | 03:40:21 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40742/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:40:22 INFO - PID 4435 | RSS: Main: 169787392 03:40:22 INFO - PID 4435 | 03:40:23 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40742/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:40:24 INFO - PID 4435 | RSS: Main: 170250240 03:40:24 INFO - PID 4435 | 03:40:26 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40742/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:40:27 INFO - PID 4435 | RSS: Main: 166506496 03:40:27 INFO - PID 4435 | 03:40:29 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:40:30 INFO - PID 4435 | RSS: Main: 166838272 03:40:30 INFO - PID 4435 | 03:40:33 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:40:33 INFO - PID 4435 | RSS: Main: 167907328 03:40:33 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:40742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40742/tests/kraken/driver.html?testName=ai-astar) 03:40:35 INFO - PID 4435 | RSS: Main: 169082880 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | __start_tp_report 03:40:35 INFO - PID 4435 | _x_x_mozilla_page_load 03:40:35 INFO - PID 4435 | _x_x_mozilla_page_load_details 03:40:35 INFO - PID 4435 | |i|pagename|runs| 03:40:35 INFO - PID 4435 | |0;ai-astar;107;107;106;107;105;100;106;105;105;105 03:40:35 INFO - PID 4435 | |1;audio-beat-detection;113;114;117;112;111;114;113;139;114;113 03:40:35 INFO - PID 4435 | |2;audio-dft;161;160;162;160;161;162;162;163;162;168 03:40:35 INFO - PID 4435 | |3;audio-fft;73;73;78;73;73;73;74;74;73;73 03:40:35 INFO - PID 4435 | |4;audio-oscillator;78;79;79;77;78;77;78;78;84;86 03:40:35 INFO - PID 4435 | |5;imaging-gaussian-blur;116;117;114;110;113;113;114;114;114;117 03:40:35 INFO - PID 4435 | |6;imaging-darkroom;150;151;151;148;149;149;149;149;149;150 03:40:35 INFO - PID 4435 | |7;imaging-desaturate;93;93;94;93;93;93;95;93;94;94 03:40:35 INFO - PID 4435 | |8;json-parse-financial;45;46;46;50;45;46;45;45;44;48 03:40:35 INFO - PID 4435 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;38;38 03:40:35 INFO - PID 4435 | |10;stanford-crypto-aes;75;74;75;74;73;74;74;77;71;73 03:40:35 INFO - PID 4435 | |11;stanford-crypto-ccm;109;107;110;102;107;119;110;112;106;116 03:40:35 INFO - PID 4435 | |12;stanford-crypto-pbkdf2;156;159;153;154;151;152;153;156;158;155 03:40:35 INFO - PID 4435 | |13;stanford-crypto-sha256-iterative;62;60;65;64;64;67;62;60;63;63 03:40:35 INFO - PID 4435 | __end_tp_report 03:40:35 INFO - PID 4435 | __start_cc_report 03:40:35 INFO - PID 4435 | _x_x_mozilla_cycle_collect,915 03:40:35 INFO - PID 4435 | __end_cc_report 03:40:35 INFO - PID 4435 | __startTimestamp1505472035745__endTimestamp 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | ------- Summary: start ------- 03:40:35 INFO - PID 4435 | Number of tests: 14 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#0] ai-astar Cycles:10 Average:105.30 Median:106.00 stddev:2.06 (1.9%) stddev-sans-first:2.09 03:40:35 INFO - PID 4435 | Values: 107.0 107.0 106.0 107.0 105.0 100.0 106.0 105.0 105.0 105.0 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#1] audio-beat-detection Cycles:10 Average:116.00 Median:114.00 stddev:8.23 (7.2%) stddev-sans-first:8.66 03:40:35 INFO - PID 4435 | Values: 113.0 114.0 117.0 112.0 111.0 114.0 113.0 139.0 114.0 113.0 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:2.28 (1.4%) stddev-sans-first:2.39 03:40:35 INFO - PID 4435 | Values: 161.0 160.0 162.0 160.0 161.0 162.0 162.0 163.0 162.0 168.0 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#3] audio-fft Cycles:10 Average:73.70 Median:73.00 stddev:1.57 (2.1%) stddev-sans-first:1.64 03:40:35 INFO - PID 4435 | Values: 73.0 73.0 78.0 73.0 73.0 73.0 74.0 74.0 73.0 73.0 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:78.50 stddev:3.06 (3.9%) stddev-sans-first:3.21 03:40:35 INFO - PID 4435 | Values: 78.0 79.0 79.0 77.0 78.0 77.0 78.0 78.0 84.0 86.0 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:2.10 (1.8%) stddev-sans-first:2.12 03:40:35 INFO - PID 4435 | Values: 116.0 117.0 114.0 110.0 113.0 113.0 114.0 114.0 114.0 117.0 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 03:40:35 INFO - PID 4435 | Values: 150.0 151.0 151.0 148.0 149.0 149.0 149.0 149.0 149.0 150.0 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:93.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 03:40:35 INFO - PID 4435 | Values: 93.0 93.0 94.0 93.0 93.0 93.0 95.0 93.0 94.0 94.0 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#8] json-parse-financial Cycles:10 Average:46.00 Median:46.00 stddev:1.76 (3.8%) stddev-sans-first:1.83 03:40:35 INFO - PID 4435 | Values: 45.0 46.0 46.0 50.0 45.0 46.0 45.0 45.0 44.0 48.0 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:40:35 INFO - PID 4435 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:1.56 (2.1%) stddev-sans-first:1.62 03:40:35 INFO - PID 4435 | Values: 75.0 74.0 75.0 74.0 73.0 74.0 74.0 77.0 71.0 73.0 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#11] stanford-crypto-ccm Cycles:10 Average:109.80 Median:110.00 stddev:4.94 (4.5%) stddev-sans-first:5.23 03:40:35 INFO - PID 4435 | Values: 109.0 107.0 110.0 102.0 107.0 119.0 110.0 112.0 106.0 116.0 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:155.50 stddev:2.58 (1.7%) stddev-sans-first:2.70 03:40:35 INFO - PID 4435 | Values: 156.0 159.0 153.0 154.0 151.0 152.0 153.0 156.0 158.0 155.0 03:40:35 INFO - PID 4435 | 03:40:35 INFO - PID 4435 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.50 stddev:2.16 (3.4%) stddev-sans-first:2.26 03:40:35 INFO - PID 4435 | Values: 62.0 60.0 65.0 64.0 64.0 67.0 62.0 60.0 63.0 63.0 03:40:35 INFO - PID 4435 | -------- Summary: end -------- 03:40:35 INFO - PID 4435 | 03:40:36 INFO - PID 4435 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:40:36 INFO - TEST-INFO | 4435: exit 0 03:40:36 INFO - TEST-OK | kraken | took 60190ms 03:40:36 INFO - SUITE-END | took 1172s 03:40:36 INFO - Completed test suite (00:19:32) 03:40:36 INFO - javascript benchmark 03:40:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9016.276600307721, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3785.0, 3822.3502004659213, 3825.9617403825955, 3892.630200130988, 3896.805159742012, 6111.755529778803, 6219.067139929008, 6245.0632405139195, 6249.4687951524065, 6270.184875966123, 6211.844703882416, 6241.750329986795, 6256.906146407796, 6354.01512765521, 6362.650054247015, 5573.804916827912, 5587.078132108218, 5626.268585083933, 5673.744681489343, 5680.971595142039, 257.983800037045, 5549.056660367727, 5587.972060139694, 5638.238837756912, 5698.173764804101, 5535.308086489189, 5544.63959842609, 5578.665280083208, 5590.301212348457, 5631.0708733059, 5526.917096243559, 5573.080441727151, 5604.243427137366, 5649.0, 5654.547636189095, 5551.77792888284, 5561.221428999943, 5616.494515493584, 5630.761232528837, 5635.408282130358, 6146.539009574255, 6201.286852011986, 6254.155688981975, 6261.092141639482, 6286.874262514724, 6666.200055993263, 6702.899456508157, 6713.597184168965, 6721.462283017347, 6742.460603151736, 6812.727490900358, 6821.317868213188, 6838.589684618939, 6847.041414201966, 6849.212340580847, 6189.0, 6260.686965651745, 6341.778037768702, 6342.048692696087, 6386.808395748135, 6872.862542749217, 6879.58722476653, 6882.105326307648, 6900.827479313058, 6907.689153988083, 6614.86770264592, 6641.468682505388, 6641.501887358468, 6642.767503137367, 6644.202695676453, 6662.533622646368, 6728.058071869942, 6732.4950628703045, 6740.0226967090475, 6741.696623651947, 6677.866442671119, 6681.665916704145, 6681.9331806682285, 6694.497912656473, 6706.027625994301, 6679.56582822115, 6680.665966701646, 6691.0, 6712.060311556386, 6713.832154196184, 4921.311016457699, 4924.039812236651, 4969.676970996874, 4980.252962055648, 4985.326980857538, 4405.449318835145, 4491.640668746492, 4497.775111244425, 4539.886502837456, 4542.636589072932, 6176.969115154396, 6235.719392627343, 6302.621842689362, 6304.243490781136, 6312.5581209314905, 6797.0, 6809.659517024228, 6816.420604248694, 6838.658067096625, 6843.144606924135, 6241.21984751906, 6252.656103914328, 6256.311805701369, 6328.398802113792, 6350.396712312323, 5381.354237491526, 5391.353037635509, 5420.945790542044, 5526.364468086222, 5529.529989950819, 6947.617881016491, 6949.061876646689, 6953.860922781516, 6962.477814163958, 6965.5124141309625, 6443.162388889415, 6656.5340426169705, 6688.933110668929, 6699.5310328276555, 6708.698108585223, 7031.191412987368, 7052.929470705228, 7058.858822823412, 7070.116235470567, 7077.610731409822, 6654.800355989328, 6678.3989440950545, 6740.359665831738, 6772.0857684212, 6776.627285499345, 6654.101696270942, 6735.0, 6739.258681545124, 6826.249112597709, 6867.141607299088, 6429.646369449538, 6467.288598254282, 6517.967410162919, 6521.347865213441, 6538.803835884931, 6525.314841941527, 6534.509911756542, 6548.279689234085, 6560.967195163994, 6562.409383155539, 6407.935920640734, 6409.327020662763, 6409.9679501602195, 6503.317151699192, 6504.642244676588, 6399.7440102395385, 6491.902621460777, 6518.315576864361, 6631.104800851823, 6632.137822083098, 6246.843828904313, 6334.9366506334345, 6345.238571371465, 6347.5239357047485, 6348.0], "value": 6119.0472038479165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [935.6865450074225, 946.2335508238323, 978.3445091788501, 995.5868314649423, 997.3616885193472, 43664.0, 44496.0, 44646.55353446465, 44665.106697866024, 44771.55228447715, 40513.392299115534, 40591.59408405922, 40644.0, 40815.59184408155, 40872.79563602178, 7527.13437954634, 7655.425843061765, 7656.196099409565, 7659.885101723478, 7680.500767450098, 7282.19895811463, 7339.743108991186, 7342.4860259781835, 7342.853142937138, 7344.816379590527, 8034.9598252008955, 8223.506589604613, 8223.876641850376, 8226.42415030948, 8228.876566851503, 8033.758987230392, 8080.313173380269, 8136.877946830773, 8146.022477302702, 8153.592320384017, 7897.091834439056, 8027.397945154137, 8077.192280771876, 8091.433599648027, 8095.635696393676, 41879.790601047105, 41987.160256794996, 41987.58012419867, 42089.78955105205, 42108.3683744741, 3790.1851102012924, 3800.847966081353, 3847.61523847613, 3852.672522835562, 3855.8072096395067, 33615.15962100943, 33805.830970845236, 33935.321293574234, 34060.82969585136, 34092.0, 5499.615026948115, 5539.639923404966, 5567.164925261202, 5575.749091290902, 5684.516816070639, 216970.0, 217762.0, 218036.0, 218285.0, 219431.0, 53945.460545394046, 54253.45746542484, 54502.72748636232, 54849.0, 54876.72561637166, 56966.71516642473, 57029.42970570324, 57207.14189287164, 57238.42761572331, 57277.427225728046, 17258.223379947933, 17563.73654395185, 17575.121243937752, 17585.824141758418, 17611.647767044586, 14148.787768183485, 14281.85718142826, 14285.714285714228, 14328.068675536057, 14328.14031158134, 15422.537323880302, 15676.137812420198, 15704.764428533581, 15724.29240684172, 15795.763063554055, 6178.320384757673, 6200.875982480416, 6202.34875338092, 6246.344133865879, 6279.7802076928, 1125.2235957189514, 1127.3912087472672, 1129.8192289233684, 1135.2450620337547, 1142.9657110286705, 25434.491310174064, 26073.217803465926, 26332.21003369902, 26358.20925372242, 26399.472010559683, 1232.7596118756755, 1239.3431481314917, 1249.9687507812378, 1260.1431026901794, 1264.8482182138202, 13719.862801372059, 13734.793978090336, 14015.50945716895, 14131.57605271823, 14269.64325891861, 272317.0, 289738.0, 291065.0, 291721.0, 291827.0, 51258.23112653313, 51705.0, 51820.740896295276, 57844.843103137704, 59239.40760592425, 1514.9166795826336, 1555.3312075807512, 1566.0368873142936, 1570.6073481629592, 1578.8579027887315, 30985.69014309828, 31386.529202062444, 31587.684123159393, 31606.367872642877, 31832.52251216187, 41814.79092604518, 41900.37149442822, 41914.79042604767, 41991.370129447474, 42010.57989420189, 232759.0, 233509.0, 233529.0, 234005.0, 235123.0, 36331.09172270714, 36398.0, 36620.0, 36698.8165059173, 36823.44764828583, 45083.0, 46459.303110452696, 46901.0, 46921.76539117283, 47084.29373559331, 33924.32151357008, 34246.315073697886, 34665.480017800255, 34995.0, 35246.0, 34406.65593344034, 34520.82739586286, 34668.0, 34698.306033878674, 35031.47452788159, 40558.1888362237, 40638.796806016966, 40789.796051019555, 40825.0, 40841.38737918874, 34063.82968085243, 34147.0, 34350.656493435745, 34355.65644343525, 35063.82468087643, 25333.366665832764, 25747.742522574536, 26240.73759262459, 26507.337316566467, 26645.200643980712], "value": 18816.97401847672, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.9790707325244, 603.3393434189561, 609.7987664070857, 615.9045347971063, 621.5214285000549, 23457.530849383023, 23977.880110599446, 24053.398665033383, 24072.0, 24115.276541703755, 20180.39458816238, 23959.28122156334, 24029.158979435724, 24058.879705601492, 24104.397390065256, 6790.898136527943, 6869.862602747967, 6914.0, 6916.4812639052025, 6918.238993710688, 6586.93413065868, 6777.423918966893, 6868.690908909086, 6877.931220687779, 6881.4838887083415, 6809.795706128824, 6813.829654258634, 6814.1482314710665, 6819.318068193191, 6822.829429264283, 6791.728330866759, 6800.489963252776, 6805.965970170167, 6818.181818181801, 6827.965860170717, 6334.936650633481, 6345.9365406345805, 6353.30113687494, 6356.45970092538, 6359.20509936258, 29615.0, 29876.103716888527, 30022.0, 30127.246818829484, 30602.234944126576, 2216.1689366487567, 2269.6028195065796, 2271.5797577448225, 2272.3410211038777, 2277.6355783074628, 19481.31815386469, 19884.20463181471, 20004.199832006703, 20087.096080676405, 20110.49723756903, 2299.0458959531775, 2324.59319619066, 2333.6849525314205, 2367.7513861044513, 2371.1108334374608, 139581.3020934889, 143374.0, 151917.0, 156591.21704391518, 157259.2137039319, 15326.463573774865, 15398.230088495531, 15860.286287117107, 15949.20253987296, 16208.189590520427, 25094.24717258485, 25173.0, 25176.622350664755, 25211.0, 25255.62116568253, 10333.328333658288, 10612.25714200014, 10641.574337026586, 10693.411862347646, 10710.73223169427, 9408.482533460725, 9498.430094194371, 9502.667406640734, 9537.904620953701, 9667.081627245401, 9521.571529281198, 9523.19052880513, 9668.323217374857, 9947.701568952943, 10013.849792253122, 2757.655293088364, 2807.087696498646, 2867.8996235132086, 2938.3682508260827, 2967.7922545422043, 1053.594366169015, 1055.6041484443333, 1066.6000249906285, 1068.1881769854965, 1071.7481391872905, 20978.580428391346, 21008.894955525124, 21070.15719371208, 21407.46481337979, 21515.78484215169, 1093.907017903487, 1111.6831702964616, 1118.983215251772, 1128.227164392394, 1142.9885701143048, 11484.0, 11668.591599293984, 11779.411029448493, 11784.764304713857, 11862.228955118062, 558028.0, 560779.0, 571131.0, 584026.0, 586245.0, 126960.36519817526, 128981.0, 129847.35076324746, 131171.0, 131721.0, 1187.7469269920146, 1212.963611091651, 1250.7248405350808, 1252.0234217310513, 1255.416231452379, 18192.363267285582, 18464.538386540444, 18696.15867285948, 18772.24911003599, 18968.620627587094, 60803.695981519806, 62911.685441572496, 63257.0, 63456.365436346896, 64258.0, 74101.25898740944, 74499.2550074514, 74726.62636686781, 75834.62082689772, 76413.61793190999, 15142.621434464227, 15250.161241131844, 15284.0, 15298.847011530188, 15385.76921346203, 23583.52832943366, 23589.882050590324, 23664.645030324904, 23878.88060559686, 23950.161744338864, 16892.746608800633, 18547.907260463613, 18767.906160469658, 19325.8067419324, 19623.215071396986, 16869.578260543585, 16981.235844386785, 17091.316347345968, 17278.395256165975, 17511.38710145139, 19608.60782784308, 19896.70154947706, 19922.0, 19943.0, 19958.600827983068, 14208.431662733376, 14922.701545969237, 15010.699786004438, 15024.399024038916, 15041.097534147986, 19609.313674021912, 19778.109985050418, 19787.0, 19800.801991980472, 19803.10886010162], "value": 12590.421232584036, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.1526291856344, 1462.5246794791694, 1468.625500497373, 1478.4825311141096, 1485.9777103343451, 16946.576335591602, 17350.392736254234, 17427.564310892234, 17505.474835754932, 17509.29962801488, 17124.14379281034, 17368.0, 17398.304067837304, 17436.65126697465, 17439.73840392395, 2809.9438011239763, 2848.686644469107, 2848.9287767805868, 2854.100958198171, 2858.614087098236, 2656.070375368625, 2759.530879750447, 2790.8604569771533, 2793.6647602287753, 2794.888204471829, 2765.363966287755, 2864.8997285095024, 2871.7702583793352, 2873.856307184643, 2883.09182607478, 2881.135659302222, 2882.4811533923885, 2886.9133925982255, 2918.2266699324696, 2922.6346706661666, 2807.1297897651793, 2819.5065863474015, 2831.108200916705, 2831.150654803551, 2831.263871393432, 15045.247737613185, 15295.0, 15313.31090100937, 15320.387184512607, 15325.46360877364, 8678.913210867937, 8892.0, 8900.243479304267, 8950.910490895072, 8964.50695211763, 5946.126970004435, 5962.612430192024, 6004.519638428916, 6055.2430946131735, 6139.907901381483, 1950.0834607734341, 1971.6746736788414, 1978.574606459618, 2006.6588679924448, 2036.2058797069155, 30277.69722302771, 30455.695443045508, 30515.38969220603, 30545.23636909095, 30635.387292254254, 7260.745873894494, 7325.706971721178, 7416.184219735825, 7473.0, 7579.54522728638, 19618.803811961698, 19622.0, 19622.509437263896, 19623.21507139727, 19623.803761962197, 8285.4200205985, 8290.792730181794, 8298.336133109458, 8301.0, 8301.916980830236, 7270.854582908312, 7511.661975211128, 7530.811729706801, 7823.530588164728, 7945.880811787828, 5552.250446189793, 5767.942320576741, 5780.566457515703, 5891.0, 5892.970535147382, 1592.1243316176058, 1625.2929975460713, 1626.8698504119643, 1681.4619321817145, 1747.467022558132, 958.9568469418892, 961.4327546747453, 964.1066375415833, 986.4180133721139, 988.4020167798523, 8456.238938495564, 8479.95760021196, 8503.787405314917, 8602.483850968836, 8612.741617751477, 1039.4387031003325, 1048.051513380392, 1050.9684709458575, 1056.1550759392455, 1056.915446764257, 5126.384833819965, 5153.458886816905, 5196.8960620787375, 5259.789608415697, 5311.681299121988, 24629.0, 25379.61930571043, 25494.23517294447, 25673.10144144946, 25705.0, 23167.53664926726, 24931.626025609632, 24975.375615609755, 25520.617190742152, 25528.872355638476, 12139.0, 12427.875721242672, 12463.252204867737, 12502.437195350582, 12519.499220031279, 9832.213422926292, 10319.94840025795, 10369.792604147724, 10409.843852342372, 10448.477576121011, 21072.578548429254, 21329.040193191035, 21656.242031528822, 21713.89143054338, 21984.340469785933, 21834.454138646663, 22032.559348813254, 22045.448863777892, 22107.889460552593, 22617.773822262225, 13513.054086213871, 13520.256385898476, 13657.385417656427, 13697.657558561115, 13726.245056521988, 15561.84438155604, 15611.0, 15644.608884777972, 15732.842671573138, 15737.44918927832, 12922.353882305659, 13002.284874332003, 13086.280254586089, 13103.0, 13131.409086590935, 11769.882301176878, 11779.293242405483, 11825.645230643095, 11853.407329633312, 12002.699932501757, 11125.88741125881, 11142.665720028412, 11192.104631629612, 11206.0, 11209.607663732057, 8488.320934325116, 8510.425571269336, 8617.0, 8647.0, 8699.347548933982, 8622.568871556272, 8636.740897773077, 8684.782880427787, 8767.780805479913, 8772.210501054935], "value": 7368.699344168076, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.9791991056812, 577.8708294584824, 581.8632621333986, 585.4409039367405, 592.2005292854647, 6243.406876346746, 6264.123022776815, 6278.811635650932, 6280.780172693957, 6314.0, 6120.785772497963, 6138.570300078996, 6142.600730952496, 6181.536384771138, 6207.255129384469, 5072.0870243356185, 5078.669886457368, 5082.517160869711, 5082.517160869711, 5084.542391184802, 4818.9036219275595, 5076.974615126919, 5095.6178286628465, 5102.540771330579, 5137.332146820908, 4847.345608342882, 4867.853964381075, 4872.02559488102, 4885.487023862496, 4903.534164254408, 4927.2855435961765, 4930.876728081808, 4938.753062346868, 4952.108620448318, 4954.777035033396, 4443.0, 4453.465584129925, 4464.325877795826, 4469.664775141878, 4482.282834746425, 6008.3390827009, 6055.545834062419, 6087.939120608781, 6092.299385570672, 6105.419985101408, 5783.467381144, 5797.304323481167, 5806.535477161817, 5831.446012628793, 5838.649681019152, 6491.974975515211, 6492.480601551864, 6540.149780528548, 6545.738170473223, 6592.747677747826, 4960.578350840183, 4964.056829202476, 4976.800927962877, 4987.925181122286, 5017.548420642123, 6579.506537009695, 6739.865202695919, 6740.460763138937, 6894.620795856226, 6899.896501552531, 5105.795768169306, 5116.513931176532, 5146.562542183956, 5165.560927321145, 5167.276581278624, 5122.743862806845, 5135.974320128375, 5158.432572417031, 5185.637005409661, 5216.139337009351, 5665.716714164275, 5682.40334764852, 5735.627184233095, 5746.942530574641, 5768.451997060357, 6509.641969691713, 6511.446527045159, 6598.73605055802, 6602.801915942529, 6633.0, 1780.5933312682835, 1801.8108098649716, 1803.7655104836288, 1806.9367572134913, 1816.7910690270787, 1204.8599881251862, 1259.1689484939895, 1281.1736430002595, 1287.5557932513454, 1299.551000634305, 6049.5462840287155, 6081.756729730761, 6119.449249567471, 6128.448439640454, 6191.9690401548605, 6626.602403855784, 6647.567908085959, 6660.100886380374, 6669.766558170538, 6670.0, 5893.616914900518, 5920.378360272195, 5938.940610593839, 6077.17958075663, 6136.520340151715, 3442.1430212923215, 3462.082548124749, 3486.8082255476193, 3496.4056110461283, 3498.2828520153816, 6694.9665251674405, 6735.4274886635185, 6790.456763458911, 6795.150606174228, 6901.413379862667, 6664.333566643297, 6673.796577642759, 6719.932800672029, 6741.359570840762, 6752.501574417399, 6673.632950187786, 6694.732210711614, 6751.594904305757, 6756.256811750605, 6803.387695107563, 6491.4806815455595, 6521.576097553644, 6578.407943285128, 6590.439812615981, 6600.669966501751, 6465.353464653497, 6537.607743535403, 6540.672966351568, 6592.571482853599, 6607.57050791697, 6797.966010169917, 6824.146981627297, 6826.897596535957, 6887.6556172192195, 6915.273896241023, 5049.444561098203, 5067.366579177603, 5105.923411148761, 5109.846704598868, 5116.437191908962, 6424.261209960914, 6474.417302442803, 6516.380943810331, 6680.5991640501725, 6697.698603562754, 6389.9041514376395, 6403.327650596807, 6417.101605775102, 6418.807435776934, 6491.48068154537, 6309.968450157719, 6325.810225693236, 6355.5551111421755, 6365.586236894587, 6381.521385895983, 6248.343923888108, 6306.810795676137, 6335.054199797117, 6370.522210834113, 6398.488120950406, 6478.352164783484, 6514.967425163033, 6517.4460170886005, 6570.277269500256, 6587.538872278895, 6280.717367718372, 6295.213098362705, 6306.779262725782, 6332.240131184288, 6342.904856427065], "value": 5099.4193576428315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.5909901895625, 910.9635614575417, 911.9817603647928, 982.9164521015714, 1020.8668378100307, 17755.37856175034, 18251.178696958636, 18410.079496025177, 18421.078946052676, 18476.445706628823, 17223.397181098662, 17266.482005539823, 17387.0, 18592.628147437044, 20060.598788024232, 1053.4258828938227, 1055.5566662001977, 1068.086785798139, 1068.3963560588243, 1068.7167900506372, 1040.750219947211, 1078.7572796120849, 1080.713610893114, 1080.864891888514, 1081.5187241677456, 1139.658102569226, 1145.5532342386475, 1147.3574798113084, 1148.070063248767, 1161.9883801161964, 1081.9783604327947, 1102.4763237462182, 1109.6948339206742, 1121.4673030310619, 1121.9943900280487, 825.5376988886183, 828.9917100828975, 829.0134739659785, 829.1625458287174, 829.5188790501555, 18709.53226169343, 18790.53023674419, 18799.342023029127, 18830.05849707509, 18862.528436789053, 19027.048647567568, 19234.03829808518, 19345.806541934682, 19382.12780424884, 19526.31657891981, 18714.438566843015, 18909.0, 19003.90498047515, 19038.238470461303, 19308.903455482774, 3983.203359328146, 4012.8394864205397, 4015.738976966517, 4015.819288132041, 4017.2568074906235, 166561.0, 167717.0, 167766.0, 167857.0, 170194.0, 17630.559236019202, 17680.204390802446, 17737.73393399074, 17750.20124094419, 18153.63692726138, 34706.479402808975, 34709.13227169341, 34916.82541587276, 34952.300953980775, 35032.29935401278, 9015.684451044182, 9077.727668169966, 9125.954370228106, 9137.223336016514, 9148.817023659489, 4487.125010622963, 4495.483019452805, 4496.100779844044, 4557.794899229542, 4592.0, 6059.606125601822, 6159.6612186330185, 6162.106494558264, 6194.5973511721595, 6226.315105338409, 1150.6663067710438, 1155.2548606148987, 1173.4602083041725, 1183.177691504396, 1189.3339729751367, 658.9538732288789, 662.5792621685265, 675.4123912196322, 680.880845851974, 687.5702685821361, 12317.876821231674, 12446.25322480654, 12475.189112707645, 13270.336483175995, 13584.660383490294, 669.7655820462799, 675.878341898463, 683.5044592670274, 684.8801459744525, 686.6806934775353, 6202.0, 6206.906896396557, 6252.843678907972, 6254.843628909313, 6264.812055638338, 148062.0, 149605.0, 156240.0, 156588.0, 158295.0, 101968.0, 125442.0, 126171.36914315553, 129733.0, 132333.0, 109444.63601245524, 109815.45092274647, 110278.44860775645, 112284.43857780822, 112439.0, 12821.679458013625, 12828.166169198972, 12836.807447888103, 12847.293398863152, 12870.485180593047, 50888.236676449145, 51502.22746658728, 51540.74229628828, 52201.7389913048, 52617.210741838135, 65353.0, 65462.67268663626, 65571.0, 66452.0, 67421.32578674347, 19120.0, 19398.127084280957, 19400.320988765325, 19448.0, 19628.60742785108, 20071.899640502288, 20217.0, 20229.393118206477, 20354.796452035884, 20368.79631203669, 19429.51426214356, 19805.108770105093, 19837.107330170467, 19863.404097877086, 19986.500337491678, 17018.914905425394, 17151.22819473102, 17356.91321543384, 17379.565510861823, 17595.736063958793, 19276.518087047934, 19602.705959410905, 19629.411117666492, 19649.80350196537, 19849.0, 14577.271136443347, 14644.267786610413, 14644.487442939446, 14681.41274349014, 14891.776623350876, 14123.788143178066, 14411.0, 14430.783538247144, 14519.0, 14522.273886305853], "value": 9861.665509317818, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1379.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 106.0, 107.0, 105.0, 100.0, 106.0, 105.0, 105.0, 105.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 117.0, 112.0, 111.0, 114.0, 113.0, 139.0, 114.0, 113.0], "value": 116.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 161.0, 162.0, 162.0, 163.0, 162.0, 168.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 78.0, 73.0, 73.0, 73.0, 74.0, 74.0, 73.0, 73.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 77.0, 78.0, 77.0, 78.0, 78.0, 84.0, 86.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 114.0, 110.0, 113.0, 113.0, 114.0, 114.0, 114.0, 117.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 148.0, 149.0, 149.0, 149.0, 149.0, 149.0, 150.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 93.0, 95.0, 93.0, 94.0, 94.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 46.0, 50.0, 45.0, 46.0, 45.0, 45.0, 44.0, 48.0], "value": 46.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 74.0, 73.0, 74.0, 74.0, 77.0, 71.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 107.0, 110.0, 102.0, 107.0, 119.0, 110.0, 112.0, 106.0, 116.0], "value": 109.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 153.0, 154.0, 151.0, 152.0, 153.0, 156.0, 158.0, 155.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 65.0, 64.0, 64.0, 67.0, 62.0, 60.0, 63.0, 63.0], "value": 63.0, "unit": "score"}]}]} 03:40:36 INFO - Return code: 0 03:40:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:40:37 INFO - # TBPL SUCCESS # 03:40:37 INFO - Running post-action listener: _package_coverage_data 03:40:37 INFO - Running post-action listener: _resource_record_post_action 03:40:37 INFO - [mozharness: 2017-09-15 10:40:37.027792Z] Finished run-tests step (success) 03:40:37 INFO - Running post-run listener: _resource_record_post_run 03:40:37 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 9355264; Write bytes: 458764288; Read time: 2144; Write time: 389424 03:40:37 INFO - TinderboxPrint: CPU usage
13.1% 03:40:37 INFO - TinderboxPrint: I/O read bytes / time
9,355,264 / 2,144 03:40:37 INFO - TinderboxPrint: I/O write bytes / time
458,764,288 / 389,424 03:40:37 INFO - TinderboxPrint: CPU idle
8,253.5 (86.9%) 03:40:37 INFO - TinderboxPrint: CPU user
1,188.4 (12.5%) 03:40:37 INFO - TinderboxPrint: Swap in / out
0 / 0 03:40:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12402688; Read time: 0; Write time: 2516 03:40:37 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:40:37 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8204288; Write bytes: 446361600; Read time: 2116; Write time: 386908 03:40:37 INFO - Running post-run listener: _upload_blobber_files 03:40:37 INFO - Blob upload gear active. 03:40:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:40:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:40:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:40:38 INFO - (blobuploader) - INFO - Open directory for files ... 03:40:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:40:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:40:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:39 INFO - (blobuploader) - INFO - Done attempting. 03:40:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:40:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:40:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:40 INFO - (blobuploader) - INFO - Done attempting. 03:40:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:40:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:40:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:41 INFO - (blobuploader) - INFO - Done attempting. 03:40:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:40:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:40:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:48 INFO - (blobuploader) - INFO - Done attempting. 03:40:48 INFO - (blobuploader) - INFO - Iteration through files over. 03:40:48 INFO - Return code: 0 03:40:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:40:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:40:48 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45699211d9619f93df802cc8f6ab2060cb0b8ad72653c2bfcc8881c19e32977c9c788eacae2e9037fb7457b347dbc88ae20e57d0135c6e342edc8fa3a2416c71", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cf67504f18fe224cb017551c731e1e7f302f039819b649373562069988c712073e26d89cfc867e11bd29f2490b389d7914ccc85d6fdbe4867318b5ba337fd79", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8abca8db8b1d8f464811a37f9524ec46788c09e8643674e2e796a9810921138293a6b86cba249a7761c9e5dec787819efd3885f99bcb9e8605570b37317976e4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5191eb83a3191ff5181f2773e8b4d2a7925e87801d0b99bb907a9d2dba72b62ac8a301f607d9be52a3415585d5bcb6715095f63fdd59436ce4babd8a55b16bb"} 03:40:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:40:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:40:48 INFO - Contents: 03:40:48 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45699211d9619f93df802cc8f6ab2060cb0b8ad72653c2bfcc8881c19e32977c9c788eacae2e9037fb7457b347dbc88ae20e57d0135c6e342edc8fa3a2416c71", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cf67504f18fe224cb017551c731e1e7f302f039819b649373562069988c712073e26d89cfc867e11bd29f2490b389d7914ccc85d6fdbe4867318b5ba337fd79", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8abca8db8b1d8f464811a37f9524ec46788c09e8643674e2e796a9810921138293a6b86cba249a7761c9e5dec787819efd3885f99bcb9e8605570b37317976e4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5191eb83a3191ff5181f2773e8b4d2a7925e87801d0b99bb907a9d2dba72b62ac8a301f607d9be52a3415585d5bcb6715095f63fdd59436ce4babd8a55b16bb"} 03:40:48 INFO - Running post-run listener: copy_logs_to_upload_dir 03:40:48 INFO - Copying logs to upload dir... 03:40:48 INFO - mkdir: /builds/slave/test/build/upload/logs 03:40:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.189274 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-15 03:40:48.442411) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 03:40:48.446062) ========= 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=7de08804244eb36560b44971000001c3-1505469860.17312-4953465 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/45699211d9619f93df802cc8f6ab2060cb0b8ad72653c2bfcc8881c19e32977c9c788eacae2e9037fb7457b347dbc88ae20e57d0135c6e342edc8fa3a2416c71", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cf67504f18fe224cb017551c731e1e7f302f039819b649373562069988c712073e26d89cfc867e11bd29f2490b389d7914ccc85d6fdbe4867318b5ba337fd79", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8abca8db8b1d8f464811a37f9524ec46788c09e8643674e2e796a9810921138293a6b86cba249a7761c9e5dec787819efd3885f99bcb9e8605570b37317976e4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5191eb83a3191ff5181f2773e8b4d2a7925e87801d0b99bb907a9d2dba72b62ac8a301f607d9be52a3415585d5bcb6715095f63fdd59436ce4babd8a55b16bb"} build_url:https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45699211d9619f93df802cc8f6ab2060cb0b8ad72653c2bfcc8881c19e32977c9c788eacae2e9037fb7457b347dbc88ae20e57d0135c6e342edc8fa3a2416c71", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cf67504f18fe224cb017551c731e1e7f302f039819b649373562069988c712073e26d89cfc867e11bd29f2490b389d7914ccc85d6fdbe4867318b5ba337fd79", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8abca8db8b1d8f464811a37f9524ec46788c09e8643674e2e796a9810921138293a6b86cba249a7761c9e5dec787819efd3885f99bcb9e8605570b37317976e4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5191eb83a3191ff5181f2773e8b4d2a7925e87801d0b99bb907a9d2dba72b62ac8a301f607d9be52a3415585d5bcb6715095f63fdd59436ce4babd8a55b16bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 03:40:48.474209) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:40:48.474548) ========= 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=7de08804244eb36560b44971000001c3-1505469860.17312-4953465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:40:48.559646) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 03:40:48.559965) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 03:40:48.560308) ========= ========= Total master_lag: 0.25 =========