builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1502449033.13 results: success (0) revision: 64f5e3f40f0e7accb12cd90080e58eff0be46383 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:13.127393) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:13.127829) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:13.128105) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:13.143732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:13.144031) ========= 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=62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-11 03:57:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 80.0M=0s 2017-08-11 03:57:13 (80.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162669 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:13.323178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:13.323503) ========= 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=62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014495 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:13.376389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:13.376870) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 64f5e3f40f0e7accb12cd90080e58eff0be46383 --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 64f5e3f40f0e7accb12cd90080e58eff0be46383 --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=62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-11 03:57:13,469 truncating revision to first 12 chars 2017-08-11 03:57:13,469 Setting DEBUG logging. 2017-08-11 03:57:13,469 attempt 1/10 2017-08-11 03:57:13,469 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/64f5e3f40f0e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-11 03:57:13,913 unpacking tar archive at: mozilla-central-64f5e3f40f0e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.869270 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:14.262402) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:14.262711) ========= script_repo_revision: 64f5e3f40f0e7accb12cd90080e58eff0be46383 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:14.263086) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:14.263360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 03:57:14.272013) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-11 03:57:14.272291) ========= /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=62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:57:14 INFO - MultiFileLogger online at 20170811 03:57:14 in /builds/slave/test 03:57:14 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:57:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:57:14 INFO - {'append_to_log': False, 03:57:14 INFO - 'base_work_dir': '/builds/slave/test', 03:57:14 INFO - 'blob_upload_branch': 'Firefox', 03:57:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:57:14 INFO - 'branch': 'Firefox', 03:57:14 INFO - 'buildbot_json_path': 'buildprops.json', 03:57:14 INFO - 'code_coverage': False, 03:57:14 INFO - 'config_files': ('talos/linux_config.py',), 03:57:14 INFO - 'default_actions': ('clobber', 03:57:14 INFO - 'read-buildbot-config', 03:57:14 INFO - 'download-and-extract', 03:57:14 INFO - 'populate-webroot', 03:57:14 INFO - 'create-virtualenv', 03:57:14 INFO - 'install', 03:57:14 INFO - 'setup-mitmproxy', 03:57:14 INFO - 'run-tests'), 03:57:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:57:14 INFO - 'disable_ccov_upload': False, 03:57:14 INFO - 'download_minidump_stackwalk': True, 03:57:14 INFO - 'download_symbols': 'ondemand', 03:57:14 INFO - 'enable_stylo': False, 03:57:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:57:14 INFO - 'tooltool.py': '/tools/tooltool.py', 03:57:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:57:14 INFO - '/tools/misc-python/virtualenv.py')}, 03:57:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:57:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:57:14 INFO - 'gecko_profile': False, 03:57:14 INFO - 'gecko_profile_interval': 0, 03:57:14 INFO - 'installer_path': 'installer.exe', 03:57:14 INFO - 'log_level': 'info', 03:57:14 INFO - 'log_name': 'talos', 03:57:14 INFO - 'log_to_console': True, 03:57:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:57:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:57:14 INFO - 'opt_config_files': (), 03:57:14 INFO - 'pip_index': False, 03:57:14 INFO - 'suite': 'dromaeojs-e10s', 03:57:14 INFO - 'system_bits': '32', 03:57:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:57:14 INFO - 'title': 'talos-linux64-ix-018', 03:57:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:57:14 INFO - 'use_talos_json': True, 03:57:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:57:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:57:14 INFO - 'work_dir': 'build'} 03:57:14 INFO - [mozharness: 2017-08-11 10:57:14.470128Z] Running clobber step. 03:57:14 INFO - Running pre-action listener: _resource_record_pre_action 03:57:14 INFO - Running main action method: clobber 03:57:14 INFO - rmtree: /builds/slave/test/build 03:57:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:57:16 INFO - Running post-action listener: _resource_record_post_action 03:57:16 INFO - [mozharness: 2017-08-11 10:57:16.166664Z] Finished clobber step (success) 03:57:16 INFO - [mozharness: 2017-08-11 10:57:16.166766Z] Running read-buildbot-config step. 03:57:16 INFO - Running pre-action listener: _resource_record_pre_action 03:57:16 INFO - Running main action method: read_buildbot_config 03:57:16 INFO - Using buildbot properties: 03:57:16 INFO - { 03:57:16 INFO - "project": "", 03:57:16 INFO - "product": "firefox", 03:57:16 INFO - "who": "archaeopteryx@coole-files.de", 03:57:16 INFO - "installer_path": "public/build/target.tar.bz2", 03:57:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:57:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:57:16 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:57:16 INFO - "stage_platform": "linux64-stylo", 03:57:16 INFO - "basedir": "/builds/slave/test", 03:57:16 INFO - "buildnumber": 21, 03:57:16 INFO - "platform": "ubuntu64_hw_stylo", 03:57:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:57:16 INFO - "slavebuilddir": "test", 03:57:16 INFO - "taskId": "CJ5pF53mQ0GH82nXl2r6Dw", 03:57:16 INFO - "branch": "mozilla-central", 03:57:16 INFO - "script_repo_revision": "production", 03:57:16 INFO - "revision": "64f5e3f40f0e7accb12cd90080e58eff0be46383", 03:57:16 INFO - "slavename": "talos-linux64-ix-018", 03:57:16 INFO - "repo_path": "mozilla-central" 03:57:16 INFO - } 03:57:16 INFO - Finding installer, test and symbols from parent task. 03:57:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CJ5pF53mQ0GH82nXl2r6Dw'}, attempt #1 03:57:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CJ5pF53mQ0GH82nXl2r6Dw'}, attempt #1 03:57:17 INFO - Task dependencies: DccvNO8hRT2EKCynlXqtsg 03:57:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg'}, attempt #1 03:57:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2 03:57:17 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.test_packages.json 03:57:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.crashreporter-symbols.zip 03:57:17 INFO - Running post-action listener: _resource_record_post_action 03:57:17 INFO - [mozharness: 2017-08-11 10:57:17.519489Z] Finished read-buildbot-config step (success) 03:57:17 INFO - [mozharness: 2017-08-11 10:57:17.519715Z] Running download-and-extract step. 03:57:17 INFO - Running pre-action listener: _resource_record_pre_action 03:57:17 INFO - Running main action method: download_and_extract 03:57:17 INFO - mkdir: /builds/slave/test/build/tests 03:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:17 INFO - trying https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.test_packages.json 03:57:17 INFO - Downloading https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:57:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:57:18 INFO - Downloaded 989 bytes. 03:57:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:57:18 INFO - Using the following test package requirements: 03:57:18 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:57:18 INFO - u'common': [u'target.common.tests.zip'], 03:57:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:57:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:57:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:57:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:57:18 INFO - u'mozbase': [u'target.common.tests.zip'], 03:57:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:57:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:57:18 INFO - u'web-platform': [u'target.common.tests.zip', 03:57:18 INFO - u'target.web-platform.tests.tar.gz'], 03:57:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:57:18 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:57:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.common.tests.zip 03:57:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:57:18 INFO - Fetch https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.common.tests.zip into memory 03:57:19 INFO - Content-Length response header: 54036596 03:57:19 INFO - Bytes received: 54036596 03:57:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:57:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.common.tests.zip 03:57:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:57:30 INFO - Fetch https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.common.tests.zip into memory 03:57:31 INFO - Content-Length response header: 54036596 03:57:31 INFO - Bytes received: 54036596 03:57:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.talos.tests.zip 03:57:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:57:43 INFO - Fetch https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.talos.tests.zip into memory 03:57:44 INFO - Content-Length response header: 14496050 03:57:44 INFO - Bytes received: 14496050 03:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:44 INFO - trying https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2 03:57:44 INFO - Downloading https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:57:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:57:45 INFO - Downloaded 61791336 bytes. 03:57:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2 03:57:45 INFO - mkdir: /builds/slave/test/properties 03:57:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:57:45 INFO - Writing to file /builds/slave/test/properties/build_url 03:57:45 INFO - Contents: 03:57:45 INFO - build_url:https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2 03:57:45 INFO - Running post-action listener: _resource_record_post_action 03:57:45 INFO - Running post-action listener: set_extra_try_arguments 03:57:45 INFO - [mozharness: 2017-08-11 10:57:45.467915Z] Finished download-and-extract step (success) 03:57:45 INFO - [mozharness: 2017-08-11 10:57:45.468014Z] Running populate-webroot step. 03:57:45 INFO - Running pre-action listener: _resource_record_pre_action 03:57:45 INFO - Running main action method: populate_webroot 03:57:45 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:57:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:57:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:57:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:57:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:57:45 INFO - 'tests': ['damp', 'tps']}, 03:57:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:57:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:57:45 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:57:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:57:45 INFO - 'other-e10s': {'tests': ['a11yr', 03:57:45 INFO - 'ts_paint', 03:57:45 INFO - 'tpaint', 03:57:45 INFO - 'sessionrestore', 03:57:45 INFO - 'sessionrestore_many_windows', 03:57:45 INFO - 'sessionrestore_no_auto_restore', 03:57:45 INFO - 'tabpaint']}, 03:57:45 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:57:45 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:57:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:57:45 INFO - 'tsvgr_opacity', 03:57:45 INFO - 'tart', 03:57:45 INFO - 'tscrollx', 03:57:45 INFO - 'tsvg_static']}, 03:57:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:57:45 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:57:45 INFO - 'talos_options': ['--mitmproxy', 03:57:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:57:45 INFO - '--firstNonBlankPaint'], 03:57:45 INFO - 'tests': ['tp6_google', 03:57:45 INFO - 'tp6_youtube', 03:57:45 INFO - 'tp6_amazon', 03:57:45 INFO - 'tp6_facebook']}, 03:57:45 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:57:45 INFO - 'talos_options': ['--stylo', 03:57:45 INFO - '--mitmproxy', 03:57:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:57:45 INFO - '--firstNonBlankPaint'], 03:57:45 INFO - 'tests': ['tp6_google', 03:57:45 INFO - 'tp6_youtube', 03:57:45 INFO - 'tp6_amazon', 03:57:45 INFO - 'tp6_facebook']}, 03:57:45 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:57:45 INFO - 'talos_options': ['--stylo', 03:57:45 INFO - '--stylo-threads=1', 03:57:45 INFO - '--mitmproxy', 03:57:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:57:45 INFO - '--firstNonBlankPaint'], 03:57:45 INFO - 'tests': ['tp6_google', 03:57:45 INFO - 'tp6_youtube', 03:57:45 INFO - 'tp6_amazon', 03:57:45 INFO - 'tp6_facebook']}, 03:57:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:57:45 INFO - 'talos_options': ['--xperf_path', 03:57:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:57:45 INFO - 'tests': ['tp5n']}}} 03:57:45 INFO - Running post-action listener: _resource_record_post_action 03:57:45 INFO - [mozharness: 2017-08-11 10:57:45.476494Z] Finished populate-webroot step (success) 03:57:45 INFO - [mozharness: 2017-08-11 10:57:45.476585Z] Running create-virtualenv step. 03:57:45 INFO - Running pre-action listener: _resource_record_pre_action 03:57:45 INFO - Running main action method: create_virtualenv 03:57:45 INFO - Creating virtualenv /builds/slave/test/build/venv 03:57:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:57:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:57:45 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:57:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:57:45 INFO - Using real prefix '/usr' 03:57:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:57:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:57:48 INFO - Installing pip.................done. 03:57:48 INFO - Return code: 0 03:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:57:48 INFO - Reading from file tmpfile_stdout 03:57:48 INFO - Output received: 03:57:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:57:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8f00>, '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 0x1ad3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4050>, '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': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', '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:57:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:57:48 INFO - Using env: {'DISPLAY': ':0', 03:57:48 INFO - 'HOME': '/home/cltbld', 03:57:48 INFO - 'LANG': 'en_US.UTF-8', 03:57:48 INFO - 'LANGUAGE': 'en_US:en', 03:57:48 INFO - 'LOGNAME': 'cltbld', 03:57:48 INFO - 'MAIL': '/var/mail/cltbld', 03:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:48 INFO - 'MOZ_NO_REMOTE': '1', 03:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:48 INFO - 'NO_EM_RESTART': '1', 03:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:48 INFO - 'PWD': '/builds/slave/test', 03:57:48 INFO - 'SHELL': '/bin/bash', 03:57:48 INFO - 'SHLVL': '1', 03:57:48 INFO - 'TERM': 'linux', 03:57:48 INFO - 'TMOUT': '86400', 03:57:48 INFO - 'USER': 'cltbld', 03:57:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', 03:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:48 INFO - '_': '/tools/buildbot/bin/python'} 03:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:57:48 INFO - Cleaning up... 03:57:48 INFO - Return code: 0 03:57:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8f00>, '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 0x1ad3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4050>, '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': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', '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:57:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:57:48 INFO - Using env: {'DISPLAY': ':0', 03:57:48 INFO - 'HOME': '/home/cltbld', 03:57:48 INFO - 'LANG': 'en_US.UTF-8', 03:57:48 INFO - 'LANGUAGE': 'en_US:en', 03:57:48 INFO - 'LOGNAME': 'cltbld', 03:57:48 INFO - 'MAIL': '/var/mail/cltbld', 03:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:48 INFO - 'MOZ_NO_REMOTE': '1', 03:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:48 INFO - 'NO_EM_RESTART': '1', 03:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:48 INFO - 'PWD': '/builds/slave/test', 03:57:48 INFO - 'SHELL': '/bin/bash', 03:57:48 INFO - 'SHLVL': '1', 03:57:48 INFO - 'TERM': 'linux', 03:57:48 INFO - 'TMOUT': '86400', 03:57:48 INFO - 'USER': 'cltbld', 03:57:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', 03:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:48 INFO - '_': '/tools/buildbot/bin/python'} 03:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:48 INFO - Downloading/unpacking psutil>=3.1.1 03:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:57:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:49 INFO - Installing collected packages: psutil 03:57:49 INFO - Running setup.py install for psutil 03:57:50 INFO - building 'psutil._psutil_linux' extension 03:57:50 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:57:50 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:57:50 INFO - building 'psutil._psutil_posix' extension 03:57:50 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:57:50 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:57:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:50 INFO - Successfully installed psutil 03:57:50 INFO - Cleaning up... 03:57:50 INFO - Return code: 0 03:57:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:50 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8f00>, '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 0x1ad3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4050>, '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': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', '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:57:50 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:57:50 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:57:50 INFO - Using env: {'DISPLAY': ':0', 03:57:50 INFO - 'HOME': '/home/cltbld', 03:57:50 INFO - 'LANG': 'en_US.UTF-8', 03:57:50 INFO - 'LANGUAGE': 'en_US:en', 03:57:50 INFO - 'LOGNAME': 'cltbld', 03:57:50 INFO - 'MAIL': '/var/mail/cltbld', 03:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:50 INFO - 'MOZ_NO_REMOTE': '1', 03:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:50 INFO - 'NO_EM_RESTART': '1', 03:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:50 INFO - 'PWD': '/builds/slave/test', 03:57:50 INFO - 'SHELL': '/bin/bash', 03:57:50 INFO - 'SHLVL': '1', 03:57:50 INFO - 'TERM': 'linux', 03:57:50 INFO - 'TMOUT': '86400', 03:57:50 INFO - 'USER': 'cltbld', 03:57:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', 03:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:50 INFO - '_': '/tools/buildbot/bin/python'} 03:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:57:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:57:51 INFO - Installing collected packages: mozsystemmonitor 03:57:51 INFO - Running setup.py install for mozsystemmonitor 03:57:51 INFO - Successfully installed mozsystemmonitor 03:57:51 INFO - Cleaning up... 03:57:51 INFO - Return code: 0 03:57:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8f00>, '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 0x1ad3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4050>, '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': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', '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:57:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:57:51 INFO - Using env: {'DISPLAY': ':0', 03:57:51 INFO - 'HOME': '/home/cltbld', 03:57:51 INFO - 'LANG': 'en_US.UTF-8', 03:57:51 INFO - 'LANGUAGE': 'en_US:en', 03:57:51 INFO - 'LOGNAME': 'cltbld', 03:57:51 INFO - 'MAIL': '/var/mail/cltbld', 03:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:51 INFO - 'MOZ_NO_REMOTE': '1', 03:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:51 INFO - 'NO_EM_RESTART': '1', 03:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:51 INFO - 'PWD': '/builds/slave/test', 03:57:51 INFO - 'SHELL': '/bin/bash', 03:57:51 INFO - 'SHLVL': '1', 03:57:51 INFO - 'TERM': 'linux', 03:57:51 INFO - 'TMOUT': '86400', 03:57:51 INFO - 'USER': 'cltbld', 03:57:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', 03:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:51 INFO - '_': '/tools/buildbot/bin/python'} 03:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:52 INFO - Downloading/unpacking jsonschema==2.5.1 03:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:57:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:53 INFO - Downloading functools32-3.2.3-2.tar.gz 03:57:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:57:53 INFO - warning: no files found matching '*.txt' 03:57:53 INFO - no previously-included directories found matching 'build' 03:57:53 INFO - no previously-included directories found matching 'dist' 03:57:53 INFO - no previously-included directories found matching '.git*' 03:57:53 INFO - Installing collected packages: jsonschema, functools32 03:57:53 INFO - Running setup.py install for functools32 03:57:53 INFO - warning: no files found matching '*.txt' 03:57:53 INFO - no previously-included directories found matching 'build' 03:57:53 INFO - no previously-included directories found matching 'dist' 03:57:53 INFO - no previously-included directories found matching '.git*' 03:57:53 INFO - Successfully installed jsonschema functools32 03:57:53 INFO - Cleaning up... 03:57:53 INFO - Return code: 0 03:57:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:57:53 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:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:53 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:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:53 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8f00>, '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 0x1ad3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4050>, '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': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', '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:57:53 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:57:53 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:57:53 INFO - Using env: {'DISPLAY': ':0', 03:57:53 INFO - 'HOME': '/home/cltbld', 03:57:53 INFO - 'LANG': 'en_US.UTF-8', 03:57:53 INFO - 'LANGUAGE': 'en_US:en', 03:57:53 INFO - 'LOGNAME': 'cltbld', 03:57:53 INFO - 'MAIL': '/var/mail/cltbld', 03:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:53 INFO - 'MOZ_NO_REMOTE': '1', 03:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:53 INFO - 'NO_EM_RESTART': '1', 03:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:53 INFO - 'PWD': '/builds/slave/test', 03:57:53 INFO - 'SHELL': '/bin/bash', 03:57:53 INFO - 'SHLVL': '1', 03:57:53 INFO - 'TERM': 'linux', 03:57:53 INFO - 'TMOUT': '86400', 03:57:53 INFO - 'USER': 'cltbld', 03:57:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', 03:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:53 INFO - '_': '/tools/buildbot/bin/python'} 03:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:57:53 INFO - Cleaning up... 03:57:53 INFO - Return code: 0 03:57:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:57:53 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:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:53 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:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:54 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8f00>, '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 0x1ad3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4050>, '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': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', '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:57:54 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:57:54 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:57:54 INFO - Using env: {'DISPLAY': ':0', 03:57:54 INFO - 'HOME': '/home/cltbld', 03:57:54 INFO - 'LANG': 'en_US.UTF-8', 03:57:54 INFO - 'LANGUAGE': 'en_US:en', 03:57:54 INFO - 'LOGNAME': 'cltbld', 03:57:54 INFO - 'MAIL': '/var/mail/cltbld', 03:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:54 INFO - 'MOZ_NO_REMOTE': '1', 03:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:54 INFO - 'NO_EM_RESTART': '1', 03:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:54 INFO - 'PWD': '/builds/slave/test', 03:57:54 INFO - 'SHELL': '/bin/bash', 03:57:54 INFO - 'SHLVL': '1', 03:57:54 INFO - 'TERM': 'linux', 03:57:54 INFO - 'TMOUT': '86400', 03:57:54 INFO - 'USER': 'cltbld', 03:57:54 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', 03:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:54 INFO - '_': '/tools/buildbot/bin/python'} 03:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:57:54 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:57:54 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:57:54 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:57:54 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:57:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:57:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:57:55 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:57:55 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:57:55 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:57:55 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:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:57:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:57:55 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:57:55 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:57:55 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:57:55 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:57:55 INFO - Downloading docopt-0.6.1.tar.gz 03:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:57:55 INFO - Installing collected packages: blobuploader, requests, docopt 03:57:55 INFO - Running setup.py install for blobuploader 03:57:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:57:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:57:56 INFO - Running setup.py install for requests 03:57:56 INFO - Running setup.py install for docopt 03:57:56 INFO - Successfully installed blobuploader requests docopt 03:57:56 INFO - Cleaning up... 03:57:56 INFO - Return code: 0 03:57:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:56 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8f00>, '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 0x1ad3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4050>, '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': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', '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:57:56 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:57:56 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:57:56 INFO - Using env: {'DISPLAY': ':0', 03:57:56 INFO - 'HOME': '/home/cltbld', 03:57:56 INFO - 'LANG': 'en_US.UTF-8', 03:57:56 INFO - 'LANGUAGE': 'en_US:en', 03:57:56 INFO - 'LOGNAME': 'cltbld', 03:57:56 INFO - 'MAIL': '/var/mail/cltbld', 03:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:56 INFO - 'MOZ_NO_REMOTE': '1', 03:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:56 INFO - 'NO_EM_RESTART': '1', 03:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:56 INFO - 'PWD': '/builds/slave/test', 03:57:56 INFO - 'SHELL': '/bin/bash', 03:57:56 INFO - 'SHLVL': '1', 03:57:56 INFO - 'TERM': 'linux', 03:57:56 INFO - 'TMOUT': '86400', 03:57:56 INFO - 'USER': 'cltbld', 03:57:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', 03:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:56 INFO - '_': '/tools/buildbot/bin/python'} 03:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:56 INFO - Running setup.py (path:/tmp/pip-D1HqzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:56 INFO - Running setup.py (path:/tmp/pip-Ury5uH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:56 INFO - Running setup.py (path:/tmp/pip-6rKRzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:56 INFO - Running setup.py (path:/tmp/pip-qwC21a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:56 INFO - Running setup.py (path:/tmp/pip-hQcGRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:57 INFO - Running setup.py (path:/tmp/pip-hNpShN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:57 INFO - Running setup.py (path:/tmp/pip-RKUgvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:57 INFO - Running setup.py (path:/tmp/pip-TPKy0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:57 INFO - Running setup.py (path:/tmp/pip-Jiq6WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:57 INFO - Running setup.py (path:/tmp/pip-SEAIOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:57 INFO - Running setup.py (path:/tmp/pip-qgGA_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:57 INFO - Running setup.py (path:/tmp/pip-bf9Cfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:57 INFO - Running setup.py (path:/tmp/pip-6wx7Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:57 INFO - Running setup.py (path:/tmp/pip-yO2Gm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:57 INFO - Running setup.py (path:/tmp/pip-zdbGP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:57 INFO - Running setup.py (path:/tmp/pip-1JsJoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:57 INFO - Running setup.py (path:/tmp/pip-KROyp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:57:57 INFO - Running setup.py install for manifestparser 03:57:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:57:58 INFO - Running setup.py install for mozcrash 03:57:58 INFO - Running setup.py install for mozdebug 03:57:58 INFO - Running setup.py install for mozdevice 03:57:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:57:58 INFO - Running setup.py install for mozfile 03:57:58 INFO - Running setup.py install for mozhttpd 03:57:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:57:58 INFO - Running setup.py install for mozinfo 03:57:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:57:58 INFO - Running setup.py install for mozInstall 03:57:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:57:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:57:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:57:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:57:58 INFO - Running setup.py install for mozleak 03:57:58 INFO - Running setup.py install for mozlog 03:57:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:57:58 INFO - Running setup.py install for moznetwork 03:57:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:57:59 INFO - Running setup.py install for mozprocess 03:57:59 INFO - Running setup.py install for mozprofile 03:57:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:57:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:57:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:57:59 INFO - Running setup.py install for mozrunner 03:57:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:57:59 INFO - Running setup.py install for mozscreenshot 03:57:59 INFO - Running setup.py install for moztest 03:57:59 INFO - Running setup.py install for mozversion 03:57:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:57:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:57:59 INFO - Cleaning up... 03:57:59 INFO - Return code: 0 03:57:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:59 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:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:59 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:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:59 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8f00>, '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 0x1ad3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4050>, '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': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', '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:57:59 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:57:59 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:57:59 INFO - Using env: {'DISPLAY': ':0', 03:57:59 INFO - 'HOME': '/home/cltbld', 03:57:59 INFO - 'LANG': 'en_US.UTF-8', 03:57:59 INFO - 'LANGUAGE': 'en_US:en', 03:57:59 INFO - 'LOGNAME': 'cltbld', 03:57:59 INFO - 'MAIL': '/var/mail/cltbld', 03:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:59 INFO - 'MOZ_NO_REMOTE': '1', 03:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:59 INFO - 'NO_EM_RESTART': '1', 03:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:59 INFO - 'PWD': '/builds/slave/test', 03:57:59 INFO - 'SHELL': '/bin/bash', 03:57:59 INFO - 'SHLVL': '1', 03:57:59 INFO - 'TERM': 'linux', 03:57:59 INFO - 'TMOUT': '86400', 03:57:59 INFO - 'USER': 'cltbld', 03:57:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', 03:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:59 INFO - '_': '/tools/buildbot/bin/python'} 03:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:59 INFO - Running setup.py (path:/tmp/pip-hcng3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:59 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:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:59 INFO - Running setup.py (path:/tmp/pip-gRnxTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:58:00 INFO - Running setup.py (path:/tmp/pip-O0zp4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:58:00 INFO - Running setup.py (path:/tmp/pip-HmLmdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:58:00 INFO - Running setup.py (path:/tmp/pip-iKsSv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:58:00 INFO - Running setup.py (path:/tmp/pip-HJAO9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:58:00 INFO - Running setup.py (path:/tmp/pip-2AKPMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:58:00 INFO - Running setup.py (path:/tmp/pip-TMhblq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:58:00 INFO - Running setup.py (path:/tmp/pip-D9uniF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:58:00 INFO - Running setup.py (path:/tmp/pip-NLPjyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:58:00 INFO - Running setup.py (path:/tmp/pip-PcOnZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:58:00 INFO - Running setup.py (path:/tmp/pip-8du1XR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:58:00 INFO - Running setup.py (path:/tmp/pip-3yk1qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:58:00 INFO - Running setup.py (path:/tmp/pip-18sd2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:00 INFO - Running setup.py (path:/tmp/pip-8gurwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:00 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:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:58:01 INFO - Running setup.py (path:/tmp/pip-es4CTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:58:01 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:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:58:01 INFO - Running setup.py (path:/tmp/pip-DBRGZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:58:01 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:58:01 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:58:01 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:58:01 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:58:01 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:58:01 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:58:01 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:58:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:02 INFO - Downloading blessings-1.6.tar.gz 03:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:58:02 INFO - Installing collected packages: blessings 03:58:02 INFO - Running setup.py install for blessings 03:58:02 INFO - Successfully installed blessings 03:58:02 INFO - Cleaning up... 03:58:02 INFO - Return code: 0 03:58:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:58:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:02 INFO - Reading from file tmpfile_stdout 03:58:02 INFO - Current package versions: 03:58:02 INFO - argparse == 1.2.1 03:58:02 INFO - blessings == 1.6 03:58:02 INFO - blobuploader == 1.2.4 03:58:02 INFO - docopt == 0.6.1 03:58:02 INFO - functools32 == 3.2.3-2 03:58:02 INFO - jsonschema == 2.5.1 03:58:02 INFO - manifestparser == 1.1 03:58:02 INFO - mozInstall == 1.13 03:58:02 INFO - mozcrash == 1.0 03:58:02 INFO - mozdebug == 0.1 03:58:02 INFO - mozdevice == 0.51 03:58:02 INFO - mozfile == 1.2 03:58:02 INFO - mozhttpd == 0.7 03:58:02 INFO - mozinfo == 0.10 03:58:02 INFO - mozleak == 0.1 03:58:02 INFO - mozlog == 3.5 03:58:02 INFO - moznetwork == 0.27 03:58:02 INFO - mozprocess == 0.25 03:58:02 INFO - mozprofile == 0.28 03:58:02 INFO - mozrunner == 6.13 03:58:02 INFO - mozscreenshot == 0.1 03:58:02 INFO - mozsystemmonitor == 0.3 03:58:02 INFO - moztest == 0.8 03:58:02 INFO - mozversion == 1.4 03:58:02 INFO - psutil == 3.1.1 03:58:02 INFO - requests == 1.2.3 03:58:02 INFO - wsgiref == 0.1.2 03:58:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:02 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8f00>, '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 0x1ad3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4050>, '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': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', '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:58:02 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:58:02 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:58:02 INFO - Using env: {'DISPLAY': ':0', 03:58:02 INFO - 'HOME': '/home/cltbld', 03:58:02 INFO - 'LANG': 'en_US.UTF-8', 03:58:02 INFO - 'LANGUAGE': 'en_US:en', 03:58:02 INFO - 'LOGNAME': 'cltbld', 03:58:02 INFO - 'MAIL': '/var/mail/cltbld', 03:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:02 INFO - 'MOZ_NO_REMOTE': '1', 03:58:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:02 INFO - 'NO_EM_RESTART': '1', 03:58:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:02 INFO - 'PWD': '/builds/slave/test', 03:58:02 INFO - 'SHELL': '/bin/bash', 03:58:02 INFO - 'SHLVL': '1', 03:58:02 INFO - 'TERM': 'linux', 03:58:02 INFO - 'TMOUT': '86400', 03:58:02 INFO - 'USER': 'cltbld', 03:58:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', 03:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:02 INFO - '_': '/tools/buildbot/bin/python'} 03:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:02 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:58:02 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:58:02 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:58:02 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:58:02 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:58:02 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:58:02 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:58:02 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:58:02 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:58:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:58:04 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:58:04 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:58:04 INFO - Installing collected packages: simplejson 03:58:04 INFO - Running setup.py install for simplejson 03:58:04 INFO - building 'simplejson._speedups' extension 03:58:04 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:58:04 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:58:05 INFO - Successfully installed simplejson 03:58:05 INFO - Cleaning up... 03:58:05 INFO - Return code: 0 03:58:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:05 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8f00>, '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 0x1ad3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4050>, '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': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', '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:58:05 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:58:05 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:58:05 INFO - Using env: {'DISPLAY': ':0', 03:58:05 INFO - 'HOME': '/home/cltbld', 03:58:05 INFO - 'LANG': 'en_US.UTF-8', 03:58:05 INFO - 'LANGUAGE': 'en_US:en', 03:58:05 INFO - 'LOGNAME': 'cltbld', 03:58:05 INFO - 'MAIL': '/var/mail/cltbld', 03:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:05 INFO - 'MOZ_NO_REMOTE': '1', 03:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:05 INFO - 'NO_EM_RESTART': '1', 03:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:05 INFO - 'PWD': '/builds/slave/test', 03:58:05 INFO - 'SHELL': '/bin/bash', 03:58:05 INFO - 'SHLVL': '1', 03:58:05 INFO - 'TERM': 'linux', 03:58:05 INFO - 'TMOUT': '86400', 03:58:05 INFO - 'USER': 'cltbld', 03:58:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', 03:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:05 INFO - '_': '/tools/buildbot/bin/python'} 03:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:58:05 INFO - Cleaning up... 03:58:05 INFO - Return code: 0 03:58:05 INFO - Running post-action listener: _resource_record_post_action 03:58:05 INFO - Running post-action listener: _start_resource_monitoring 03:58:05 INFO - Starting resource monitoring. 03:58:05 INFO - [mozharness: 2017-08-11 10:58:05.386393Z] Finished create-virtualenv step (success) 03:58:05 INFO - [mozharness: 2017-08-11 10:58:05.386908Z] Running install step. 03:58:05 INFO - Running pre-action listener: _resource_record_pre_action 03:58:05 INFO - Running main action method: install 03:58:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:05 INFO - Reading from file tmpfile_stdout 03:58:05 INFO - Detecting whether we're running mozinstall >=1.0... 03:58:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:58:05 INFO - Reading from file tmpfile_stdout 03:58:05 INFO - Output received: 03:58:05 INFO - Usage: mozinstall [options] installer 03:58:05 INFO - Options: 03:58:05 INFO - -h, --help show this help message and exit 03:58:05 INFO - -d DEST, --destination=DEST 03:58:05 INFO - Directory to install application into. [default: 03:58:05 INFO - "/builds/slave/test"] 03:58:05 INFO - --app=APP Application being installed. [default: firefox] 03:58:05 INFO - mkdir: /builds/slave/test/build/application 03:58:05 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:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:58:23 INFO - Reading from file tmpfile_stdout 03:58:23 INFO - Output received: 03:58:23 INFO - /builds/slave/test/build/application/firefox/firefox 03:58:23 INFO - Running post-action listener: _resource_record_post_action 03:58:23 INFO - [mozharness: 2017-08-11 10:58:23.704640Z] Finished install step (success) 03:58:23 INFO - [mozharness: 2017-08-11 10:58:23.704791Z] Running setup-mitmproxy step. 03:58:23 INFO - Running pre-action listener: _resource_record_pre_action 03:58:23 INFO - Running main action method: setup_mitmproxy 03:58:23 INFO - Skipping: mitmproxy is not required 03:58:23 INFO - Running post-action listener: _resource_record_post_action 03:58:23 INFO - [mozharness: 2017-08-11 10:58:23.705645Z] Finished setup-mitmproxy step (success) 03:58:23 INFO - [mozharness: 2017-08-11 10:58:23.705868Z] Running run-tests step. 03:58:23 INFO - Running pre-action listener: _resource_record_pre_action 03:58:23 INFO - Running pre-action listener: _set_gcov_prefix 03:58:23 INFO - Running main action method: run_tests 03:58:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:58:23 INFO - Python 2.7.3 03:58:23 INFO - Return code: 0 03:58:23 INFO - grabbing minidump binary from tooltool 03:58:23 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:58:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x1ad8f00>, '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 0x1ad3ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:58:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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:58:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:58:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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:58:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:58:23 INFO - Return code: 0 03:58:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:58:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:58:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:58:23 INFO - ENV: RUST_BACKTRACE is now full 03:58:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:58:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:58:23 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/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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:58:23 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/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-018 --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:58:23 INFO - Using env: {'DISPLAY': ':0', 03:58:23 INFO - 'HOME': '/home/cltbld', 03:58:23 INFO - 'LANG': 'en_US.UTF-8', 03:58:23 INFO - 'LANGUAGE': 'en_US:en', 03:58:23 INFO - 'LOGNAME': 'cltbld', 03:58:23 INFO - 'MAIL': '/var/mail/cltbld', 03:58:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:58:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:23 INFO - 'MOZ_NO_REMOTE': '1', 03:58:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:23 INFO - 'NO_EM_RESTART': '1', 03:58:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:23 INFO - 'PWD': '/builds/slave/test', 03:58:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:58:23 INFO - 'RUST_BACKTRACE': 'full', 03:58:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:58:23 INFO - 'SHELL': '/bin/bash', 03:58:23 INFO - 'SHLVL': '1', 03:58:23 INFO - 'STYLO_FORCE_ENABLED': '1', 03:58:23 INFO - 'TERM': 'linux', 03:58:23 INFO - 'TMOUT': '86400', 03:58:23 INFO - 'USER': 'cltbld', 03:58:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927', 03:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:23 INFO - '_': '/tools/buildbot/bin/python'} 03:58:23 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/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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:58:24 INFO - mozversion application_buildid: 20170811095810 03:58:24 INFO - mozversion application_changeset: 64f5e3f40f0e7accb12cd90080e58eff0be46383 03:58:24 INFO - mozversion application_display_name: Nightly 03:58:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:58:24 INFO - mozversion application_name: Firefox 03:58:24 INFO - mozversion application_remotingname: firefox 03:58:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:58:24 INFO - mozversion application_vendor: Mozilla 03:58:24 INFO - mozversion application_version: 57.0a1 03:58:24 INFO - mozversion platform_buildid: 20170811095810 03:58:24 INFO - mozversion platform_changeset: 64f5e3f40f0e7accb12cd90080e58eff0be46383 03:58:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:58:24 INFO - mozversion platform_version: 57.0a1 03:58:24 INFO - using testdate: 1502449104 03:58:24 INFO - actual date: 1502449104 03:58:24 INFO - starting webserver on 'localhost:45021' 03:58:24 INFO - SUITE-START | Running 2 tests 03:58:24 INFO - TEST-START | dromaeo_css 03:58:24 INFO - Initialising browser for dromaeo_css test... 03:58:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45021/getInfo.html -profile /tmp/tmpQIn4PA/profile 03:58:24 INFO - TEST-INFO | started process 28986 (/builds/slave/test/build/application/firefox/firefox http://localhost:45021/getInfo.html) 03:58:29 INFO - TEST-INFO | 28986: exit 0 03:58:29 INFO - Browser initialized. 03:58:29 INFO - Running cycle 1/1 for dromaeo_css test... 03:58:29 INFO - TEST-INFO | started process 29221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQIn4PA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:58:30 INFO - PID 29221 | 03:58:30 INFO - PID 29221 | (/builds/slave/test/build/application/firefox/firefox:29276): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:58:30 INFO - PID 29221 | 03:58:41 INFO - PID 29221 | RSS: Main: 171675648 03:58:41 INFO - PID 29221 | 04:01:40 INFO - PID 29221 | Cycle 1(1): loaded http://localhost:45021/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45021/tests/dromaeo/cssquery-ext.html) 04:01:41 INFO - PID 29221 | RSS: Main: 176087040 04:01:41 INFO - PID 29221 | 04:04:43 INFO - PID 29221 | Cycle 1(1): loaded http://localhost:45021/tests/dromaeo/cssquery-ext.html (next: http://localhost:45021/tests/dromaeo/cssquery-jquery.html) 04:04:43 INFO - PID 29221 | RSS: Main: 173547520 04:04:43 INFO - PID 29221 | 04:07:45 INFO - PID 29221 | Cycle 1(1): loaded http://localhost:45021/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45021/tests/dromaeo/cssquery-mootools.html) 04:07:46 INFO - PID 29221 | RSS: Main: 175214592 04:07:46 INFO - PID 29221 | 04:10:47 INFO - PID 29221 | Cycle 1(1): loaded http://localhost:45021/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45021/tests/dromaeo/cssquery-prototype.html) 04:10:48 INFO - PID 29221 | RSS: Main: 173436928 04:10:48 INFO - PID 29221 | 04:13:52 INFO - PID 29221 | Cycle 1(1): loaded http://localhost:45021/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45021/tests/dromaeo/cssquery-yui.html) 04:13:52 INFO - PID 29221 | RSS: Main: 177410048 04:13:52 INFO - PID 29221 | 04:16:54 INFO - PID 29221 | Cycle 1(1): loaded http://localhost:45021/tests/dromaeo/cssquery-yui.html (next: http://localhost:45021/tests/dromaeo/cssquery-dojo.html) 04:16:54 INFO - PID 29221 | RSS: Main: 178192384 04:16:54 INFO - PID 29221 | 04:16:54 INFO - PID 29221 | __start_tp_report 04:16:54 INFO - PID 29221 | _x_x_mozilla_page_load 04:16:54 INFO - PID 29221 | _x_x_mozilla_page_load_details 04:16:54 INFO - PID 29221 | |i|pagename|runs| 04:16:54 INFO - PID 29221 | |0;dojo.html;3154.5425913242593;3155.2427417419813;3165.2719874428876;3186.2193762528186;3205.358928214356;6164.383561643834;6202.968985155079;6306.400891915267;6337.36626337366;6356.110144579751;6118.908216376747;6205.720742566584;6233.252009758835;6244.250689917217;6245.125682404456;5668.234788303588;5706.115552089412;5740.569457290699;5751.079827227644;5806.332271788735;5716.228309178249;5733.340665823421;5740.081586946089;5762.82711518653;5802.332731735863;84.68502415271271;5739.856503587423;5807.332156801979;5831.241938548004;5852.882942341151;5647.519960803336;5683.488486036235;5685.829425117253;5778.0466223073145;5802;5658.490735833753;5667.773289068432;5738.7991420300505;5754.97122514389;5756.02147634903;6168.84577885552;6174.629522228681;6190.84522886927;6253.280872699653;6287.308396076473;6677.198736151693;6709.295523969961;6725.730970761164;6780.38976492118;6809.761658341984;6609.966950165266;6719.529632925697;6729.32706729328;6842.623655698934;6873.106496155518;6205.81382558524;6217;6234.750609975596;6236.594621349598;6254.718537665816;6844.28135045823;6893.103896493424;6924.861502769916;6931.376176144171;6932.410745086623;6636.502262330345;6657.966710166418;6690.397864192246;6692.096566963398;6696.59820410777;6739.191297044386;6745.12313399255;6811.318868113149;6828.2147553031045;6856.6228857413325;6494.740210391626;6629.668516574152;6649.933500665028;6659.300773418819;6715.4291885190305;6692.933070669328;6702.162229721285;6707.798766037026;6708.161479815023;6717.932820671828;5457.235986961749;5476.808311709071;5478.890422191534;5492.258545096361;5498.890022199534;4349.478062632505;4619.838305659286;4707.83522576715;4710.8351207707565;4712.59942904857;5800.564957628195;5858.677772722456;5897.67562784051;5908.586398952118;5908.615939963888;6600.73597056122;6755.054292399068;6814.931850681529;6837.213720422115;6848.794536163923;5744.712764361765;5750.338711048199;5791.0734282514595;5794.246747922743;5804.709764511757;5892.381299963442;5909.793157239476;5941.910871336933;5947.226860508193;5976.252968378953;6486.6756662167645;6493.610383377012;6496.545241833121;6512.674366281667;6573.474122070223;6724.092247546714;6745.9662701686175;6817.89773153413;6820.488463365267;6825.965870170816;6365.172527571386;6401.455876250385;6466.256380516301;6472.5145614080075;6563.9343606563325;6455.774047908489;6586.110875031809;6588;6588.176477940257;6605.933940660724;6765.9661701691175;6784.93215067843;6788.830279243059;6797.93202067973;6810.9318906810295;6261.373862613702;6542.411182993554;6561.507886908405;6568.80293591193;6642.103316052271;6551.5413921026975;6577.177852768404;6627.138471998609;6636.601803891782;6649.335066493505;6326.367363263636;6390.105385246162;6393.2967373587935;6398.712057957497;6459.257185423548;6488.837779055561;6489.253735820441;6541.149650545399;6541.378569035934;6569.441597464269;6302.023186406114;6417.807465776034;6430.903536446864;6484.837879053061;6485.15692959931 04:16:54 INFO - PID 29221 | |1;ext.html;804.2399932064199;858.5750053723406;889.5952341684534;891.48739474802;1170.2510393348252;29414.41171176575;41103;41808.581914180846;41853.58146418539;41915;42101;42437.57562424375;42590.57409425913;42593.36109958345;42625.360619590734;7089.89365159523;7292.307230813064;7579.734709285176;7602.125755538101;7605.125410577772;7472.663730132157;7590.1650818409935;7591.3926885849;7593.506422082547;7596.848063038736;7567.356774674159;7627.046619172604;7627.694892204305;7635.083789945186;7636.350910172642;7541.509801862889;7549.547027178387;7599.962000190019;7600.733974310872;7605.391568674493;7418.814529636802;7491.288327608923;7492;7502.512336698152;7507.512011719221;37278.44082338767;37447;37650.24699506022;37682.81158594217;37870.62129378726;3236.6277878044093;3270.117068391521;3271.4275001874817;3274.983625081883;3278.065751260903;29893;29906.85046574775;30016.69983300161;30066.24834379158;30224.24439389011;4723.244280915037;4898.951010489921;4909.705417674951;4914.066327397783;4941.382327209099;183894;184043;184563;185430;185700;47048.05903881903;47068.76465617718;47115.5288447118;47141.350052748676;47184.056318874114;49250.753746231756;49385.259221111715;49412.50587494079;49489.50510494849;49540;14505.782413263809;16195.433159839584;16550.255238514295;16582.419615313407;16622.58443538897;12178.634640960785;13546.390412431465;13753.79369309441;13772.380242889094;13777.242251676254;14219.928900355639;14288.357023933948;14295.28523573817;14299.499517517044;14413.063150895368;5706.743196556165;5771.134329850556;5877.823665290048;6040.879182416327;6082.361352058058;1000.2797985450464;1022.1618273016204;1032.1020711980625;1036.7511797168625;1047.7328281288376;23003.654945175836;23084.192053278053;23122.76877231206;23293.650595241084;23324.416889577897;1109.778044391125;1117.5082963496036;1125.178619607691;1126.2116518437126;1134.5178299222798;12344.444499997522;12429.689257768629;12430.440630171664;12448.190867593577;12454.003679705602;232936;233925;234607;234850;234916;50146.74926625416;50239.24641130386;50325.24512132321;50357.244641330406;50416.24375634368;1435.8205224346957;1462.4223431744401;1501.0393348257123;1501.69215310861;1502.706972140422;22826.201082962016;22831;22895.88552057229;23032.4241893954;23081.307560773203;36707.26585468222;36720;36725.265494689425;36742.8162859184;36836.81581592075;196717;196782;197155;197371;197852;32627.510587340734;34574.65425345815;35173.06548139877;35190.824045879606;35225.82387088048;45673.77163114296;46177.53822461867;46229.07541849077;46337.768311159576;46738.766306168254;33693.49459758154;33802.154946125556;33870.83064584661;34092.65907340895;34587.4811877817;33285.66714332825;33682.831585841916;33705.325893482484;33799.66200338063;34453.138671533416;35679.28641427105;35812;36059.81970090133;36451.27097458089;36495;32589;32660.34679306353;32703.34593308168;33103.172420689676;33296.50055249125;23317.53364932726;24413;24651.137210197558;25018.62472062957;25280.241592752245 04:16:54 INFO - PID 29221 | |2;jquery.html;572.8711040015997;584.8391692284619;585.2187329914567;593.6616128806583;597.4205021129504;22201.777982220192;22971.19600813972;22995.310140695805;23013.309600712004;23018.424539386524;26536.07123750669;28761.28096797581;28762.424751504957;28777.136685899404;28802.85598572004;6956.721731130761;7080.893786593205;7105.467089968247;7110.537815042032;7125.465590080738;6301.369863013708;6958.478114141434;6966.651667416634;6986.056882320872;7005.439564834826;6926.792196234121;6946.131733533309;6959.060526828889;6964.338387853146;6967.094277743886;6926.099607051051;6940.6529673516125;6958.965205173941;6960.965195174017;6966.930330696704;6827.214870289881;6827.419669328113;6830.043793868862;6837.213720422165;6842.965785171043;31547.684523154705;32105.197370065936;32983.83508082444;33305.83347083273;33349.833250833835;1974.1017836884182;2011.9295824646067;2012.6477866373325;2012.7785943546198;2018.2330714328607;20288.49278768028;20988.47528811792;21028.264010759704;21055.894720526452;21164.259250926298;2196.242296407737;2410.963835542468;2444.498877730061;2510.3724068982756;2586.883590238444;139281;142629;144965;145138;145182;21141.894290528755;21242.9197766323;21437.249696260555;22002;22614.321570352917;45332.773336133105;45573.31640025402;45707.542924571;45711.54288457139;45784.313235301495;12236.632901012983;12291.201071930296;12473.937630311972;12478.5008599655;12585.37073146339;9160.404573702688;10414.375137491776;10500.579976800842;10529.42088185157;10615.787684246272;9926.454045027593;11425.828612570818;11580.88419115798;11873.168878178618;11875.287482751062;3638.8362523686496;3743.981280093582;3934.449177115206;4046.5548789633117;4103.035786590149;965.9034096590285;973.095021629891;994.751312171957;996.1134590214715;997.0777031246213;20252.594948100956;20384.388468345678;20403.591928161353;20409.285675001305;21090.78909210919;1041.317936751429;1044.3159730376615;1052.5000624703205;1060.16247164739;1073.1951036722458;11255.943720281346;11500.94249528747;11555.480003399867;11629.651110466699;11694.590689325832;440036;458558;460638;463305;464336;116369;118184;119838;119881.40059299648;120071;1258.6916205529521;1274.2354587247762;1304.1914013311618;1304.6868751499571;1311.6589686681723;21599.46001349979;21660;21744.456388590414;21798.564028719655;22452.32643020712;57295.42704572901;58582;58689.70655146697;58755.706221468616;59740.402595973486;75470;75540;76218.23781762333;76415.707528772;77043;12356.25862448256;13826.65433364174;14443.277836108362;15009.024413413093;15151.242437877841;23588.52822943497;23900.641490378006;23921.16275930334;23995.760042399354;24135.396615084763;18824.623507529497;19186.808131918504;19203.711944321127;19288.22847086101;19313.4205973821;16964.83035169682;17533.123343833013;17685.292588296325;17807.821921780618;17836.46490605284;19190.8080919189;19706.21175152978;19799.901000494905;19800.20799168075;19858.90070549638;14963.850361496681;14985.325660345528;14989.40042398292;14998.925005374904;15012.099274043592;18547.81452185461;18611.534711632317;18742.344017959305;18794.436166915013;18803.623927521647 04:16:54 INFO - PID 29221 | |3;mootools.html;1361;1408.5563047639992;1418.5744276716985;1421.587739555529;1423.9145651260926;14078.859211407882;14626.634334141652;14831.555053348404;14838.851611483882;14852.108873467572;14757.18835464049;14884.330205140768;14907.776383354258;15010.849891501082;15025.173615451173;2676.491466621341;2730.5358089124898;2734.0840818325883;2734.3164208947765;2734.8359098454157;2577.4845030993783;2668.5063263296256;2699.5140874642557;2707.1337172104936;2708.255229811798;2573.6396904433395;2663.1211700139006;2677.6385187999663;2706;2712.755851973322;2622.3968487247944;2628.4480259145603;2642.8546429946346;2649.7615214630778;2661.441097369545;2616.5682662360687;2628.7239839816925;2633.697124830631;2644.286042768461;2645.2196602002455;14221.502247421395;14469.855301446956;14473.855261447461;14515.491957781427;14523.346449409803;7759.7672069838;8029.718959836436;8051.718189863385;8053;8058.476199047043;5084.822031228926;5141.228815677641;5240.240165176028;5298.284731561228;5330.413654498002;1862.962740745191;1908.1127275816812;1925.2202857842597;1934.642091213116;1957.119296316649;21730.13079476819;21780.89109554458;22551.774482255296;23450.765492345028;24374.26877193687;6394.680265986682;6561.442277406474;6608.339166083353;6748.966255168791;6806.965965170241;16518.6696266074;16724.49826505207;16740.16299185036;16745.83254167467;16759.2458339375;7658.885116723253;7916.406269529808;7925.762227133196;7928.643211055516;7930.0880398753725;7118.857622847618;7135.429165666734;7303.6348182590655;7342.192358840523;7349.154847192642;5015.4733752956145;5254.264402983586;5271.894562108736;5281.894362112813;5308.734563271821;1530.6402995296096;1534.8465153484785;1539.1765405508;1551.2166355990153;1587.6904003719164;869.4305230074311;888.7467071884482;901.4366021236727;903.1826197291462;903.1961554216621;8361.916380836114;8434.493930364199;8445.408821382443;8457.323414126855;8466.576671166416;968.3270127261486;980;982.1111893736038;986.329296078659;1002.6691191906654;4300.376445415397;5608.551315894719;5614.578906581941;5755.366909639936;5885.882282354329;19784.90107549453;20028.69956950647;20827.687584686242;20876.791232087788;20880.06039728216;20188.192472301238;20351.389458316273;20376.59246815085;20405.48986275355;20556.691649625267;10141.340812847142;10939.398333091598;10945.288556243819;10948.781024379468;11017.394043327533;8247.340212783083;8312.21034001769;8484;8580.742577722678;8725.869111963199;17431.30274789045;17501.912490437466;17647.117644118;17794.199261033027;18030.90984545069;17796.199171037595;18059.54851128732;18108.637827243645;18236.36172733948;18365.3572124975;11447.370394628375;11811.763764724828;11813.881861181279;11815.645530634094;11817.350045747566;12860.292683902475;12886.677833053873;13009;13096.214227146402;13100.737985240052;10716.142708583451;10783.784324313312;10804.783904322027;10987.285826421257;11087.556497740323;10125.746856328356;10148.746281343025;10161.339512931636;10170.237232207466;10309;9486.051394860458;9688.757781055248;9692.369995950241;9698.175655069399;9701.07839755222;6939.757108501179;6949.861002780017;6998.790036298919;7071;7085.6457177141965;7289.817754556178;7295.635218238961;7310;7345.816354590964;7356.742514012198 04:16:54 INFO - PID 29221 | |4;prototype.html;483.94109529480727;494.1179993711225;508.5092885365626;515.8426679862642;531.7075608415372;6177.598456100351;6305.864944310022;6333;6334.651594162319;6349.682515874199;6121.357257487955;6156.507479401648;6170.8148755537295;6174.289956654975;6200.844978875531;4997.675151115166;5003.39959204896;5017.397912250517;5029;5051.242313652963;4886.560209581137;4989.950100498985;4997;5002.799888004493;5019.949800501985;4954.876128096808;4961.355023846912;4961.70229786214;4972.378452693413;4973.278874563186;4948.7278199699;4958.776855041532;4979.925301120468;4992.750362481897;5016.849494515171;4492.16894874446;4501.392312037866;4506.053728716974;4517.344984977192;4518.3222516622445;6098.14625952367;6109.297430795426;6122.357152499013;6131.63210207389;6150.261968563801;5701.429857014306;5703.77184912603;5717.228174196472;5731.475142787156;5758.942410575883;6591.802245932629;6599.8020059398295;6603.669816509156;6612.93387066128;6619.867602647968;4881.975590122027;4926.285688575173;4932.80268789248;4940.925886111711;4946.431160416562;6949.305069493061;6990.231074581792;6995.615241161734;7030.437564994788;7034.2965703429245;4978.90042199154;4993.300937868701;4997.475265097112;4998.6750861193905;5000.099982003201;5064.366954130734;5079.187330027252;5089.720065396365;5114.181730923109;5135.717535535581;5683.204351390808;5690.630109042899;5726.627769194989;5735.913961290584;5750.281214848144;6354.093771868421;6621.668916554153;6631.867362652816;6661.2006559213205;6662.101301129155;1644.983550164507;1683.6127690631224;1695.1439523040785;1748.4492384898717;1758.1824451630052;1205.6925484001524;1212.3392750950752;1229.6864299603544;1243.6890777305673;1247.7442124364484;5692;5792.247007888947;5795.333536643256;5797.652140871477;5852.356240813507;6655.367740064686;6711.362420570038;6793.354631310018;6894.414284714544;6904.896426553606;5844.912326315109;5867.882642347215;5935.258092738408;5943;5948.464638182584;3582.7492075554983;3625.9093522662142;3629.709623230188;3647.835847386874;3653.178034942117;6591.340865913467;6592.868142637216;6642.3430627749285;6646.468282537386;6661.867482527982;6954.3045695430055;6992.440604751608;7050.5769653820935;7071.681774320168;7092.893606595905;6390.520710946605;6525.641089740015;6542.54202205841;6612.371824676648;6645.371883888478;6753.527253092237;6757.22291936414;6798.912174052128;6804.4896632753735;6836.38472537474;6737.157855268091;6775.254721980677;6787.083743694736;6822.965885170543;6823.66938446998;6552.4616706977695;6596.208454985433;6608.50436217276;6649.135612370555;6698.39714425704;4966.925496117633;4979.278004689228;4984.900301994012;5019.824306149268;5083.949160508348;6506.934930650822;6705.664716764045;6809;6882.380585747307;6905.93094069073;6202.131701561695;6426;6428.935710642833;6546.378094081055;6622.271550129578;6441.1626488556185;6453.290138084901;6518;6548.148740663683;6563.113979612882;6352.523560732871;6359.268684101387;6372.36276372359;6385.13800636908;6529.314421985623;6517.600619581669;6522;6534.497065674826;6623.735050598115;6646.83382915431;6301.527385446201;6366.745330186741;6423.678816059085;6441.194850643669;6456.289808121197 04:16:54 INFO - PID 29221 | |5;yui.html;920.7974245665953;925.6436272035264;935.1069728409369;938.1416004356015;952.8761261036062;18465.63068738626;19384.22463101476;19468.610627787435;19476.90261548694;22345.217917372895;21624.8918755406;22016.559668806614;22304.330870073925;22357.888210558925;22415;1031.1750599520371;1055.3298655353829;1059.062729484408;1059.6609085092773;1061.4374381577777;1014.3508154780947;1031.072035168347;1055.5566662001938;1058.0107599394553;1059.4226146750002;1102.6747109602647;1107.0811226681874;1111.2832223216062;1111.644273832374;1113.1373185781044;1084.902358787705;1093.20742461715;1094.6934858239706;1097.2593499387922;1100.6367898593444;806.1173015548025;809.2191035650567;809.6275713171948;809.817790997021;811.4319976016753;19417.22331106754;19730.30943916956;19768.60462790736;19888.403347899588;20638.690419643717;21783.891080544498;22021.00905459258;22279.108835646715;22302.442438938993;22445.102195912306;16761.245743941552;16828.411005614867;17320.39378621742;17324.39364622245;17619.735703964452;3749.15643980105;3752.212035472554;3754.3242216401036;3762.8711386583914;3762.887113386603;122810;123810.38094809468;124856;127643;128653;16121;16600.252988615543;16860.156992150343;16863.325466981183;16986.405475808533;30734.846325768227;31256.843715781277;31264.531032034538;31391;32141.678583214336;7682.846343073107;8090.1909809018625;8397.412181147383;9106.225970792424;9300.302477314093;4293.098449325614;4411.404460397869;4447.444069491314;4450.1767173073085;4453.3320001999955;5246.895062098737;5339.439358867341;5403.0544654686055;5403.108487099585;5415.268938693304;1030.8247597908373;1051.8527406163143;1057.8466122412208;1068.4123731947398;1072.2708558180357;665.1917919727457;727.5198369076384;729.5549714674045;731.378328420838;731.8463122744176;11701.414929253504;12248;12661.873381266254;12907.612771616867;13095.410706518229;711.5232794028013;716.3517017099533;720.4488566246825;722.6350692900052;728.035353157069;5829.650220986754;5919.319278283053;5942.6731529766275;6002.54980876436;6089.086637004485;115428;115847;116415;116622;118032;95894;98721.50639246902;98788;99680.50159749154;101792;83204.58397707973;85180;86077.13922860817;86228.13771862327;87199;10673.306235094695;10701.732456688334;10954.397508137128;11122.944385278022;11272.830907536558;40582;41019;41775.37336940009;42315.788421057696;43010.784946076325;51602.22596660978;53654.92690146253;53954;54221.18668220059;54638.45361546334;15720.449784257497;16250.756238656193;19683.21267149298;20351.491212719207;20478.488037799176;19826.206951722346;20130.29543965954;20158.596828063062;20465.38603841887;20488.975551222677;18716.344927927457;18765.812341876408;18831.24675013039;19245.711314330576;19643.31248406299;20177.192912283343;20278.695819562425;20362.694559581916;20375.184992600723;20391.59216815685;19556.413307600797;19677.409677709693;19749.30877419341;19890.70163947513;20484.590308194052;14570.5628831131;14609.853901461274;14672.926635366755;14766.187859667392;15382.923085384502;14883.181425021294;15094.24528773535;15133.470328538448;15173.393064277305;15307.923460382626 04:16:54 INFO - PID 29221 | __end_tp_report 04:16:54 INFO - PID 29221 | __start_cc_report 04:16:54 INFO - PID 29221 | _x_x_mozilla_cycle_collect,405 04:16:54 INFO - PID 29221 | __end_cc_report 04:16:54 INFO - PID 29221 | __startTimestamp1502450214934__endTimestamp 04:16:54 INFO - PID 29221 | 04:16:54 INFO - PID 29221 | ------- Summary: start ------- 04:16:54 INFO - PID 29221 | Number of tests: 6 04:16:54 INFO - PID 29221 | 04:16:54 INFO - PID 29221 | [#0] dojo.html Cycles:165 Average:6149.21 Median:6417.81 stddev:871.99 (13.6%) stddev-sans-first:842.42 04:16:54 INFO - PID 29221 | Values: 3154.5 3155.2 3165.3 3186.2 3205.4 6164.4 6203.0 6306.4 6337.4 6356.1 6118.9 6205.7 6233.3 6244.3 6245.1 5668.2 5706.1 5740.6 5751.1 5806.3 5716.2 5733.3 5740.1 5762.8 5802.3 84.7 5739.9 5807.3 5831.2 5852.9 5647.5 5683.5 5685.8 5778.0 5802.0 5658.5 5667.8 5738.8 5755.0 5756.0 6168.8 6174.6 6190.8 6253.3 6287.3 6677.2 6709.3 6725.7 6780.4 6809.8 6610.0 6719.5 6729.3 6842.6 6873.1 6205.8 6217.0 6234.8 6236.6 6254.7 6844.3 6893.1 6924.9 6931.4 6932.4 6636.5 6658.0 6690.4 6692.1 6696.6 6739.2 6745.1 6811.3 6828.2 6856.6 6494.7 6629.7 6649.9 6659.3 6715.4 6692.9 6702.2 6707.8 6708.2 6717.9 5457.2 5476.8 5478.9 5492.3 5498.9 4349.5 4619.8 4707.8 4710.8 4712.6 5800.6 5858.7 5897.7 5908.6 5908.6 6600.7 6755.1 6814.9 6837.2 6848.8 5744.7 5750.3 5791.1 5794.2 5804.7 5892.4 5909.8 5941.9 5947.2 5976.3 6486.7 6493.6 6496.5 6512.7 6573.5 6724.1 6746.0 6817.9 6820.5 6826.0 6365.2 6401.5 6466.3 6472.5 6563.9 6455.8 6586.1 6588.0 6588.2 6605.9 6766.0 6784.9 6788.8 6797.9 6810.9 6261.4 6542.4 6561.5 6568.8 6642.1 6551.5 6577.2 6627.1 6636.6 6649.3 6326.4 6390.1 6393.3 6398.7 6459.3 6488.8 6489.3 6541.1 6541.4 6569.4 6302.0 6417.8 6430.9 6484.8 6485.2 04:16:54 INFO - PID 29221 | 04:16:54 INFO - PID 29221 | [#1] ext.html Cycles:180 Average:37491.73 Median:34272.90 stddev:53464.00 (156.0%) stddev-sans-first:53543.01 04:16:54 INFO - PID 29221 | Values: 804.2 858.6 889.6 891.5 1170.3 29414.4 41103.0 41808.6 41853.6 41915.0 42101.0 42437.6 42590.6 42593.4 42625.4 7089.9 7292.3 7579.7 7602.1 7605.1 7472.7 7590.2 7591.4 7593.5 7596.8 7567.4 7627.0 7627.7 7635.1 7636.4 7541.5 7549.5 7600.0 7600.7 7605.4 7418.8 7491.3 7492.0 7502.5 7507.5 37278.4 37447.0 37650.2 37682.8 37870.6 3236.6 3270.1 3271.4 3275.0 3278.1 29893.0 29906.9 30016.7 30066.2 30224.2 4723.2 4899.0 4909.7 4914.1 4941.4 183894.0 184043.0 184563.0 185430.0 185700.0 47048.1 47068.8 47115.5 47141.4 47184.1 49250.8 49385.3 49412.5 49489.5 49540.0 14505.8 16195.4 16550.3 16582.4 16622.6 12178.6 13546.4 13753.8 13772.4 13777.2 14219.9 14288.4 14295.3 14299.5 14413.1 5706.7 5771.1 5877.8 6040.9 6082.4 1000.3 1022.2 1032.1 1036.8 1047.7 23003.7 23084.2 23122.8 23293.7 23324.4 1109.8 1117.5 1125.2 1126.2 1134.5 12344.4 12429.7 12430.4 12448.2 12454.0 232936.0 233925.0 234607.0 234850.0 234916.0 50146.7 50239.2 50325.2 50357.2 50416.2 1435.8 1462.4 1501.0 1501.7 1502.7 22826.2 22831.0 22895.9 23032.4 23081.3 36707.3 36720.0 36725.3 36742.8 36836.8 196717.0 196782.0 197155.0 197371.0 197852.0 32627.5 34574.7 35173.1 35190.8 35225.8 45673.8 46177.5 46229.1 46337.8 46738.8 33693.5 33802.2 33870.8 34092.7 34587.5 33285.7 33682.8 33705.3 33799.7 34453.1 35679.3 35812.0 36059.8 36451.3 36495.0 32589.0 32660.3 32703.3 33103.2 33296.5 23317.5 24413.0 24651.1 25018.6 25280.2 04:16:54 INFO - PID 29221 | 04:16:54 INFO - PID 29221 | [#2] jquery.html Cycles:180 Average:35816.97 Median:12099.12 stddev:77768.07 (642.8%) stddev-sans-first:77941.21 04:16:54 INFO - PID 29221 | Values: 572.9 584.8 585.2 593.7 597.4 22201.8 22971.2 22995.3 23013.3 23018.4 26536.1 28761.3 28762.4 28777.1 28802.9 6956.7 7080.9 7105.5 7110.5 7125.5 6301.4 6958.5 6966.7 6986.1 7005.4 6926.8 6946.1 6959.1 6964.3 6967.1 6926.1 6940.7 6959.0 6961.0 6966.9 6827.2 6827.4 6830.0 6837.2 6843.0 31547.7 32105.2 32983.8 33305.8 33349.8 1974.1 2011.9 2012.6 2012.8 2018.2 20288.5 20988.5 21028.3 21055.9 21164.3 2196.2 2411.0 2444.5 2510.4 2586.9 139281.0 142629.0 144965.0 145138.0 145182.0 21141.9 21242.9 21437.2 22002.0 22614.3 45332.8 45573.3 45707.5 45711.5 45784.3 12236.6 12291.2 12473.9 12478.5 12585.4 9160.4 10414.4 10500.6 10529.4 10615.8 9926.5 11425.8 11580.9 11873.2 11875.3 3638.8 3744.0 3934.4 4046.6 4103.0 965.9 973.1 994.8 996.1 997.1 20252.6 20384.4 20403.6 20409.3 21090.8 1041.3 1044.3 1052.5 1060.2 1073.2 11255.9 11500.9 11555.5 11629.7 11694.6 440036.0 458558.0 460638.0 463305.0 464336.0 116369.0 118184.0 119838.0 119881.4 120071.0 1258.7 1274.2 1304.2 1304.7 1311.7 21599.5 21660.0 21744.5 21798.6 22452.3 57295.4 58582.0 58689.7 58755.7 59740.4 75470.0 75540.0 76218.2 76415.7 77043.0 12356.3 13826.7 14443.3 15009.0 15151.2 23588.5 23900.6 23921.2 23995.8 24135.4 18824.6 19186.8 19203.7 19288.2 19313.4 16964.8 17533.1 17685.3 17807.8 17836.5 19190.8 19706.2 19799.9 19800.2 19858.9 14963.9 14985.3 14989.4 14998.9 15012.1 18547.8 18611.5 18742.3 18794.4 18803.6 04:16:54 INFO - PID 29221 | 04:16:54 INFO - PID 29221 | [#3] mootools.html Cycles:180 Average:8980.64 Median:2628.59 stddev:6147.07 (233.9%) stddev-sans-first:6137.65 04:16:54 INFO - PID 29221 | Values: 1361.0 1408.6 1418.6 1421.6 1423.9 14078.9 14626.6 14831.6 14838.9 14852.1 14757.2 14884.3 14907.8 15010.8 15025.2 2676.5 2730.5 2734.1 2734.3 2734.8 2577.5 2668.5 2699.5 2707.1 2708.3 2573.6 2663.1 2677.6 2706.0 2712.8 2622.4 2628.4 2642.9 2649.8 2661.4 2616.6 2628.7 2633.7 2644.3 2645.2 14221.5 14469.9 14473.9 14515.5 14523.3 7759.8 8029.7 8051.7 8053.0 8058.5 5084.8 5141.2 5240.2 5298.3 5330.4 1863.0 1908.1 1925.2 1934.6 1957.1 21730.1 21780.9 22551.8 23450.8 24374.3 6394.7 6561.4 6608.3 6749.0 6807.0 16518.7 16724.5 16740.2 16745.8 16759.2 7658.9 7916.4 7925.8 7928.6 7930.1 7118.9 7135.4 7303.6 7342.2 7349.2 5015.5 5254.3 5271.9 5281.9 5308.7 1530.6 1534.8 1539.2 1551.2 1587.7 869.4 888.7 901.4 903.2 903.2 8361.9 8434.5 8445.4 8457.3 8466.6 968.3 980.0 982.1 986.3 1002.7 4300.4 5608.6 5614.6 5755.4 5885.9 19784.9 20028.7 20827.7 20876.8 20880.1 20188.2 20351.4 20376.6 20405.5 20556.7 10141.3 10939.4 10945.3 10948.8 11017.4 8247.3 8312.2 8484.0 8580.7 8725.9 17431.3 17501.9 17647.1 17794.2 18030.9 17796.2 18059.5 18108.6 18236.4 18365.4 11447.4 11811.8 11813.9 11815.6 11817.4 12860.3 12886.7 13009.0 13096.2 13100.7 10716.1 10783.8 10804.8 10987.3 11087.6 10125.7 10148.7 10161.3 10170.2 10309.0 9486.1 9688.8 9692.4 9698.2 9701.1 6939.8 6949.9 6998.8 7071.0 7085.6 7289.8 7295.6 7310.0 7345.8 7356.7 04:16:54 INFO - PID 29221 | 04:16:54 INFO - PID 29221 | [#4] prototype.html Cycles:180 Average:5547.99 Median:6153.38 stddev:1566.32 (25.5%) stddev-sans-first:1523.89 04:16:54 INFO - PID 29221 | Values: 483.9 494.1 508.5 515.8 531.7 6177.6 6305.9 6333.0 6334.7 6349.7 6121.4 6156.5 6170.8 6174.3 6200.8 4997.7 5003.4 5017.4 5029.0 5051.2 4886.6 4990.0 4997.0 5002.8 5019.9 4954.9 4961.4 4961.7 4972.4 4973.3 4948.7 4958.8 4979.9 4992.8 5016.8 4492.2 4501.4 4506.1 4517.3 4518.3 6098.1 6109.3 6122.4 6131.6 6150.3 5701.4 5703.8 5717.2 5731.5 5758.9 6591.8 6599.8 6603.7 6612.9 6619.9 4882.0 4926.3 4932.8 4940.9 4946.4 6949.3 6990.2 6995.6 7030.4 7034.3 4978.9 4993.3 4997.5 4998.7 5000.1 5064.4 5079.2 5089.7 5114.2 5135.7 5683.2 5690.6 5726.6 5735.9 5750.3 6354.1 6621.7 6631.9 6661.2 6662.1 1645.0 1683.6 1695.1 1748.4 1758.2 1205.7 1212.3 1229.7 1243.7 1247.7 5692.0 5792.2 5795.3 5797.7 5852.4 6655.4 6711.4 6793.4 6894.4 6904.9 5844.9 5867.9 5935.3 5943.0 5948.5 3582.7 3625.9 3629.7 3647.8 3653.2 6591.3 6592.9 6642.3 6646.5 6661.9 6954.3 6992.4 7050.6 7071.7 7092.9 6390.5 6525.6 6542.5 6612.4 6645.4 6753.5 6757.2 6798.9 6804.5 6836.4 6737.2 6775.3 6787.1 6823.0 6823.7 6552.5 6596.2 6608.5 6649.1 6698.4 4966.9 4979.3 4984.9 5019.8 5083.9 6506.9 6705.7 6809.0 6882.4 6905.9 6202.1 6426.0 6428.9 6546.4 6622.3 6441.2 6453.3 6518.0 6548.1 6563.1 6352.5 6359.3 6372.4 6385.1 6529.3 6517.6 6522.0 6534.5 6623.7 6646.8 6301.5 6366.7 6423.7 6441.2 6456.3 04:16:54 INFO - PID 29221 | 04:16:54 INFO - PID 29221 | [#5] yui.html Cycles:180 Average:23862.16 Median:20315.09 stddev:32034.60 (157.7%) stddev-sans-first:32078.15 04:16:54 INFO - PID 29221 | Values: 920.8 925.6 935.1 938.1 952.9 18465.6 19384.2 19468.6 19476.9 22345.2 21624.9 22016.6 22304.3 22357.9 22415.0 1031.2 1055.3 1059.1 1059.7 1061.4 1014.4 1031.1 1055.6 1058.0 1059.4 1102.7 1107.1 1111.3 1111.6 1113.1 1084.9 1093.2 1094.7 1097.3 1100.6 806.1 809.2 809.6 809.8 811.4 19417.2 19730.3 19768.6 19888.4 20638.7 21783.9 22021.0 22279.1 22302.4 22445.1 16761.2 16828.4 17320.4 17324.4 17619.7 3749.2 3752.2 3754.3 3762.9 3762.9 122810.0 123810.4 124856.0 127643.0 128653.0 16121.0 16600.3 16860.2 16863.3 16986.4 30734.8 31256.8 31264.5 31391.0 32141.7 7682.8 8090.2 8397.4 9106.2 9300.3 4293.1 4411.4 4447.4 4450.2 4453.3 5246.9 5339.4 5403.1 5403.1 5415.3 1030.8 1051.9 1057.8 1068.4 1072.3 665.2 727.5 729.6 731.4 731.8 11701.4 12248.0 12661.9 12907.6 13095.4 711.5 716.4 720.4 722.6 728.0 5829.7 5919.3 5942.7 6002.5 6089.1 115428.0 115847.0 116415.0 116622.0 118032.0 95894.0 98721.5 98788.0 99680.5 101792.0 83204.6 85180.0 86077.1 86228.1 87199.0 10673.3 10701.7 10954.4 11122.9 11272.8 40582.0 41019.0 41775.4 42315.8 43010.8 51602.2 53654.9 53954.0 54221.2 54638.5 15720.4 16250.8 19683.2 20351.5 20478.5 19826.2 20130.3 20158.6 20465.4 20489.0 18716.3 18765.8 18831.2 19245.7 19643.3 20177.2 20278.7 20362.7 20375.2 20391.6 19556.4 19677.4 19749.3 19890.7 20484.6 14570.6 14609.9 14672.9 14766.2 15382.9 14883.2 15094.2 15133.5 15173.4 15307.9 04:16:54 INFO - PID 29221 | -------- Summary: end -------- 04:16:54 INFO - PID 29221 | 04:16:55 INFO - TEST-INFO | 29221: exit 0 04:16:55 INFO - TEST-OK | dromaeo_css | took 1111575ms 04:16:55 INFO - TEST-START | kraken 04:16:55 INFO - Initialising browser for kraken test... 04:16:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45021/getInfo.html -profile /tmp/tmpJUPuU5/profile 04:16:55 INFO - TEST-INFO | started process 29602 (/builds/slave/test/build/application/firefox/firefox http://localhost:45021/getInfo.html) 04:17:01 INFO - TEST-INFO | 29602: exit 0 04:17:01 INFO - Browser initialized. 04:17:01 INFO - Running cycle 1/1 for kraken test... 04:17:01 INFO - TEST-INFO | started process 29839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJUPuU5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:02 INFO - PID 29839 | 04:17:02 INFO - PID 29839 | (/builds/slave/test/build/application/firefox/firefox:29894): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:17:02 INFO - PID 29839 | 04:17:12 INFO - PID 29839 | RSS: Main: 168325120 04:17:12 INFO - PID 29839 | 04:17:15 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45021/tests/kraken/driver.html?testName=audio-beat-detection) 04:17:16 INFO - PID 29839 | RSS: Main: 174505984 04:17:16 INFO - PID 29839 | 04:17:19 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45021/tests/kraken/driver.html?testName=audio-dft) 04:17:19 INFO - PID 29839 | RSS: Main: 178466816 04:17:19 INFO - PID 29839 | 04:17:22 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45021/tests/kraken/driver.html?testName=audio-fft) 04:17:23 INFO - PID 29839 | RSS: Main: 172830720 04:17:23 INFO - PID 29839 | 04:17:25 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45021/tests/kraken/driver.html?testName=audio-oscillator) 04:17:26 INFO - PID 29839 | RSS: Main: 172969984 04:17:26 INFO - PID 29839 | 04:17:28 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45021/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:17:29 INFO - PID 29839 | RSS: Main: 172691456 04:17:29 INFO - PID 29839 | 04:17:32 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45021/tests/kraken/driver.html?testName=imaging-darkroom) 04:17:33 INFO - PID 29839 | RSS: Main: 173441024 04:17:33 INFO - PID 29839 | 04:17:36 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45021/tests/kraken/driver.html?testName=imaging-desaturate) 04:17:37 INFO - PID 29839 | RSS: Main: 173314048 04:17:37 INFO - PID 29839 | 04:17:40 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45021/tests/kraken/driver.html?testName=json-parse-financial) 04:17:40 INFO - PID 29839 | RSS: Main: 174260224 04:17:40 INFO - PID 29839 | 04:17:42 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45021/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:17:43 INFO - PID 29839 | RSS: Main: 174125056 04:17:43 INFO - PID 29839 | 04:17:44 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45021/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:17:45 INFO - PID 29839 | RSS: Main: 173993984 04:17:45 INFO - PID 29839 | 04:17:47 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45021/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:17:48 INFO - PID 29839 | RSS: Main: 174022656 04:17:48 INFO - PID 29839 | 04:17:51 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45021/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:17:51 INFO - PID 29839 | RSS: Main: 174383104 04:17:51 INFO - PID 29839 | 04:17:54 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45021/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:17:55 INFO - PID 29839 | RSS: Main: 174510080 04:17:55 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | Cycle 1(1): loaded http://localhost:45021/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45021/tests/kraken/driver.html?testName=ai-astar) 04:17:57 INFO - PID 29839 | RSS: Main: 176443392 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | __start_tp_report 04:17:57 INFO - PID 29839 | _x_x_mozilla_page_load 04:17:57 INFO - PID 29839 | _x_x_mozilla_page_load_details 04:17:57 INFO - PID 29839 | |i|pagename|runs| 04:17:57 INFO - PID 29839 | |0;ai-astar;99;110;100;109;116;114;109;109;110;112 04:17:57 INFO - PID 29839 | |1;audio-beat-detection;156;122;142;171;126;148;141;117;172;125 04:17:57 INFO - PID 29839 | |2;audio-dft;164;162;163;162;164;169;165;168;162;165 04:17:57 INFO - PID 29839 | |3;audio-fft;74;76;73;165;79;78;74;92;99;74 04:17:57 INFO - PID 29839 | |4;audio-oscillator;79;78;134;79;80;78;140;80;79;138 04:17:57 INFO - PID 29839 | |5;imaging-gaussian-blur;115;114;114;114;114;116;113;115;118;115 04:17:57 INFO - PID 29839 | |6;imaging-darkroom;150;152;157;152;154;151;150;150;149;154 04:17:57 INFO - PID 29839 | |7;imaging-desaturate;94;103;99;106;98;99;94;94;94;94 04:17:57 INFO - PID 29839 | |8;json-parse-financial;54;54;53;53;55;53;53;54;54;58 04:17:57 INFO - PID 29839 | |9;json-stringify-tinderbox;56;55;59;61;59;60;56;55;54;55 04:17:57 INFO - PID 29839 | |10;stanford-crypto-aes;86;89;80;78;78;92;88;78;82;77 04:17:57 INFO - PID 29839 | |11;stanford-crypto-ccm;136;135;121;131;142;128;123;122;126;163 04:17:57 INFO - PID 29839 | |12;stanford-crypto-pbkdf2;180;177;175;173;173;181;187;173;177;172 04:17:57 INFO - PID 29839 | |13;stanford-crypto-sha256-iterative;70;69;70;68;67;66;67;65;65;70 04:17:57 INFO - PID 29839 | __end_tp_report 04:17:57 INFO - PID 29839 | __start_cc_report 04:17:57 INFO - PID 29839 | _x_x_mozilla_cycle_collect,1004 04:17:57 INFO - PID 29839 | __end_cc_report 04:17:57 INFO - PID 29839 | __startTimestamp1502450277716__endTimestamp 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | ------- Summary: start ------- 04:17:57 INFO - PID 29839 | Number of tests: 14 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:5.43 (4.9%) stddev-sans-first:4.46 04:17:57 INFO - PID 29839 | Values: 99.0 110.0 100.0 109.0 116.0 114.0 109.0 109.0 110.0 112.0 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:145.00 stddev:19.84 (13.7%) stddev-sans-first:20.39 04:17:57 INFO - PID 29839 | Values: 156.0 122.0 142.0 171.0 126.0 148.0 141.0 117.0 172.0 125.0 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:2.46 (1.5%) stddev-sans-first:2.60 04:17:57 INFO - PID 29839 | Values: 164.0 162.0 163.0 162.0 164.0 169.0 165.0 168.0 162.0 165.0 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#3] audio-fft Cycles:10 Average:88.40 Median:77.00 stddev:28.29 (36.7%) stddev-sans-first:29.52 04:17:57 INFO - PID 29839 | Values: 74.0 76.0 73.0 165.0 79.0 78.0 74.0 92.0 99.0 74.0 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:79.00 stddev:28.22 (35.7%) stddev-sans-first:29.22 04:17:57 INFO - PID 29839 | Values: 79.0 78.0 134.0 79.0 80.0 78.0 140.0 80.0 79.0 138.0 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:1.40 (1.2%) stddev-sans-first:1.48 04:17:57 INFO - PID 29839 | Values: 115.0 114.0 114.0 114.0 114.0 116.0 113.0 115.0 118.0 115.0 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:152.00 stddev:2.47 (1.6%) stddev-sans-first:2.52 04:17:57 INFO - PID 29839 | Values: 150.0 152.0 157.0 152.0 154.0 151.0 150.0 150.0 149.0 154.0 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:94.00 stddev:4.33 (4.6%) stddev-sans-first:4.40 04:17:57 INFO - PID 29839 | Values: 94.0 103.0 99.0 106.0 98.0 99.0 94.0 94.0 94.0 94.0 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.52 (2.8%) stddev-sans-first:1.62 04:17:57 INFO - PID 29839 | Values: 54.0 54.0 53.0 53.0 55.0 53.0 53.0 54.0 54.0 58.0 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.50 stddev:2.49 (4.3%) stddev-sans-first:2.62 04:17:57 INFO - PID 29839 | Values: 56.0 55.0 59.0 61.0 59.0 60.0 56.0 55.0 54.0 55.0 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:84.00 stddev:5.49 (6.5%) stddev-sans-first:5.70 04:17:57 INFO - PID 29839 | Values: 86.0 89.0 80.0 78.0 78.0 92.0 88.0 78.0 82.0 77.0 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:133.00 stddev:12.63 (9.5%) stddev-sans-first:13.34 04:17:57 INFO - PID 29839 | Values: 136.0 135.0 121.0 131.0 142.0 128.0 123.0 122.0 126.0 163.0 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:177.00 stddev:4.73 (2.7%) stddev-sans-first:4.88 04:17:57 INFO - PID 29839 | Values: 180.0 177.0 175.0 173.0 173.0 181.0 187.0 173.0 177.0 172.0 04:17:57 INFO - PID 29839 | 04:17:57 INFO - PID 29839 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.50 stddev:2.00 (2.9%) stddev-sans-first:1.94 04:17:57 INFO - PID 29839 | Values: 70.0 69.0 70.0 68.0 67.0 66.0 67.0 65.0 65.0 70.0 04:17:57 INFO - PID 29839 | -------- Summary: end -------- 04:17:57 INFO - PID 29839 | 04:17:58 INFO - PID 29839 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:17:58 INFO - TEST-INFO | 29839: exit 0 04:17:58 INFO - TEST-OK | kraken | took 62784ms 04:17:58 INFO - SUITE-END | took 1174s 04:17:58 INFO - Completed test suite (00:19:34) 04:17:58 INFO - javascript benchmark 04:17:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8679.682508068816, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3154.5425913242593, 3155.2427417419813, 3165.2719874428876, 3186.2193762528186, 3205.358928214356, 6164.383561643834, 6202.968985155079, 6306.400891915267, 6337.36626337366, 6356.110144579751, 6118.908216376747, 6205.720742566584, 6233.252009758835, 6244.250689917217, 6245.125682404456, 5668.234788303588, 5706.115552089412, 5740.569457290699, 5751.079827227644, 5806.332271788735, 5716.228309178249, 5733.340665823421, 5740.081586946089, 5762.82711518653, 5802.332731735863, 84.68502415271271, 5739.856503587423, 5807.332156801979, 5831.241938548004, 5852.882942341151, 5647.519960803336, 5683.488486036235, 5685.829425117253, 5778.0466223073145, 5802.0, 5658.490735833753, 5667.773289068432, 5738.7991420300505, 5754.97122514389, 5756.02147634903, 6168.84577885552, 6174.629522228681, 6190.84522886927, 6253.280872699653, 6287.308396076473, 6677.198736151693, 6709.295523969961, 6725.730970761164, 6780.38976492118, 6809.761658341984, 6609.966950165266, 6719.529632925697, 6729.32706729328, 6842.623655698934, 6873.106496155518, 6205.81382558524, 6217.0, 6234.750609975596, 6236.594621349598, 6254.718537665816, 6844.28135045823, 6893.103896493424, 6924.861502769916, 6931.376176144171, 6932.410745086623, 6636.502262330345, 6657.966710166418, 6690.397864192246, 6692.096566963398, 6696.59820410777, 6739.191297044386, 6745.12313399255, 6811.318868113149, 6828.2147553031045, 6856.6228857413325, 6494.740210391626, 6629.668516574152, 6649.933500665028, 6659.300773418819, 6715.4291885190305, 6692.933070669328, 6702.162229721285, 6707.798766037026, 6708.161479815023, 6717.932820671828, 5457.235986961749, 5476.808311709071, 5478.890422191534, 5492.258545096361, 5498.890022199534, 4349.478062632505, 4619.838305659286, 4707.83522576715, 4710.8351207707565, 4712.59942904857, 5800.564957628195, 5858.677772722456, 5897.67562784051, 5908.586398952118, 5908.615939963888, 6600.73597056122, 6755.054292399068, 6814.931850681529, 6837.213720422115, 6848.794536163923, 5744.712764361765, 5750.338711048199, 5791.0734282514595, 5794.246747922743, 5804.709764511757, 5892.381299963442, 5909.793157239476, 5941.910871336933, 5947.226860508193, 5976.252968378953, 6486.6756662167645, 6493.610383377012, 6496.545241833121, 6512.674366281667, 6573.474122070223, 6724.092247546714, 6745.9662701686175, 6817.89773153413, 6820.488463365267, 6825.965870170816, 6365.172527571386, 6401.455876250385, 6466.256380516301, 6472.5145614080075, 6563.9343606563325, 6455.774047908489, 6586.110875031809, 6588.0, 6588.176477940257, 6605.933940660724, 6765.9661701691175, 6784.93215067843, 6788.830279243059, 6797.93202067973, 6810.9318906810295, 6261.373862613702, 6542.411182993554, 6561.507886908405, 6568.80293591193, 6642.103316052271, 6551.5413921026975, 6577.177852768404, 6627.138471998609, 6636.601803891782, 6649.335066493505, 6326.367363263636, 6390.105385246162, 6393.2967373587935, 6398.712057957497, 6459.257185423548, 6488.837779055561, 6489.253735820441, 6541.149650545399, 6541.378569035934, 6569.441597464269, 6302.023186406114, 6417.807465776034, 6430.903536446864, 6484.837879053061, 6485.15692959931], "value": 6088.218287679956, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.2399932064199, 858.5750053723406, 889.5952341684534, 891.48739474802, 1170.2510393348252, 29414.41171176575, 41103.0, 41808.581914180846, 41853.58146418539, 41915.0, 42101.0, 42437.57562424375, 42590.57409425913, 42593.36109958345, 42625.360619590734, 7089.89365159523, 7292.307230813064, 7579.734709285176, 7602.125755538101, 7605.125410577772, 7472.663730132157, 7590.1650818409935, 7591.3926885849, 7593.506422082547, 7596.848063038736, 7567.356774674159, 7627.046619172604, 7627.694892204305, 7635.083789945186, 7636.350910172642, 7541.509801862889, 7549.547027178387, 7599.962000190019, 7600.733974310872, 7605.391568674493, 7418.814529636802, 7491.288327608923, 7492.0, 7502.512336698152, 7507.512011719221, 37278.44082338767, 37447.0, 37650.24699506022, 37682.81158594217, 37870.62129378726, 3236.6277878044093, 3270.117068391521, 3271.4275001874817, 3274.983625081883, 3278.065751260903, 29893.0, 29906.85046574775, 30016.69983300161, 30066.24834379158, 30224.24439389011, 4723.244280915037, 4898.951010489921, 4909.705417674951, 4914.066327397783, 4941.382327209099, 183894.0, 184043.0, 184563.0, 185430.0, 185700.0, 47048.05903881903, 47068.76465617718, 47115.5288447118, 47141.350052748676, 47184.056318874114, 49250.753746231756, 49385.259221111715, 49412.50587494079, 49489.50510494849, 49540.0, 14505.782413263809, 16195.433159839584, 16550.255238514295, 16582.419615313407, 16622.58443538897, 12178.634640960785, 13546.390412431465, 13753.79369309441, 13772.380242889094, 13777.242251676254, 14219.928900355639, 14288.357023933948, 14295.28523573817, 14299.499517517044, 14413.063150895368, 5706.743196556165, 5771.134329850556, 5877.823665290048, 6040.879182416327, 6082.361352058058, 1000.2797985450464, 1022.1618273016204, 1032.1020711980625, 1036.7511797168625, 1047.7328281288376, 23003.654945175836, 23084.192053278053, 23122.76877231206, 23293.650595241084, 23324.416889577897, 1109.778044391125, 1117.5082963496036, 1125.178619607691, 1126.2116518437126, 1134.5178299222798, 12344.444499997522, 12429.689257768629, 12430.440630171664, 12448.190867593577, 12454.003679705602, 232936.0, 233925.0, 234607.0, 234850.0, 234916.0, 50146.74926625416, 50239.24641130386, 50325.24512132321, 50357.244641330406, 50416.24375634368, 1435.8205224346957, 1462.4223431744401, 1501.0393348257123, 1501.69215310861, 1502.706972140422, 22826.201082962016, 22831.0, 22895.88552057229, 23032.4241893954, 23081.307560773203, 36707.26585468222, 36720.0, 36725.265494689425, 36742.8162859184, 36836.81581592075, 196717.0, 196782.0, 197155.0, 197371.0, 197852.0, 32627.510587340734, 34574.65425345815, 35173.06548139877, 35190.824045879606, 35225.82387088048, 45673.77163114296, 46177.53822461867, 46229.07541849077, 46337.768311159576, 46738.766306168254, 33693.49459758154, 33802.154946125556, 33870.83064584661, 34092.65907340895, 34587.4811877817, 33285.66714332825, 33682.831585841916, 33705.325893482484, 33799.66200338063, 34453.138671533416, 35679.28641427105, 35812.0, 36059.81970090133, 36451.27097458089, 36495.0, 32589.0, 32660.34679306353, 32703.34593308168, 33103.172420689676, 33296.50055249125, 23317.53364932726, 24413.0, 24651.137210197558, 25018.62472062957, 25280.241592752245], "value": 17149.978928250162, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.8711040015997, 584.8391692284619, 585.2187329914567, 593.6616128806583, 597.4205021129504, 22201.777982220192, 22971.19600813972, 22995.310140695805, 23013.309600712004, 23018.424539386524, 26536.07123750669, 28761.28096797581, 28762.424751504957, 28777.136685899404, 28802.85598572004, 6956.721731130761, 7080.893786593205, 7105.467089968247, 7110.537815042032, 7125.465590080738, 6301.369863013708, 6958.478114141434, 6966.651667416634, 6986.056882320872, 7005.439564834826, 6926.792196234121, 6946.131733533309, 6959.060526828889, 6964.338387853146, 6967.094277743886, 6926.099607051051, 6940.6529673516125, 6958.965205173941, 6960.965195174017, 6966.930330696704, 6827.214870289881, 6827.419669328113, 6830.043793868862, 6837.213720422165, 6842.965785171043, 31547.684523154705, 32105.197370065936, 32983.83508082444, 33305.83347083273, 33349.833250833835, 1974.1017836884182, 2011.9295824646067, 2012.6477866373325, 2012.7785943546198, 2018.2330714328607, 20288.49278768028, 20988.47528811792, 21028.264010759704, 21055.894720526452, 21164.259250926298, 2196.242296407737, 2410.963835542468, 2444.498877730061, 2510.3724068982756, 2586.883590238444, 139281.0, 142629.0, 144965.0, 145138.0, 145182.0, 21141.894290528755, 21242.9197766323, 21437.249696260555, 22002.0, 22614.321570352917, 45332.773336133105, 45573.31640025402, 45707.542924571, 45711.54288457139, 45784.313235301495, 12236.632901012983, 12291.201071930296, 12473.937630311972, 12478.5008599655, 12585.37073146339, 9160.404573702688, 10414.375137491776, 10500.579976800842, 10529.42088185157, 10615.787684246272, 9926.454045027593, 11425.828612570818, 11580.88419115798, 11873.168878178618, 11875.287482751062, 3638.8362523686496, 3743.981280093582, 3934.449177115206, 4046.5548789633117, 4103.035786590149, 965.9034096590285, 973.095021629891, 994.751312171957, 996.1134590214715, 997.0777031246213, 20252.594948100956, 20384.388468345678, 20403.591928161353, 20409.285675001305, 21090.78909210919, 1041.317936751429, 1044.3159730376615, 1052.5000624703205, 1060.16247164739, 1073.1951036722458, 11255.943720281346, 11500.94249528747, 11555.480003399867, 11629.651110466699, 11694.590689325832, 440036.0, 458558.0, 460638.0, 463305.0, 464336.0, 116369.0, 118184.0, 119838.0, 119881.40059299648, 120071.0, 1258.6916205529521, 1274.2354587247762, 1304.1914013311618, 1304.6868751499571, 1311.6589686681723, 21599.46001349979, 21660.0, 21744.456388590414, 21798.564028719655, 22452.32643020712, 57295.42704572901, 58582.0, 58689.70655146697, 58755.706221468616, 59740.402595973486, 75470.0, 75540.0, 76218.23781762333, 76415.707528772, 77043.0, 12356.25862448256, 13826.65433364174, 14443.277836108362, 15009.024413413093, 15151.242437877841, 23588.52822943497, 23900.641490378006, 23921.16275930334, 23995.760042399354, 24135.396615084763, 18824.623507529497, 19186.808131918504, 19203.711944321127, 19288.22847086101, 19313.4205973821, 16964.83035169682, 17533.123343833013, 17685.292588296325, 17807.821921780618, 17836.46490605284, 19190.8080919189, 19706.21175152978, 19799.901000494905, 19800.20799168075, 19858.90070549638, 14963.850361496681, 14985.325660345528, 14989.40042398292, 14998.925005374904, 15012.099274043592, 18547.81452185461, 18611.534711632317, 18742.344017959305, 18794.436166915013, 18803.623927521647], "value": 13108.758829769145, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.0, 1408.5563047639992, 1418.5744276716985, 1421.587739555529, 1423.9145651260926, 14078.859211407882, 14626.634334141652, 14831.555053348404, 14838.851611483882, 14852.108873467572, 14757.18835464049, 14884.330205140768, 14907.776383354258, 15010.849891501082, 15025.173615451173, 2676.491466621341, 2730.5358089124898, 2734.0840818325883, 2734.3164208947765, 2734.8359098454157, 2577.4845030993783, 2668.5063263296256, 2699.5140874642557, 2707.1337172104936, 2708.255229811798, 2573.6396904433395, 2663.1211700139006, 2677.6385187999663, 2706.0, 2712.755851973322, 2622.3968487247944, 2628.4480259145603, 2642.8546429946346, 2649.7615214630778, 2661.441097369545, 2616.5682662360687, 2628.7239839816925, 2633.697124830631, 2644.286042768461, 2645.2196602002455, 14221.502247421395, 14469.855301446956, 14473.855261447461, 14515.491957781427, 14523.346449409803, 7759.7672069838, 8029.718959836436, 8051.718189863385, 8053.0, 8058.476199047043, 5084.822031228926, 5141.228815677641, 5240.240165176028, 5298.284731561228, 5330.413654498002, 1862.962740745191, 1908.1127275816812, 1925.2202857842597, 1934.642091213116, 1957.119296316649, 21730.13079476819, 21780.89109554458, 22551.774482255296, 23450.765492345028, 24374.26877193687, 6394.680265986682, 6561.442277406474, 6608.339166083353, 6748.966255168791, 6806.965965170241, 16518.6696266074, 16724.49826505207, 16740.16299185036, 16745.83254167467, 16759.2458339375, 7658.885116723253, 7916.406269529808, 7925.762227133196, 7928.643211055516, 7930.0880398753725, 7118.857622847618, 7135.429165666734, 7303.6348182590655, 7342.192358840523, 7349.154847192642, 5015.4733752956145, 5254.264402983586, 5271.894562108736, 5281.894362112813, 5308.734563271821, 1530.6402995296096, 1534.8465153484785, 1539.1765405508, 1551.2166355990153, 1587.6904003719164, 869.4305230074311, 888.7467071884482, 901.4366021236727, 903.1826197291462, 903.1961554216621, 8361.916380836114, 8434.493930364199, 8445.408821382443, 8457.323414126855, 8466.576671166416, 968.3270127261486, 980.0, 982.1111893736038, 986.329296078659, 1002.6691191906654, 4300.376445415397, 5608.551315894719, 5614.578906581941, 5755.366909639936, 5885.882282354329, 19784.90107549453, 20028.69956950647, 20827.687584686242, 20876.791232087788, 20880.06039728216, 20188.192472301238, 20351.389458316273, 20376.59246815085, 20405.48986275355, 20556.691649625267, 10141.340812847142, 10939.398333091598, 10945.288556243819, 10948.781024379468, 11017.394043327533, 8247.340212783083, 8312.21034001769, 8484.0, 8580.742577722678, 8725.869111963199, 17431.30274789045, 17501.912490437466, 17647.117644118, 17794.199261033027, 18030.90984545069, 17796.199171037595, 18059.54851128732, 18108.637827243645, 18236.36172733948, 18365.3572124975, 11447.370394628375, 11811.763764724828, 11813.881861181279, 11815.645530634094, 11817.350045747566, 12860.292683902475, 12886.677833053873, 13009.0, 13096.214227146402, 13100.737985240052, 10716.142708583451, 10783.784324313312, 10804.783904322027, 10987.285826421257, 11087.556497740323, 10125.746856328356, 10148.746281343025, 10161.339512931636, 10170.237232207466, 10309.0, 9486.051394860458, 9688.757781055248, 9692.369995950241, 9698.175655069399, 9701.07839755222, 6939.757108501179, 6949.861002780017, 6998.790036298919, 7071.0, 7085.6457177141965, 7289.817754556178, 7295.635218238961, 7310.0, 7345.816354590964, 7356.742514012198], "value": 6540.499021487245, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.94109529480727, 494.1179993711225, 508.5092885365626, 515.8426679862642, 531.7075608415372, 6177.598456100351, 6305.864944310022, 6333.0, 6334.651594162319, 6349.682515874199, 6121.357257487955, 6156.507479401648, 6170.8148755537295, 6174.289956654975, 6200.844978875531, 4997.675151115166, 5003.39959204896, 5017.397912250517, 5029.0, 5051.242313652963, 4886.560209581137, 4989.950100498985, 4997.0, 5002.799888004493, 5019.949800501985, 4954.876128096808, 4961.355023846912, 4961.70229786214, 4972.378452693413, 4973.278874563186, 4948.7278199699, 4958.776855041532, 4979.925301120468, 4992.750362481897, 5016.849494515171, 4492.16894874446, 4501.392312037866, 4506.053728716974, 4517.344984977192, 4518.3222516622445, 6098.14625952367, 6109.297430795426, 6122.357152499013, 6131.63210207389, 6150.261968563801, 5701.429857014306, 5703.77184912603, 5717.228174196472, 5731.475142787156, 5758.942410575883, 6591.802245932629, 6599.8020059398295, 6603.669816509156, 6612.93387066128, 6619.867602647968, 4881.975590122027, 4926.285688575173, 4932.80268789248, 4940.925886111711, 4946.431160416562, 6949.305069493061, 6990.231074581792, 6995.615241161734, 7030.437564994788, 7034.2965703429245, 4978.90042199154, 4993.300937868701, 4997.475265097112, 4998.6750861193905, 5000.099982003201, 5064.366954130734, 5079.187330027252, 5089.720065396365, 5114.181730923109, 5135.717535535581, 5683.204351390808, 5690.630109042899, 5726.627769194989, 5735.913961290584, 5750.281214848144, 6354.093771868421, 6621.668916554153, 6631.867362652816, 6661.2006559213205, 6662.101301129155, 1644.983550164507, 1683.6127690631224, 1695.1439523040785, 1748.4492384898717, 1758.1824451630052, 1205.6925484001524, 1212.3392750950752, 1229.6864299603544, 1243.6890777305673, 1247.7442124364484, 5692.0, 5792.247007888947, 5795.333536643256, 5797.652140871477, 5852.356240813507, 6655.367740064686, 6711.362420570038, 6793.354631310018, 6894.414284714544, 6904.896426553606, 5844.912326315109, 5867.882642347215, 5935.258092738408, 5943.0, 5948.464638182584, 3582.7492075554983, 3625.9093522662142, 3629.709623230188, 3647.835847386874, 3653.178034942117, 6591.340865913467, 6592.868142637216, 6642.3430627749285, 6646.468282537386, 6661.867482527982, 6954.3045695430055, 6992.440604751608, 7050.5769653820935, 7071.681774320168, 7092.893606595905, 6390.520710946605, 6525.641089740015, 6542.54202205841, 6612.371824676648, 6645.371883888478, 6753.527253092237, 6757.22291936414, 6798.912174052128, 6804.4896632753735, 6836.38472537474, 6737.157855268091, 6775.254721980677, 6787.083743694736, 6822.965885170543, 6823.66938446998, 6552.4616706977695, 6596.208454985433, 6608.50436217276, 6649.135612370555, 6698.39714425704, 4966.925496117633, 4979.278004689228, 4984.900301994012, 5019.824306149268, 5083.949160508348, 6506.934930650822, 6705.664716764045, 6809.0, 6882.380585747307, 6905.93094069073, 6202.131701561695, 6426.0, 6428.935710642833, 6546.378094081055, 6622.271550129578, 6441.1626488556185, 6453.290138084901, 6518.0, 6548.148740663683, 6563.113979612882, 6352.523560732871, 6359.268684101387, 6372.36276372359, 6385.13800636908, 6529.314421985623, 6517.600619581669, 6522.0, 6534.497065674826, 6623.735050598115, 6646.83382915431, 6301.527385446201, 6366.745330186741, 6423.678816059085, 6441.194850643669, 6456.289808121197], "value": 5083.066502639726, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [920.7974245665953, 925.6436272035264, 935.1069728409369, 938.1416004356015, 952.8761261036062, 18465.63068738626, 19384.22463101476, 19468.610627787435, 19476.90261548694, 22345.217917372895, 21624.8918755406, 22016.559668806614, 22304.330870073925, 22357.888210558925, 22415.0, 1031.1750599520371, 1055.3298655353829, 1059.062729484408, 1059.6609085092773, 1061.4374381577777, 1014.3508154780947, 1031.072035168347, 1055.5566662001938, 1058.0107599394553, 1059.4226146750002, 1102.6747109602647, 1107.0811226681874, 1111.2832223216062, 1111.644273832374, 1113.1373185781044, 1084.902358787705, 1093.20742461715, 1094.6934858239706, 1097.2593499387922, 1100.6367898593444, 806.1173015548025, 809.2191035650567, 809.6275713171948, 809.817790997021, 811.4319976016753, 19417.22331106754, 19730.30943916956, 19768.60462790736, 19888.403347899588, 20638.690419643717, 21783.891080544498, 22021.00905459258, 22279.108835646715, 22302.442438938993, 22445.102195912306, 16761.245743941552, 16828.411005614867, 17320.39378621742, 17324.39364622245, 17619.735703964452, 3749.15643980105, 3752.212035472554, 3754.3242216401036, 3762.8711386583914, 3762.887113386603, 122810.0, 123810.38094809468, 124856.0, 127643.0, 128653.0, 16121.0, 16600.252988615543, 16860.156992150343, 16863.325466981183, 16986.405475808533, 30734.846325768227, 31256.843715781277, 31264.531032034538, 31391.0, 32141.678583214336, 7682.846343073107, 8090.1909809018625, 8397.412181147383, 9106.225970792424, 9300.302477314093, 4293.098449325614, 4411.404460397869, 4447.444069491314, 4450.1767173073085, 4453.3320001999955, 5246.895062098737, 5339.439358867341, 5403.0544654686055, 5403.108487099585, 5415.268938693304, 1030.8247597908373, 1051.8527406163143, 1057.8466122412208, 1068.4123731947398, 1072.2708558180357, 665.1917919727457, 727.5198369076384, 729.5549714674045, 731.378328420838, 731.8463122744176, 11701.414929253504, 12248.0, 12661.873381266254, 12907.612771616867, 13095.410706518229, 711.5232794028013, 716.3517017099533, 720.4488566246825, 722.6350692900052, 728.035353157069, 5829.650220986754, 5919.319278283053, 5942.6731529766275, 6002.54980876436, 6089.086637004485, 115428.0, 115847.0, 116415.0, 116622.0, 118032.0, 95894.0, 98721.50639246902, 98788.0, 99680.50159749154, 101792.0, 83204.58397707973, 85180.0, 86077.13922860817, 86228.13771862327, 87199.0, 10673.306235094695, 10701.732456688334, 10954.397508137128, 11122.944385278022, 11272.830907536558, 40582.0, 41019.0, 41775.37336940009, 42315.788421057696, 43010.784946076325, 51602.22596660978, 53654.92690146253, 53954.0, 54221.18668220059, 54638.45361546334, 15720.449784257497, 16250.756238656193, 19683.21267149298, 20351.491212719207, 20478.488037799176, 19826.206951722346, 20130.29543965954, 20158.596828063062, 20465.38603841887, 20488.975551222677, 18716.344927927457, 18765.812341876408, 18831.24675013039, 19245.711314330576, 19643.31248406299, 20177.192912283343, 20278.695819562425, 20362.694559581916, 20375.184992600723, 20391.59216815685, 19556.413307600797, 19677.409677709693, 19749.30877419341, 19890.70163947513, 20484.590308194052, 14570.5628831131, 14609.853901461274, 14672.926635366755, 14766.187859667392, 15382.923085384502, 14883.181425021294, 15094.24528773535, 15133.470328538448, 15173.393064277305, 15307.923460382626], "value": 9396.007469766206, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 100.0, 109.0, 116.0, 114.0, 109.0, 109.0, 110.0, 112.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 122.0, 142.0, 171.0, 126.0, 148.0, 141.0, 117.0, 172.0, 125.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 162.0, 164.0, 169.0, 165.0, 168.0, 162.0, 165.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 165.0, 79.0, 78.0, 74.0, 92.0, 99.0, 74.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 134.0, 79.0, 80.0, 78.0, 140.0, 80.0, 79.0, 138.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 114.0, 116.0, 113.0, 115.0, 118.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 157.0, 152.0, 154.0, 151.0, 150.0, 150.0, 149.0, 154.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 103.0, 99.0, 106.0, 98.0, 99.0, 94.0, 94.0, 94.0, 94.0], "value": 97.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 55.0, 53.0, 53.0, 54.0, 54.0, 58.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 59.0, 61.0, 59.0, 60.0, 56.0, 55.0, 54.0, 55.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 80.0, 78.0, 78.0, 92.0, 88.0, 78.0, 82.0, 77.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 121.0, 131.0, 142.0, 128.0, 123.0, 122.0, 126.0, 163.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 177.0, 175.0, 173.0, 173.0, 181.0, 187.0, 173.0, 177.0, 172.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 68.0, 67.0, 66.0, 67.0, 65.0, 65.0, 70.0], "value": 67.7, "unit": "score"}]}]} 04:17:58 INFO - Return code: 0 04:17:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:17:58 INFO - # TBPL SUCCESS # 04:17:58 INFO - Running post-action listener: _package_coverage_data 04:17:58 INFO - Running post-action listener: _resource_record_post_action 04:17:58 INFO - [mozharness: 2017-08-11 11:17:58.975866Z] Finished run-tests step (success) 04:17:58 INFO - Running post-run listener: _resource_record_post_run 04:17:59 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 445059072; Read time: 216; Write time: 461996 04:17:59 INFO - TinderboxPrint: CPU usage
13.2% 04:17:59 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 216 04:17:59 INFO - TinderboxPrint: I/O write bytes / time
445,059,072 / 461,996 04:17:59 INFO - TinderboxPrint: CPU idle
8,257.2 (86.8%) 04:17:59 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 04:17:59 INFO - TinderboxPrint: Swap in / out
0 / 0 04:17:59 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 120942592; Read time: 0; Write time: 168816 04:17:59 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:17:59 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 324116480; Read time: 204; Write time: 293180 04:17:59 INFO - Running post-run listener: _upload_blobber_files 04:17:59 INFO - Blob upload gear active. 04:17:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:17:59 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 04:17:59 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'] 04:17:59 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 04:18:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:18:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:18:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:18:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:00 INFO - (blobuploader) - INFO - Done attempting. 04:18:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:18:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:18:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:01 INFO - (blobuploader) - INFO - Done attempting. 04:18:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:18:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:18:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:09 INFO - (blobuploader) - INFO - Done attempting. 04:18:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:18:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:18:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:09 INFO - (blobuploader) - INFO - Done attempting. 04:18:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:18:10 INFO - Return code: 0 04:18:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:18:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:18:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4083350feb68fd48379dc66dd52508aafd0ffb39ada2a42252cbde9cdfc86775975c12e2beba06a08f01a808435a741fbdd851093e63abf7199ebf5400ecb416", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2d8608b50149d467097a1fc3c279d1c1371473cb0e4c8e73cb3e0b986be226b92345757c896558952c85095499688737ac82ea1345df9755d4f9b54d5500533", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3879c7c68d6b8e9571a7b44fc60cf7289c9bc56279b167cb976fcb32b603941f8816183afb95f961f549016cdd8a183ec0c1bfd743cc6a8ad3d0957e2bd3b8a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8faa57446ffd18677b21c1eaefe279232e41fa67bf36cef4fd7d297aaff74e292ea10a15baa17c0d327831b38010a8e2dc842b59b957c8a13df4cf0fd7748925"} 04:18:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:18:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:18:10 INFO - Contents: 04:18:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4083350feb68fd48379dc66dd52508aafd0ffb39ada2a42252cbde9cdfc86775975c12e2beba06a08f01a808435a741fbdd851093e63abf7199ebf5400ecb416", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2d8608b50149d467097a1fc3c279d1c1371473cb0e4c8e73cb3e0b986be226b92345757c896558952c85095499688737ac82ea1345df9755d4f9b54d5500533", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3879c7c68d6b8e9571a7b44fc60cf7289c9bc56279b167cb976fcb32b603941f8816183afb95f961f549016cdd8a183ec0c1bfd743cc6a8ad3d0957e2bd3b8a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8faa57446ffd18677b21c1eaefe279232e41fa67bf36cef4fd7d297aaff74e292ea10a15baa17c0d327831b38010a8e2dc842b59b957c8a13df4cf0fd7748925"} 04:18:10 INFO - Running post-run listener: copy_logs_to_upload_dir 04:18:10 INFO - Copying logs to upload dir... 04:18:10 INFO - mkdir: /builds/slave/test/build/upload/logs 04:18:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.719225 ========= master_lag: -0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-11 04:18:09.754187) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 04:18:09.762554) ========= 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=62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4083350feb68fd48379dc66dd52508aafd0ffb39ada2a42252cbde9cdfc86775975c12e2beba06a08f01a808435a741fbdd851093e63abf7199ebf5400ecb416", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2d8608b50149d467097a1fc3c279d1c1371473cb0e4c8e73cb3e0b986be226b92345757c896558952c85095499688737ac82ea1345df9755d4f9b54d5500533", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3879c7c68d6b8e9571a7b44fc60cf7289c9bc56279b167cb976fcb32b603941f8816183afb95f961f549016cdd8a183ec0c1bfd743cc6a8ad3d0957e2bd3b8a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8faa57446ffd18677b21c1eaefe279232e41fa67bf36cef4fd7d297aaff74e292ea10a15baa17c0d327831b38010a8e2dc842b59b957c8a13df4cf0fd7748925"} build_url:https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4083350feb68fd48379dc66dd52508aafd0ffb39ada2a42252cbde9cdfc86775975c12e2beba06a08f01a808435a741fbdd851093e63abf7199ebf5400ecb416", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2d8608b50149d467097a1fc3c279d1c1371473cb0e4c8e73cb3e0b986be226b92345757c896558952c85095499688737ac82ea1345df9755d4f9b54d5500533", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3879c7c68d6b8e9571a7b44fc60cf7289c9bc56279b167cb976fcb32b603941f8816183afb95f961f549016cdd8a183ec0c1bfd743cc6a8ad3d0957e2bd3b8a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8faa57446ffd18677b21c1eaefe279232e41fa67bf36cef4fd7d297aaff74e292ea10a15baa17c0d327831b38010a8e2dc842b59b957c8a13df4cf0fd7748925"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 04:18:09.789955) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:18:09.790264) ========= 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=62c568580acbfdaac3eec7be000001dc-1502449032.562581-1255168927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:18:09.871031) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 04:18:09.874345) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 04:18:09.874646) ========= ========= Total master_lag: -0.07 =========